-- Logs begin at Thu 2019-02-14 12:12:03 EET, end at Fri 2025-07-11 15:54:45 EEST. -- Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:09 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:09 volumio volumio[1088]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://motherearth.streamserver24.com/api/station/motherearth_instrumental/art/48755b9a097f65b7383a685c-1683740811.jpg","uri":"https://motherearth.streamserver24.com/listen/motherearth_instrumental/motherearth.instrumental","name":"Secret Garden - Song From A Secret Garden","title":"Song From A Secret Garden","artist":"Secret Garden","album":"Songs from A Secret Garden","streaming":true,"disableUiControls":true,"duration":213,"seek":0,"bitdepth":"24 bit","channels":2} Jul 11 15:54:09 volumio volumio[1088]: verbose: CURRENT POSITION 0 Jul 11 15:54:09 volumio volumio[1088]: info: CoreStateMachine::syncState stateService play Jul 11 15:54:09 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus play Jul 11 15:54:09 volumio volumio[1088]: info: Received an update from plugin. extracting info from payload Jul 11 15:54:09 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:09 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 15:54:09 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:09 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:09 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:09 volumio volumio[1088]: info: [1752238449297] [MotherEarth] setting new timer with duration of 213000 seconds. Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:09 volumio volumio[1088]: info: CorePlayQueue::getTrack 1 Jul 11 15:54:24 volumio volumio[1088]: info: Preload queue cleared Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::ClearQueue Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::stop Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::stPlaybackTimer Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::updateTrackBlock Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrackBlock Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::serviceStop Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::serviceStop Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::stop Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::clearPlayQueue Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::saveQueue Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushQueue Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::addQueueItems Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::addQueueItems Jul 11 15:54:24 volumio volumio[1088]: info: Preload queue cleared Jul 11 15:54:24 volumio volumio[1088]: info: Adding Item to queue: webmer/3 Jul 11 15:54:24 volumio volumio[1088]: info: Using cached record of: webmer/3 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushQueue Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::saveQueue Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::updateTrackBlock Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrackBlock Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPlay Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::play index 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::stop Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::play index undefined Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::startPlaybackTimer Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand stop Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand stop took 105 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand stop took 20 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://motherearth.streamserver24.com/api/station/motherearth_instrumental/art/48755b9a097f65b7383a685c-1683740811.jpg","uri":"https://motherearth.streamserver24.com/listen/motherearth_instrumental/motherearth.instrumental","name":"Secret Garden - Song From A Secret Garden","title":"Song From A Secret Garden","artist":"Secret Garden","album":"Songs from A Secret Garden","streaming":true,"disableUiControls":true,"duration":213,"seek":0,"bitdepth":"24 bit","channels":2} Jul 11 15:54:24 volumio volumio[1088]: verbose: CURRENT POSITION 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::syncState stateService stop Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: info: No code Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand clear Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand status took 144 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand clear took 90 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand status took 29 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand status took 25 milliseconds Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:24 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:24 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:24 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 105ms Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 102ms Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: error: updateQueue error: null Jul 11 15:54:24 volumio volumio[1088]: error: updateQueue error: null Jul 11 15:54:24 volumio volumio[1088]: error: updateQueue error: null Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 127ms Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 120 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand consume 1 took 120 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 37ms Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 34ms Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:24 volumio volumio[1088]: info: [1752238464667] [MotherEarth] set to consume mode, adding url: https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz" Jul 11 15:54:24 volumio volumio[1088]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 283ms Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz" took 26 milliseconds Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand play Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:24 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 55ms Jul 11 15:54:24 volumio volumio[1088]: info: sendMpdCommand play took 31 milliseconds Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 20ms Jul 11 15:54:24 volumio volumio[1088]: info: ------------------------------ 17ms Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:24 volumio volumio[1088]: info: Jul 11 15:54:24 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:24 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:24 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 244 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 243 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 239 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 23 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 13 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 10 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 308ms Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 301ms Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 297ms Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 21 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 93ms Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 75ms Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 72ms Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://motherearth.streamserver24.com/api/station/motherearth_jazz/art/1b81f1721cb3688d632244da-1683740813.jpg","uri":"https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz","name":"Santana - Evil Ways","title":"Evil Ways","artist":"Santana","album":"Santana","streaming":true,"disableUiControls":true,"duration":16,"seek":0,"bitdepth":"24 bit","channels":2} Jul 11 15:54:25 volumio volumio[1088]: verbose: CURRENT POSITION 0 Jul 11 15:54:25 volumio volumio[1088]: info: CoreStateMachine::syncState stateService play Jul 11 15:54:25 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus stop Jul 11 15:54:25 volumio volumio[1088]: info: [1752238465492] [MotherEarth] setting new timer with duration of 16000 seconds. Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:25 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:25 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 27ms Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 14 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 12ms Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 8 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces system playlist update Jul 11 15:54:25 volumio volumio[1088]: info: Ignoring MPD Status Update Jul 11 15:54:25 volumio volumio[1088]: info: Jul 11 15:54:25 volumio volumio[1088]: ---------------------------- MPD announces state update: player Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::getState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand status Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 15ms Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand status took 12 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseState Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 60ms Jul 11 15:54:25 volumio volumio[1088]: info: ------------------------------ 49ms Jul 11 15:54:25 volumio volumio[1088]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 11 15:54:25 volumio volumio[1088]: verbose: ControllerMpd::parseTrackInfo Jul 11 15:54:25 volumio volumio[1088]: info: ControllerMpd::pushState Jul 11 15:54:25 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:25 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:25 volumio volumio[1088]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd Jul 11 15:54:26 volumio volumio[1088]: info: ------------------------------ 36ms Jul 11 15:54:29 volumio volumio[1088]: info: CoreCommandRouter::volumioGetState Jul 11 15:54:29 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:42 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:42 volumio volumio[1088]: info: CoreCommandRouter::servicePushState Jul 11 15:54:42 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:42 volumio volumio[1088]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://motherearth.streamserver24.com/api/station/motherearth_jazz/art/029af14307d53ab38f410b6b-1732317688.jpg","uri":"https://motherearth.streamserver24.com/listen/motherearth_jazz/motherearth.jazz","name":"Søren Bebe Trio - On And On","title":"On And On","artist":"Søren Bebe Trio","album":"Here Now","streaming":true,"disableUiControls":true,"duration":227,"seek":0,"bitdepth":"24 bit","channels":2} Jul 11 15:54:42 volumio volumio[1088]: verbose: CURRENT POSITION 0 Jul 11 15:54:42 volumio volumio[1088]: info: CoreStateMachine::syncState stateService play Jul 11 15:54:42 volumio volumio[1088]: info: CoreStateMachine::syncState currentStatus play Jul 11 15:54:42 volumio volumio[1088]: info: Received an update from plugin. extracting info from payload Jul 11 15:54:42 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:42 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:42 volumio volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 15:54:42 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:42 volumio volumio[1088]: info: CoreStateMachine::pushState Jul 11 15:54:42 volumio volumio[1088]: info: CorePlayQueue::getTrack 0 Jul 11 15:54:42 volumio volumio[1088]: info: CoreCommandRouter::volumioPushState Jul 11 15:54:42 volumio volumio[1088]: info: [1752238482262] [MotherEarth] setting new timer with duration of 227000 seconds. Jul 11 15:54:42 volumio volumio[1088]: info: [1752238482274] [MotherEarth] Error: read ECONNRESET Jul 11 15:54:42 volumio volumio[1088]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 15:54:42 volumio volumio[1088]: Error: Unable to resolve or reject the same promise twice Jul 11 15:54:42 volumio volumio[1088]: at Promise.resolve (/data/plugins/music_service/motherearthradio/node_modules/kew/kew.js:140:43) Jul 11 15:54:42 volumio volumio[1088]: at ClientRequest. (/data/plugins/music_service/motherearthradio/index.js:394:17) Jul 11 15:54:42 volumio volumio[1088]: at ClientRequest.emit (events.js:400:28) Jul 11 15:54:42 volumio volumio[1088]: at TLSSocket.socketErrorListener (_http_client.js:475:9) Jul 11 15:54:42 volumio volumio[1088]: at TLSSocket.emit (events.js:400:28) Jul 11 15:54:42 volumio volumio[1088]: at emitErrorNT (internal/streams/destroy.js:106:8) Jul 11 15:54:42 volumio volumio[1088]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Jul 11 15:54:42 volumio volumio[1088]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 11 15:54:42 volumio volumio[1088]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 15:54:45 volumio sudo[14051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-11 15:53 Jul 11 15:54:45 volumio sudo[14051]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Sep 2024 10:15:17 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="49ee0b71bdee95489f79b31a5db4cbdb"