Mar 25 18:16:14 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: calmradio , handleBrowseUri
Mar 25 18:16:14 volumio volumio[1263]: error: Failed to execute browseSource, failure: TypeError: Cannot read properties of undefined (reading 'then')
Mar 25 18:16:29 volumio volumio[1263]: info: [MER] 🎵 Adam Laloum - Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: info: [MER] 📤 Adam Laloum - Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto
Mar 25 18:16:29 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://stream.motherearthradio.de/api/station/motherearth_klassik/art/53e04724ce5a1724b24cc5c1-1772207763.jpg","uri":"motherearthradio/klassik/flac96","name":"Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto","title":"Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto","artist":"Adam Laloum","album":"Brahms - Pièces pour piano","streaming":true,"disableUiControls":true,"duration":205,"seek":0,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2}
Mar 25 18:16:29 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:16:29 volumio volumio[1263]: info: CoreStateMachine::syncState stateService play
Mar 25 18:16:29 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus play
Mar 25 18:16:29 volumio volumio[1263]: info: Received an update from plugin. extracting info from payload
Mar 25 18:16:29 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 25 18:16:29 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:16:29 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:16:29 volumio volumio5-onboarding[2139]: time=2026-03-25T18:16:29.684-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_PLAYING positionMs=0 volume=100
Mar 25 18:16:29 volumio volumio5-onboarding[2139]: time=2026-03-25T18:16:29.685-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:16:29 volumio volumio5-onboarding[2139]: time=2026-03-25T18:16:29.685-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_PLAYING positionMs=0 volume=100
Mar 25 18:16:29 volumio volumio5-onboarding[2139]: time=2026-03-25T18:16:29.685-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:16:29 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status play
Mar 25 18:16:29 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status play
Mar 25 18:16:29 volumio sudo[12211]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Mar 25 18:16:29 volumio sudo[12211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:16:29 volumio sudo[12213]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Mar 25 18:16:29 volumio sudo[12213]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:16:29 volumio sudo[12211]: pam_unix(sudo:session): session closed for user root
Mar 25 18:16:29 volumio sudo[12213]: pam_unix(sudo:session): session closed for user root
Mar 25 18:16:29 volumio volumio[1263]: info: peppymeterbasic Daemon Started
Mar 25 18:16:29 volumio volumio[1263]: info: peppymeterbasic Daemon Started
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:16:29 volumio volumio[1263]: info: Prefetching next song
Mar 25 18:16:38 volumio volumio[1263]: Searching plugin music_service/calmradio
Mar 25 18:16:38 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: calmradio , search
Mar 25 18:16:38 volumio volumio[1263]: info: All search sources collected, pushing search results
Mar 25 18:16:39 volumio volumio[1263]: Searching plugin music_service/calmradio
Mar 25 18:16:39 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: calmradio , search
Mar 25 18:16:39 volumio volumio[1263]: info: All search sources collected, pushing search results
Mar 25 18:16:49 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , handleBrowseUri
Mar 25 18:16:49 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:06 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::ClearQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::stPlaybackTimer
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::serviceStop
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::serviceStop
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Mar 25 18:17:06 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::syncState stateService stop
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus stop
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:06 volumio volumio[1263]: info: No code
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:06 volumio volumio[1263]: info: ControllerMpd::stop
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::clearPlayQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::addQueueItems
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::addQueueItems
Mar 25 18:17:06 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:06 volumio volumio[1263]: info: Adding Item to queue: motherearthradio/jazz/flac192
Mar 25 18:17:06 volumio volumio[1263]: info: Exploding uri motherearthradio/jazz/flac192 in service motherearthradio
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.274-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.275-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.275-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.275-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.277-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.277-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.278-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:17:06 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:06.278-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/klassik/flac96 title="Capriccio en Ut Dièse Mineur - Agitato, ma non troppo presto"
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::volumioPlay
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::play index 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::play index undefined
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::startPlaybackTimer
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: info: [MER] ▶️ Playing: https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz
Mar 25 18:17:06 volumio volumio[1263]: info: [MER] 🔌 Starting SSE for Jazz
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:06 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:06 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:06 volumio sudo[12270]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:06 volumio sudo[12270]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:06 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:06 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:06 volumio sudo[12274]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:06 volumio sudo[12274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:06 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon...
Mar 25 18:17:06 volumio sudo[12275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:06 volumio sudo[12275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:06 volumio volumio[1263]: info:
Mar 25 18:17:06 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand stop took 196 milliseconds
Mar 25 18:17:06 volumio sudo[12278]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:06 volumio sudo[12278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:06 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand stop took 169 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand clear
Mar 25 18:17:06 volumio volumio[1263]: info:
Mar 25 18:17:06 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:06 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand status took 6 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand clear took 5 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand add "https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz"
Mar 25 18:17:06 volumio volumio[1263]: error: updateQueue error: null
Mar 25 18:17:06 volumio volumio[1263]: info:
Mar 25 18:17:06 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:06 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:06 volumio volumio[1263]: info: ------------------------------ 37ms
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 17 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand add "https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz" took 21 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:06 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand play
Mar 25 18:17:06 volumio volumio[1263]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 25 18:17:06 volumio volumio[1263]: info: ------------------------------ 83ms
Mar 25 18:17:06 volumio volumio[1263]: info: ------------------------------ 36ms
Mar 25 18:17:06 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully.
Mar 25 18:17:06 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon.
Mar 25 18:17:06 volumio systemd[1]: peppymeterbasic.service: Consumed 4min 47.557s CPU time.
Mar 25 18:17:06 volumio volumio[1263]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 25 18:17:06 volumio volumio[1263]: info: sendMpdCommand play took 32 milliseconds
Mar 25 18:17:06 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:06 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:06 volumio volumio[1263]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Jazz · FLAC 192kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/jazz/flac192","streaming":true,"disableUiControls":true,"samplerate":"192 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Mar 25 18:17:06 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::syncState stateService play
Mar 25 18:17:06 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus stop
Mar 25 18:17:06 volumio sudo[12270]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:06 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:06 volumio sudo[12274]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:06 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:06 volumio sudo[12275]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:06 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:06 volumio sudo[12278]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:06 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:07 volumio volumio[1263]: info:
Mar 25 18:17:07 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:07 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:07 volumio volumio[1263]: info:
Mar 25 18:17:07 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:07 volumio volumio[1263]: info: sendMpdCommand status took 32 milliseconds
Mar 25 18:17:07 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:07 volumio volumio[1263]: info: sendMpdCommand status took 1 milliseconds
Mar 25 18:17:07 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:07 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:07 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:07 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:07 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:07 volumio volumio[1263]: info: ------------------------------ 36ms
Mar 25 18:17:07 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 25 18:17:07 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:07 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:07 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:07 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:07 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:07 volumio volumio[1263]: info: ------------------------------ 5ms
Mar 25 18:17:08 volumio volumio[1263]: info:
Mar 25 18:17:08 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:08 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:08 volumio volumio[1263]: info:
Mar 25 18:17:08 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:08 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:08 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:08 volumio volumio[1263]: info: ------------------------------ 2ms
Mar 25 18:17:08 volumio volumio[1263]: info: sendMpdCommand status took 2 milliseconds
Mar 25 18:17:08 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:08 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:08 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 25 18:17:08 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:08 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:08 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:08 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:08 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:08 volumio volumio[1263]: info: ------------------------------ 11ms
Mar 25 18:17:12 volumio volumio[1263]: info: [MER] ✅ SSE connected
Mar 25 18:17:14 volumio volumio[1263]: info: [MER] 🎵 Tobias Hoffmann Trio - Baby, Please Don't Go
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: info: [MER] 📤 Tobias Hoffmann Trio - Baby, Please Don't Go
Mar 25 18:17:14 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","albumart":"https://stream.motherearthradio.de/api/station/motherearth_jazz/art/45ab965ced1d4c722af08e57-1772207941.jpg","uri":"motherearthradio/jazz/flac192","name":"Baby, Please Don't Go","title":"Baby, Please Don't Go","artist":"Tobias Hoffmann Trio","album":"Slow Dance","streaming":true,"disableUiControls":true,"duration":328,"seek":0,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2}
Mar 25 18:17:14 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:14 volumio volumio[1263]: info: CoreStateMachine::syncState stateService play
Mar 25 18:17:14 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus play
Mar 25 18:17:14 volumio volumio[1263]: info: Received an update from plugin. extracting info from payload
Mar 25 18:17:14 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 25 18:17:14 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:14 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:14 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:14.794-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_PLAYING positionMs=0 volume=100
Mar 25 18:17:14 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:14.794-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:14 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:14.796-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_PLAYING positionMs=0 volume=100
Mar 25 18:17:14 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:14.797-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:14 volumio volumio[1263]: info: Prefetching next song
Mar 25 18:17:14 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status play
Mar 25 18:17:14 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status play
Mar 25 18:17:14 volumio sudo[12302]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Mar 25 18:17:14 volumio sudo[12304]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Mar 25 18:17:14 volumio sudo[12302]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:14 volumio sudo[12304]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:14 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon.
Mar 25 18:17:14 volumio sudo[12302]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:14 volumio sudo[12304]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:14 volumio volumio[1263]: info: peppymeterbasic Daemon Started
Mar 25 18:17:14 volumio volumio[1263]: info: peppymeterbasic Daemon Started
Mar 25 18:17:21 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::ClearQueue
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::stPlaybackTimer
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::serviceStop
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::serviceStop
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Mar 25 18:17:21 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::syncState stateService stop
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus stop
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:21 volumio volumio[1263]: info: No code
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:21 volumio volumio[1263]: info: ControllerMpd::stop
Mar 25 18:17:21 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::clearPlayQueue
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:21 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:21 volumio volumio[1263]: info: CoreStateMachine::addQueueItems
Mar 25 18:17:21 volumio volumio[1263]: info: CorePlayQueue::addQueueItems
Mar 25 18:17:21 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:21 volumio volumio[1263]: info: Adding Item to queue: motherearthradio/jazz/flac96
Mar 25 18:17:21 volumio volumio[1263]: info: Exploding uri motherearthradio/jazz/flac96 in service motherearthradio
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.004-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.005-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.006-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.006-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.006-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.007-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.007-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:22 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:22.008-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac192 title="Baby, Please Don't Go"
Mar 25 18:17:22 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:22 volumio volumio[1263]: info: CoreCommandRouter::volumioPlay
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::play index 0
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::play index undefined
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::startPlaybackTimer
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:22 volumio volumio[1263]: info: [MER] ▶️ Playing: https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz.flac-lo
Mar 25 18:17:22 volumio volumio[1263]: info: [MER] 🔌 Starting SSE for Jazz
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:22 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:22 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:22 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:22 volumio volumio[1263]: info: PeppyMeterBasic ---peppymeterbasic status stop
Mar 25 18:17:22 volumio sudo[12332]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:22 volumio sudo[12332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:22 volumio sudo[12339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:22 volumio sudo[12339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:22 volumio sudo[12335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:22 volumio sudo[12338]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service
Mar 25 18:17:22 volumio sudo[12338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:22 volumio volumio[1263]: info:
Mar 25 18:17:22 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand stop took 186 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:22 volumio sudo[12335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand stop took 129 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand clear
Mar 25 18:17:22 volumio volumio[1263]: info:
Mar 25 18:17:22 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:22 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand status took 47 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand clear took 35 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand add "https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz.flac-lo"
Mar 25 18:17:22 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon...
Mar 25 18:17:22 volumio volumio[1263]: error: updateQueue error: null
Mar 25 18:17:22 volumio volumio[1263]: info:
Mar 25 18:17:22 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:22 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:22 volumio volumio[1263]: info: ------------------------------ 43ms
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 17 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand add "https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz.flac-lo" took 17 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand play
Mar 25 18:17:22 volumio volumio[1263]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Mar 25 18:17:22 volumio volumio[1263]: info: ------------------------------ 96ms
Mar 25 18:17:22 volumio volumio[1263]: info: touch_display: Setting screensaver timeout to 0 seconds.
Mar 25 18:17:22 volumio volumio[1263]: info: ------------------------------ 11ms
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand play took 8 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:22 volumio volumio[1263]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Jazz · FLAC 96kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/jazz/flac96","streaming":true,"disableUiControls":true,"samplerate":"96 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Mar 25 18:17:22 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::syncState stateService play
Mar 25 18:17:22 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus stop
Mar 25 18:17:22 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully.
Mar 25 18:17:22 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon.
Mar 25 18:17:22 volumio systemd[1]: peppymeterbasic.service: Consumed 3.118s CPU time.
Mar 25 18:17:22 volumio sudo[12338]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:22 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:22 volumio sudo[12332]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:22 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:22 volumio sudo[12339]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:22 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:22 volumio sudo[12335]: pam_unix(sudo:session): session closed for user root
Mar 25 18:17:22 volumio volumio[1263]: info: peppymeterbasic Daemon Stop
Mar 25 18:17:22 volumio volumio[1263]: info:
Mar 25 18:17:22 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:22 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:22 volumio volumio[1263]: info:
Mar 25 18:17:22 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand status took 27 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand status took 1 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:22 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:22 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:22 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:22 volumio volumio[1263]: info: ------------------------------ 31ms
Mar 25 18:17:22 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 25 18:17:22 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:22 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:22 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:22 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:22 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:22 volumio volumio[1263]: info: ------------------------------ 5ms
Mar 25 18:17:23 volumio volumio[1263]: info:
Mar 25 18:17:23 volumio volumio[1263]: ---------------------------- MPD announces system playlist update
Mar 25 18:17:23 volumio volumio[1263]: info: Ignoring MPD Status Update
Mar 25 18:17:23 volumio volumio[1263]: info:
Mar 25 18:17:23 volumio volumio[1263]: ---------------------------- MPD announces state update: player
Mar 25 18:17:23 volumio volumio[1263]: info: ControllerMpd::getState
Mar 25 18:17:23 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand status
Mar 25 18:17:23 volumio volumio[1263]: info: ------------------------------ 24ms
Mar 25 18:17:23 volumio volumio[1263]: info: sendMpdCommand status took 1 milliseconds
Mar 25 18:17:23 volumio volumio[1263]: verbose: ControllerMpd::parseState
Mar 25 18:17:23 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 25 18:17:23 volumio volumio[1263]: info: sendMpdCommand playlistinfo took 0 milliseconds
Mar 25 18:17:23 volumio volumio[1263]: verbose: ControllerMpd::parseTrackInfo
Mar 25 18:17:23 volumio volumio[1263]: info: ControllerMpd::pushState
Mar 25 18:17:23 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:23 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:23 volumio volumio[1263]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Mar 25 18:17:23 volumio volumio[1263]: info: ------------------------------ 26ms
Mar 25 18:17:27 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::ClearQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::stPlaybackTimer
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::serviceStop
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::serviceStop
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::servicePushState
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Mar 25 18:17:27 volumio volumio[1263]: verbose: CURRENT POSITION 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::syncState stateService stop
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::syncState currentStatus stop
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:27 volumio volumio[1263]: info: No code
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::pushState
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushState
Mar 25 18:17:27 volumio volumio[1263]: info: ControllerMpd::stop
Mar 25 18:17:27 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::clearPlayQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::addQueueItems
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::addQueueItems
Mar 25 18:17:27 volumio volumio[1263]: info: Preload queue cleared
Mar 25 18:17:27 volumio volumio[1263]: info: Adding Item to queue: motherearthradio/jazz/mono192
Mar 25 18:17:27 volumio volumio[1263]: info: Exploding uri motherearthradio/jazz/mono192 in service motherearthradio
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.860-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.860-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac96 title=Jazz
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.861-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.861-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac96 title=Jazz
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.862-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.862-03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" state=STATUS_STOPPED positionMs=0 volume=100
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.863-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac96 title=Jazz
Mar 25 18:17:27 volumio volumio5-onboarding[2139]: time=2026-03-25T18:17:27.863-03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.83:50480 @ 0x250acc0" id=motherearthradio/jazz/flac96 title=Jazz
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPushQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::saveQueue
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::updateTrackBlock
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrackBlock
Mar 25 18:17:27 volumio volumio[1263]: info: CoreCommandRouter::volumioPlay
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::play index 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::stop
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::play index undefined
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: CoreStateMachine::startPlaybackTimer
Mar 25 18:17:27 volumio volumio[1263]: info: CorePlayQueue::getTrack 0
Mar 25 18:17:27 volumio volumio[1263]: info: [MER] ▶️ Playing: https://stream.motherearthradio.de/listen/motherearth_jazz/motherearth.jazz.mono
Mar 25 18:17:27 volumio volumio[1263]: info: [MER] 🔌 Starting SSE for Jazz
Mar 25 18:17:27 volumio volumio[1263]: verbose: ControllerMpd::sendMpdCommand stop
Mar 25 18:17:27 volumio volumio[1263]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 25 18:17:27 volumio volumio[1263]: Error: socket hang up
Mar 25 18:17:27 volumio volumio[1263]: at connResetException (node:internal/errors:720:14)
Mar 25 18:17:27 volumio volumio[1263]: at TLSSocket.socketCloseListener (node:_http_client:468:25)
Mar 25 18:17:27 volumio volumio[1263]: at TLSSocket.emit (node:events:526:35)
Mar 25 18:17:27 volumio volumio[1263]: at node:net:337:12
Mar 25 18:17:27 volumio volumio[1263]: at TCP.done (node:_tls_wrap:631:7) {
Mar 25 18:17:27 volumio volumio[1263]: code: 'ECONNRESET'
Mar 25 18:17:27 volumio volumio[1263]: }
Mar 25 18:17:27 volumio volumio[1263]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 25 18:17:28 volumio sudo[12365]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 18:16'
Mar 25 18:17:28 volumio sudo[12365]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="dc61260dec5515dafd2b634881860b4c46c919ff"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026"
VOLUMIO_VERSION="4.103"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"