Apr 03 16:25:05 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 03 16:25:05 iqaudio volumio[1288]: info: TuneIn handleBrowseUri: tunein/local
Apr 03 16:25:05 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:24 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , handleBrowseUri
Apr 03 16:25:24 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:34 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:34 iqaudio volumio[1288]: info: [1775201134216] ControllerWebradio::stop
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:25:34 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:34 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/radio/flac96
Apr 03 16:25:34 iqaudio volumio[1288]: info: Exploding uri motherearthradio/radio/flac96 in service motherearthradio
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.231+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.232+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://media-ice.musicradio.com/ClassicFMMP3 title="Classic FM"
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::play index 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: [MER] ▶️ Playing: https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo
Apr 03 16:25:34 iqaudio volumio[1288]: info: [MER] 🔌 Starting SSE for Radio
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand stop took 211 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand stop took 48 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:34 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:34 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand status took 32 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand clear took 30 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand status took 28 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand status took 27 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo"
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:34 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:34 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.505+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=177 volume=73
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.506+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.507+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=177 volume=73
Apr 03 16:25:34 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:34.508+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 96ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 94ms
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 87ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 83 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo" took 82 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 17ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 16ms
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:25:34 iqaudio volumio[1288]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 139ms
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: info:
Apr 03 16:25:34 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:34 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:34 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 69ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: sendMpdCommand play took 51 milliseconds
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 49ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: ------------------------------ 49ms
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:34 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Radio · FLAC 96kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/radio/flac96","streaming":true,"disableUiControls":true,"samplerate":"96 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Apr 03 16:25:34 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:34 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:34 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:34 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 3000ms
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 15 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: info:
Apr 03 16:25:36 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:36 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 36 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth.flac-lo"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 37 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 25 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 24 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 22 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 21 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.340+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1667 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.342+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 103ms
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand status took 117 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 102 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 101 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 85 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 83 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 83 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 75 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.440+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1840 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.442+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.443+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1840 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.444+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.446+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1840 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.447+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.448+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1840 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.449+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 242ms
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 242ms
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 242ms
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 226ms
Apr 03 16:25:36 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 114 milliseconds
Apr 03 16:25:36 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:36 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:36 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:36 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.528+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=1948 volume=73
Apr 03 16:25:36 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:36.529+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:36 iqaudio volumio[1288]: info: ------------------------------ 269ms
Apr 03 16:25:38 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:38 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 6000ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: No code
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: ControllerMpd::stop
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:25:39 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:39 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/radio/flac192
Apr 03 16:25:39 iqaudio volumio[1288]: info: Exploding uri motherearthradio/radio/flac192 in service motherearthradio
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.642+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.643+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.645+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.646+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.648+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.649+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.650+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:39 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:39.651+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac96 title=Radio
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::play index 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: [MER] ▶️ Playing: https://motherearth.streamserver24.com/listen/motherearth/motherearth
Apr 03 16:25:39 iqaudio volumio[1288]: info: [MER] 🔌 Starting SSE for Radio
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: sendMpdCommand stop took 182 milliseconds
Apr 03 16:25:39 iqaudio volumio[1288]: info: sendMpdCommand stop took 69 milliseconds
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: info: sendMpdCommand clear took 20 milliseconds
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth/motherearth"
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 16ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth/motherearth" took 14 milliseconds
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 14ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 10ms
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: info:
Apr 03 16:25:39 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:39 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 22ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: sendMpdCommand play took 6 milliseconds
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: ------------------------------ 4ms
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:39 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Radio · FLAC 192kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/radio/flac192","streaming":true,"disableUiControls":true,"samplerate":"192 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Apr 03 16:25:39 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:39 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:39 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:25:40 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:40 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 3000ms
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 14 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: info:
Apr 03 16:25:40 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:40 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 36 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth/motherearth"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 36 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 26 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 26 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 21 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.249+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=249 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.250+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 100ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand status took 111 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 96 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 94 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 79 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 79 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 78 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 76 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.344+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=461 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.344+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.346+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=461 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.348+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.349+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=461 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.350+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=461 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.351+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.351+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 235ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 234ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 235ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 221ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 105 milliseconds
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.420+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=569 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.421+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio[1288]: info: ------------------------------ 250ms
Apr 03 16:25:40 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService stop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: No code
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:40 iqaudio volumio[1288]: info: ControllerMpd::stop
Apr 03 16:25:40 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:40 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:25:40 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:25:40 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:40 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/klassik/flac192
Apr 03 16:25:40 iqaudio volumio[1288]: info: Exploding uri motherearthradio/klassik/flac192 in service motherearthradio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.969+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.969+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.973+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.974+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.975+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.977+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:40 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:40.978+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/radio/flac192 title=Radio
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::play index 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: [MER] ▶️ Playing: https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik
Apr 03 16:25:41 iqaudio volumio[1288]: info: [MER] 🔌 Starting SSE for Klassik
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:41 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:41 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 3000ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand stop took 183 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand stop took 76 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand clear took 7 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 23ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik" took 22 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 6ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:41 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 18ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand play took 6 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 4ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Klassik · FLAC 192kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/klassik/flac192","streaming":true,"disableUiControls":true,"samplerate":"192 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:41 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 12 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: info:
Apr 03 16:25:41 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:41 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 32 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 33 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 24 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 23 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 23 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 21 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand status took 19 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.550+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.551+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 83ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 84 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 83 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 70 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 69 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 68 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 66 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 66 milliseconds
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:41 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:41 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.642+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=433 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.643+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.645+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=433 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.647+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.649+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=433 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.650+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.651+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=433 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.652+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.653+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=433 volume=73
Apr 03 16:25:41 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:41.653+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 216ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 216ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 217ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 205ms
Apr 03 16:25:41 iqaudio volumio[1288]: info: ------------------------------ 204ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: No code
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::stop
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:25:42 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:42 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/klassik/flac192
Apr 03 16:25:42 iqaudio volumio[1288]: info: Using cached record of: motherearthradio/klassik/flac192
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.286+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.287+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.289+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.290+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.291+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.292+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.293+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.294+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::play index 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: [MER] ▶️ Playing: https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik
Apr 03 16:25:42 iqaudio volumio[1288]: info: [MER] 🔌 Starting SSE for Klassik
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand stop took 142 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand stop took 53 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand clear took 5 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 32ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik" took 31 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 7ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:42 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 25ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand play took 9 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 6ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 4ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Klassik · FLAC 192kHz/24bit Stereo","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/klassik/flac192","streaming":true,"disableUiControls":true,"samplerate":"192 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:42 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 18 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 18 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: info:
Apr 03 16:25:42 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:42 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 54 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 54 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 43 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 41 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 29 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.591+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.593+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.594+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.596+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 130ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 129ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 139 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand status took 138 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 117 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 115 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 102 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 101 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.681+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=185 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.681+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.682+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=185 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.683+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 210ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 209ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 46 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 46 milliseconds
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:42 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:42 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.733+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=185 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.734+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.734+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=185 volume=73
Apr 03 16:25:42 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:42.735+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 230ms
Apr 03 16:25:42 iqaudio volumio[1288]: info: ------------------------------ 229ms
Apr 03 16:25:42 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:42 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 3000ms
Apr 03 16:25:45 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:45 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 6000ms
Apr 03 16:25:47 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 03 16:25:47 iqaudio volumio[1288]: info: CURURI: playlists
Apr 03 16:25:47 iqaudio volumio[1288]: info: Listing playlists
Apr 03 16:25:47 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:48 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Apr 03 16:25:48 iqaudio volumio[1288]: info: CURURI: playlists/NAS_classic
Apr 03 16:25:48 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:48 iqaudio volumio[1288]: info: Preloading song: http://mscp3.live-streams.nl:8360/flac.flac
Apr 03 16:25:48 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 03 16:25:51 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:25:51 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 9000ms
Apr 03 16:25:51 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Apr 03 16:25:51 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService stop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: No code
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:51 iqaudio volumio[1288]: info: ControllerMpd::stop
Apr 03 16:25:51 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:25:51 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:25:51 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:25:51 iqaudio volumio[1288]: info: Adding Item to queue: http://mscp3.live-streams.nl:8360/flac.flac
Apr 03 16:25:51 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.007+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.008+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.010+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.011+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.012+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.013+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.014+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:52 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:52.015+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/flac192 title=Klassik
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:25:52 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:52 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::play index 0
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:52 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:52 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:25:52 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:52 iqaudio volumio[1288]: info: [1775201152069] ControllerWebradio::clearAddPlayTrack
Apr 03 16:25:52 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:52 iqaudio volumio[1288]: info: sendMpdCommand stop took 144 milliseconds
Apr 03 16:25:52 iqaudio volumio[1288]: info: sendMpdCommand stop took 64 milliseconds
Apr 03 16:25:52 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:25:52 iqaudio volumio[1288]: info:
Apr 03 16:25:52 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:52 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:52 iqaudio volumio[1288]: info: sendMpdCommand clear took 18 milliseconds
Apr 03 16:25:52 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8360/flac.flac"
Apr 03 16:25:52 iqaudio volumio[1288]: info:
Apr 03 16:25:52 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:52 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:52 iqaudio volumio[1288]: info:
Apr 03 16:25:52 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:52 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:52 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:52 iqaudio volumio[1288]: info: ------------------------------ 12ms
Apr 03 16:25:52 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:25:53 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac"
Apr 03 16:25:53 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:53 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:25:53 iqaudio volumio[1288]: info: ------------------------------ 990ms
Apr 03 16:25:53 iqaudio volumio[1288]: info: ------------------------------ 989ms
Apr 03 16:25:53 iqaudio volumio[1288]: info:
Apr 03 16:25:53 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:53 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:53 iqaudio volumio[1288]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" took 3 milliseconds
Apr 03 16:25:53 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 03 16:25:53 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:25:53 iqaudio volumio[1288]: info:
Apr 03 16:25:53 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:53 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:53 iqaudio volumio[1288]: info:
Apr 03 16:25:53 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:53 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:53 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:53 iqaudio volumio[1288]: info: sendMpdCommand play took 4 milliseconds
Apr 03 16:25:53 iqaudio volumio[1288]: info: ------------------------------ 4ms
Apr 03 16:25:53 iqaudio volumio[1288]: info: ------------------------------ 4ms
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 18 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 18 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 15 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 6 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 4 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 2 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 53ms
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.257+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.258+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.260+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.261+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.263+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.263+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.266+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.266+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 112ms
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 111ms
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 90 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 89 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 89 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.375+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.376+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.380+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.381+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.392+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.392+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.392+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.392+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.393+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.393+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.394+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=0 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.395+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 260ms
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 254ms
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 254ms
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:54 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:54 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:25:54 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:25:54 iqaudio volumio[1288]: info:
Apr 03 16:25:54 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 8ms
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 6 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 6ms
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 6 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand status took 5 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:54 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:54 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:54 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.969+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.970+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.972+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.973+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.974+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.975+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.977+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:54 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:54.978+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:55 iqaudio volumio[1288]: info: ------------------------------ 94ms
Apr 03 16:25:55 iqaudio volumio[1288]: info: ------------------------------ 90ms
Apr 03 16:25:55 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 83 milliseconds
Apr 03 16:25:55 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:55 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:55 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:55 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Apr 03 16:25:55 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus play
Apr 03 16:25:55 iqaudio volumio[1288]: info: Received an update from plugin. extracting info from payload
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:55 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:55 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:55 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:55.051+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:55 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:55.056+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=698 volume=73
Apr 03 16:25:55 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:55.056+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:55 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:55.057+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:55 iqaudio volumio[1288]: info: ------------------------------ 149ms
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::volumioStop
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:25:58 iqaudio volumio[1288]: info: [1775201158115] ControllerWebradio::stop
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.119+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.120+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:58 iqaudio volumio[1288]: info:
Apr 03 16:25:58 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand stop took 44 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:58 iqaudio volumio[1288]: info:
Apr 03 16:25:58 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:58 iqaudio volumio[1288]: info:
Apr 03 16:25:58 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand status took 9 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand status took 6 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand status took 3 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:58 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 03 16:25:58 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:25:58 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:25:58 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.223+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=2680 volume=73
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.224+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=2680 volume=73
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.224+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=2680 volume=73
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.225+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.226+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:58 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:25:58.227+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=http://mscp3.live-streams.nl:8360/flac.flac title="Naim Radio (FLAC)"
Apr 03 16:25:58 iqaudio volumio[1288]: info: ------------------------------ 92ms
Apr 03 16:25:58 iqaudio volumio[1288]: info: ------------------------------ 88ms
Apr 03 16:25:58 iqaudio volumio[1288]: info: ------------------------------ 87ms
Apr 03 16:25:58 iqaudio volumio[1288]: info: touch_display: Setting screensaver timeout to 120 seconds.
Apr 03 16:26:00 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:00 iqaudio volumio[1288]: info: Preloading song: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:00 iqaudio volumio[1288]: info: Preloading song: motherearthradio/klassik/mono192
Apr 03 16:26:00 iqaudio volumio[1288]: info: Preloading song: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:00 iqaudio volumio[1288]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Apr 03 16:26:00 iqaudio volumio[1288]: info: Exploding uri mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav in service mpd
Apr 03 16:26:00 iqaudio volumio[1288]: error: scanFolder - failure to stat '/mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav'
Apr 03 16:26:00 iqaudio volumio[1288]: info: Exploding uri motherearthradio/klassik/mono192 in service motherearthradio
Apr 03 16:26:00 iqaudio volumio[1288]: info: Exploding uri mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape in service mpd
Apr 03 16:26:00 iqaudio volumio[1288]: error: scanFolder - failure to stat '/mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape'
Apr 03 16:26:01 iqaudio volumio[1288]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Apr 03 16:26:03 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:26:03 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:03 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:03 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:03 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/klassik/mono192
Apr 03 16:26:03 iqaudio volumio[1288]: info: Using cached record of: motherearthradio/klassik/mono192
Apr 03 16:26:03 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:03 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::play index 2
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:26:03 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:03 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 2
Apr 03 16:26:06 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:26:06 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:06 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:06 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:06 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/klassik/mono192
Apr 03 16:26:06 iqaudio volumio[1288]: info: Using cached record of: motherearthradio/klassik/mono192
Apr 03 16:26:06 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:06 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::play index 2
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:26:06 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:06 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 2
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::startPlaybackTimer
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: [MER] ▶️ Playing: https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono
Apr 03 16:26:07 iqaudio volumio[1288]: info: [MER] 🔌 Starting SSE for Klassik
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand stop took 1 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clear
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand clear took 1 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono"
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: error: updateQueue error: null
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces system playlist update
Apr 03 16:26:07 iqaudio volumio[1288]: info: Ignoring MPD Status Update
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 7ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand add "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono" took 6 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 5ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 3ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 2ms
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand play
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 12ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand play took 9 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"play","service":"motherearthradio","type":"webradio","trackType":"flac","radioType":"mer","title":"Connecting...","artist":"Mother Earth Radio","album":"Klassik · FLAC 192kHz/24bit Mono","albumart":"/albumart?sourceicon=music_service/motherearthradio/mer-logo-cube-bold-1x 512.png","uri":"motherearthradio/klassik/mono192","streaming":true,"disableUiControls":true,"samplerate":"MONO/192 kHz","bitdepth":"24 bit","duration":0,"seek":0}
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService play
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:26:07 iqaudio volumio[1288]: error: [MER] SSE request error: getaddrinfo ENOTFOUND motherearth.streamserver24.com
Apr 03 16:26:07 iqaudio volumio[1288]: info: [MER] SSE: Reconnecting in 3000ms
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 17 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: info:
Apr 03 16:26:07 iqaudio volumio[1288]: ---------------------------- MPD announces state update: player
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::getState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand status
Apr 03 16:26:07 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 34 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: error: MPD returned error for command status: Failed to decode "https://motherearth.streamserver24.com/listen/motherearth_klassik/motherearth.klassik.mono"; Could not resolve host: motherearth.streamserver24.com: Couldn't resolve host name
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand clearerror
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 36 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 23 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 28 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 27 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 23 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.691+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 69ms
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.697+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand status took 59 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 51 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand clearerror took 48 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 32 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseState
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.738+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.741+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.742+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.743+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.743+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.744+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.744+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.745+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 120ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 120ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 120ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 102ms
Apr 03 16:26:07 iqaudio volumio[1288]: info: sendMpdCommand playlistinfo took 37 milliseconds
Apr 03 16:26:07 iqaudio volumio[1288]: verbose: ControllerMpd::parseTrackInfo
Apr 03 16:26:07 iqaudio volumio[1288]: info: ControllerMpd::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:07 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:07 iqaudio volumio[1288]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current motherearthradio Received mpd
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.760+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_PLAYING positionMs=251 volume=73
Apr 03 16:26:07 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:07.760+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:07 iqaudio volumio[1288]: info: ------------------------------ 110ms
Apr 03 16:26:10 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::ClearQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::stPlaybackTimer
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::serviceStop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::serviceStop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::servicePushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: verbose: STATE SERVICE {"status":"stop","service":"motherearthradio"}
Apr 03 16:26:10 iqaudio volumio[1288]: verbose: CURRENT POSITION 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::syncState stateService stop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::syncState currentStatus stop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: No code
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::pushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 0
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushState
Apr 03 16:26:10 iqaudio volumio[1288]: info: ControllerMpd::stop
Apr 03 16:26:10 iqaudio volumio[1288]: verbose: ControllerMpd::sendMpdCommand stop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::clearPlayQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::addQueueItems
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::addQueueItems
Apr 03 16:26:10 iqaudio volumio[1288]: info: Preload queue cleared
Apr 03 16:26:10 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:10 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/EAC_CDs/Les Secrets de la Nature - Tim Mac Brian/03 Track03.wav
Apr 03 16:26:10 iqaudio volumio[1288]: info: Adding Item to queue: motherearthradio/klassik/mono192
Apr 03 16:26:10 iqaudio volumio[1288]: info: Using cached record of: motherearthradio/klassik/mono192
Apr 03 16:26:10 iqaudio volumio[1288]: info: Adding Item to queue: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:10 iqaudio volumio[1288]: info: Using cached record of: mnt/NAS/QNAP/music_classic/Albinoni 아다지오 G단조.ape
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.903+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.904+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.905+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.906+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.907+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.908+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" state=STATUS_STOPPED positionMs=0 volume=73
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.908+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:10 iqaudio volumio5-onboarding[1708]: time=2026-04-03T16:26:10.910+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.150:34584,00:00:00:00:00:00%02 @ 0x1400a50" id=motherearthradio/klassik/mono192 title=Klassik
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPushQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::saveQueue
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::updateTrackBlock
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrackBlock
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreCommandRouter::volumioPlay
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::play index 2
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::stop
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::play index undefined
Apr 03 16:26:10 iqaudio volumio[1288]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 03 16:26:10 iqaudio volumio[1288]: info: CorePlayQueue::getTrack 2
Apr 03 16:26:10 iqaudio volumio[1288]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 03 16:26:11 iqaudio volumio[1288]: Error: socket hang up
Apr 03 16:26:11 iqaudio volumio[1288]: at connResetException (node:internal/errors:720:14)
Apr 03 16:26:11 iqaudio volumio[1288]: at TLSSocket.socketCloseListener (node:_http_client:468:25)
Apr 03 16:26:11 iqaudio volumio[1288]: at TLSSocket.emit (node:events:526:35)
Apr 03 16:26:11 iqaudio volumio[1288]: at node:net:337:12
Apr 03 16:26:11 iqaudio volumio[1288]: at TCP.done (node:_tls_wrap:631:7) {
Apr 03 16:26:11 iqaudio volumio[1288]: code: 'ECONNRESET'
Apr 03 16:26:11 iqaudio volumio[1288]: }
Apr 03 16:26:11 iqaudio volumio[1288]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 03 16:26:13 iqaudio sudo[3987]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 16:25'
Apr 03 16:26:13 iqaudio sudo[3987]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"