Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:07 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:07 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:07 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:07 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:07 kitchen volumio[1148]: info:
Aug 27 09:11:07 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 10ms
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand status took 8 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 7ms
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand status took 7 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 7ms
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 10ms
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand status took 7 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 5 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 4 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 3 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:07 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:07 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:07 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:07 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:07 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:07 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:07 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:07 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:07 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.333+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.334+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.336+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.337+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.344+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.344+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.346+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.347+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.349+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.350+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.353+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19495 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.353+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 139ms
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 138ms
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 137ms
Aug 27 09:11:07 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 124 milliseconds
Aug 27 09:11:07 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:07 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:07 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":20577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:07 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:07 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:07 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.413+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19851 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.413+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.417+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=19851 volume=39
Aug 27 09:11:07 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:07.418+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="Will Powers - Kissing With Confidence"
Aug 27 09:11:07 kitchen volumio[1148]: info: ------------------------------ 184ms
Aug 27 09:11:09 kitchen volumio[1148]: info: Preload queue cleared
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioReplaceandPlayItems
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::ClearQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::stPlaybackTimer
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::updateTrackBlock
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrackBlock
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::serviceStop
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::serviceStop
Aug 27 09:11:09 kitchen volumio[1148]: info: [1787814669062] ControllerWebradio::stop
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::clearPlayQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::saveQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::addQueueItems
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::addQueueItems
Aug 27 09:11:09 kitchen volumio[1148]: info: Preload queue cleared
Aug 27 09:11:09 kitchen volumio[1148]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s296768
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.082+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.084+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id="https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein" title="BOOM RADIO"
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand stop took 77 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 9 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 5 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 3 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 10 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 11 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 11 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 10 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: No code
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: No code
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: No code
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Will Powers - Kissing With Confidence","artist":null,"album":null,"uri":"https://listen-boomradio.sharp-stream.com/65_boom_radio_live_128?platform=tunein","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio[1148]: info: No code
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.308+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.309+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.319+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.320+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.320+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.321+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.321+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.323+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.323+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.323+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.324+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.324+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.324+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.325+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.326+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.327+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.328+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.330+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.331+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:09 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:09.332+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id= title=
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 222ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 219ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 218ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 218ms
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::saveQueue
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::updateTrackBlock
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrackBlock
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::volumioPlay
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::play index 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::stop
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::play index undefined
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::startPlaybackTimer
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: info: [1787814669691] ControllerWebradio::clearAddPlayTrack
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand stop
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand stop took 4 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand clear
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand clear took 1 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand load "http://ice-the.musicradio.com/ClassicFMMP3"
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 5ms
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand add "http://ice-the.musicradio.com/ClassicFMMP3"
Aug 27 09:11:09 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:09 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:09 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 141ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 141ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 140ms
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand add "http://ice-the.musicradio.com/ClassicFMMP3" took 3 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService mpd
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand play
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 8ms
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand play took 6 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 7ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 5ms
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 5ms
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 36 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 35 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 33 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 33 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:09 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 12 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 55ms
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info:
Aug 27 09:11:09 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 14 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: ------------------------------ 16ms
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 13 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 8 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:09 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:09 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:09 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:09 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:09 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:09 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.108+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.110+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.111+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.111+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.114+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.115+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.117+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.118+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.121+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.122+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.124+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.124+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 213ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 213ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 213ms
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:10 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:10 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:10 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:10 kitchen volumio[1148]: info:
Aug 27 09:11:10 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 159 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 159 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 158 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 159 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 158 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 10ms
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand status took 9 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 8ms
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand status took 8 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.297+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.298+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.300+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.302+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.303+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.304+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.306+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.307+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.309+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.310+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.313+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.314+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.316+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.317+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.319+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.321+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.322+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.323+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.325+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.325+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 383ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 382ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 376ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 375ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 375ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 357ms
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand status took 356 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 350 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 349 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.555+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.555+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.558+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.558+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.560+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.560+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.562+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.562+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 432ms
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 431ms
Aug 27 09:11:10 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 75 milliseconds
Aug 27 09:11:10 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:10 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:10 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":984,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:10 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:10 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:10 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.609+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.610+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.611+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=564 volume=39
Aug 27 09:11:10 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:10.612+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:10 kitchen volumio[1148]: info: ------------------------------ 467ms
Aug 27 09:11:18 kitchen volumio[1148]: info: Preload queue cleared
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioReplaceandPlayItems
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::ClearQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::stop
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::stPlaybackTimer
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::updateTrackBlock
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrackBlock
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::serviceStop
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::serviceStop
Aug 27 09:11:18 kitchen volumio[1148]: info: [1787814678385] ControllerWebradio::stop
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand stop
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::clearPlayQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::saveQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::addQueueItems
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::addQueueItems
Aug 27 09:11:18 kitchen volumio[1148]: info: Preload queue cleared
Aug 27 09:11:18 kitchen volumio[1148]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s296768
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.398+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.398+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::saveQueue
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::updateTrackBlock
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrackBlock
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPlay
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::play index 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::stop
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::play index undefined
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::startPlaybackTimer
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: [1787814678424] ControllerWebradio::clearAddPlayTrack
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand stop
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand stop took 51 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand stop took 13 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand clear
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 7 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand clear took 7 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 5 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 4 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand load "http://ice-the.musicradio.com/ClassicFMMP3"
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.500+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.501+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.504+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.505+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.509+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_STOPPED positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.509+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 83ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 83ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 82ms
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:18 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:18 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:18 kitchen volumio[1148]: error: updateQueue error: null
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 91ms
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 88 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand add "http://ice-the.musicradio.com/ClassicFMMP3"
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 10ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 8ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 7ms
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 100ms
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand add "http://ice-the.musicradio.com/ClassicFMMP3" took 34 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::setConsumeUpdateService mpd
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand play
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 9ms
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand play took 7 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 4ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 3ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 2ms
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 36 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 34 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 34 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 33 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 7 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus stop
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 88ms
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.788+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.789+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.792+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.792+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.796+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.798+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.800+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.802+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.802+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.803+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.806+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=0 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.808+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 181ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 181ms
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 180ms
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 149 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 148 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 145 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 6 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 5ms
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ClassicFMMP3","artist":null,"album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.874+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=162 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.875+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.876+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=162 volume=39
Aug 27 09:11:18 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:18.877+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="Classic FM 2"
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 199ms
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces system playlist update
Aug 27 09:11:18 kitchen volumio[1148]: info: Ignoring MPD Status Update
Aug 27 09:11:18 kitchen volumio[1148]: info:
Aug 27 09:11:18 kitchen volumio[1148]: ---------------------------- MPD announces state update: player
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::getState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand status
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 117 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 116ms
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 114 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 113 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 113 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 112 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 72ms
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 71 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: info: ------------------------------ 39ms
Aug 27 09:11:18 kitchen volumio[1148]: info: sendMpdCommand status took 38 milliseconds
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::parseState
Aug 27 09:11:18 kitchen volumio[1148]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:18 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:18 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:18 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:18 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.034+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.037+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.037+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.038+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.041+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.041+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.043+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.045+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.045+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.046+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.047+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.049+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 374ms
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 374ms
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 232ms
Aug 27 09:11:19 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 114 milliseconds
Aug 27 09:11:19 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 115 milliseconds
Aug 27 09:11:19 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 114 milliseconds
Aug 27 09:11:19 kitchen volumio[1148]: info: sendMpdCommand playlistinfo took 114 milliseconds
Aug 27 09:11:19 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:19 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:19 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:19 kitchen volumio[1148]: verbose: ControllerMpd::parseTrackInfo
Aug 27 09:11:19 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:19 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:19 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:19 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:19 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:19 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:19 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:19 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:19 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:19 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: ControllerMpd::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::servicePushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CorePlayQueue::getTrack 0
Aug 27 09:11:19 kitchen volumio[1148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)","artist":"Classic FM","album":null,"uri":"http://ice-the.musicradio.com/ClassicFMMP3","trackType":""}
Aug 27 09:11:19 kitchen volumio[1148]: verbose: CURRENT POSITION 0
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState stateService play
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::syncState currentStatus play
Aug 27 09:11:19 kitchen volumio[1148]: info: Received an update from plugin. extracting info from payload
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreStateMachine::pushState
Aug 27 09:11:19 kitchen volumio[1148]: info: CoreCommandRouter::volumioPushState
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.158+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.160+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.160+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.161+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.163+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.164+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.165+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.165+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.167+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.170+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.171+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.173+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.174+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.175+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.176+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" state=STATUS_PLAYING positionMs=280 volume=39
Aug 27 09:11:19 kitchen volumio5-onboarding[1881]: time=2026-08-27T09:11:19.177+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.213:54852,00:00:00:00:00:00%01 @ 0x249ed20" id=http://ice-the.musicradio.com/ClassicFMMP3 title="George Frideric Handel, Xavier de Maistre - Organ Concerto in F major HWV.293 (4)"
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 361ms
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 359ms
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 315ms
Aug 27 09:11:19 kitchen volumio[1148]: info: ------------------------------ 282ms
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Aug 27 09:11:36 kitchen volumio[1148]: info: Received Get System Version
Aug 27 09:11:36 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 27 09:11:49 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 27 09:11:49 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 27 09:11:53 kitchen volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 27 09:11:53 kitchen volumio[1148]: info: touch_display: About to detect HDMI ports...
Aug 27 09:11:53 kitchen volumio[1148]: info: touch_display: X server not ready, cannot detect HDMI ports yet.
Aug 27 09:12:03 kitchen volumio[1148]: info: CALLMETHOD: user_interface touch_display savePointerConf [object Object]
Aug 27 09:12:03 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: touch_display , savePointerConf
Aug 27 09:12:03 kitchen volumio[1148]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 27 09:12:03 kitchen volumio[1148]: error: touch_display: Pointer config cannot be applied: Error: ENOENT: no such file or directory, stat '/tmp/.X11-unix/Xundefined'
Aug 27 09:12:03 kitchen volumio[1148]: info: touch_display: About to detect HDMI ports...
Aug 27 09:12:03 kitchen volumio[1148]: info: touch_display: X server not ready, cannot detect HDMI ports yet.
Aug 27 09:12:11 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 27 09:12:11 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 27 09:12:19 kitchen volumio[1148]: info: Enabling plugin touch_display
Aug 27 09:12:19 kitchen volumio[1148]: info: Loading plugin "touch_display"...
Aug 27 09:12:19 kitchen volumio[1148]: info: Applying required configuration parameters for plugin touch_display
Aug 27 09:12:19 kitchen volumio[1148]: info: PLUGIN START: touch_display
Aug 27 09:12:19 kitchen volumio[1148]: info: Loading i18n strings for locale en
Aug 27 09:12:19 kitchen volumio[1148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 27 09:12:19 kitchen sudo[3021]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge
Aug 27 09:12:19 kitchen sudo[3021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen volumio[1148]: info: touch_display: No backlight interface detected.
Aug 27 09:12:19 kitchen sudo[3023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Aug 27 09:12:19 kitchen sudo[3021]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:19 kitchen sudo[3023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen sudo[3026]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Aug 27 09:12:19 kitchen sudo[3026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen sudo[3028]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Aug 27 09:12:19 kitchen sudo[3028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen volumio[1148]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Aug 27 09:12:19 kitchen sudo[3032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/
Aug 27 09:12:19 kitchen sudo[3032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen sudo[3036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Aug 27 09:12:19 kitchen sudo[3036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:19 kitchen sudo[3032]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:19 kitchen volumio[1148]: info: touch_display: IframeKeyboardBridge extension installed successfully
Aug 27 09:12:19 kitchen sudo[3036]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:19 kitchen volumio[1148]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Aug 27 09:12:19 kitchen systemd[1]: Reloading.
Aug 27 09:12:21 kitchen sudo[3028]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:21 kitchen volumio[1148]: info: touch_display: systemctl daemon-reload succeeded.
Aug 27 09:12:21 kitchen systemd[1]: Reloading.
Aug 27 09:12:21 kitchen sudo[3059]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Aug 27 09:12:21 kitchen sudo[3059]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:22 kitchen sudo[3026]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:22 kitchen volumio[1148]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Aug 27 09:12:22 kitchen sudo[3059]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:22 kitchen volumio[1148]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service
Aug 27 09:12:22 kitchen volumio[1148]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found.
Aug 27 09:12:22 kitchen volumio[1148]: info: Error: Error
Aug 27 09:12:22 kitchen sudo[3023]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:22 kitchen volumio[1148]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Aug 27 09:12:30 kitchen volumio[1148]: info: Starting Uninstall of plugin user_interface - touch_display
Aug 27 09:12:30 kitchen volumio[1148]: info: Uninstalling plugin touch_display
Aug 27 09:12:30 kitchen sudo[3094]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Aug 27 09:12:30 kitchen sudo[3094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:30 kitchen sudo[3094]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:30 kitchen sudo[3096]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service
Aug 27 09:12:30 kitchen sudo[3096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:30 kitchen volumio[1148]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Aug 27 09:12:30 kitchen sudo[3098]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service
Aug 27 09:12:30 kitchen volumio[1148]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 27 09:12:30 kitchen sudo[3098]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:30 kitchen volumio[1148]: TypeError: Cannot read properties of undefined (reading 'split')
Aug 27 09:12:30 kitchen volumio[1148]: at /data/plugins/user_interface/touch_display/index.js:1298:37
Aug 27 09:12:30 kitchen volumio[1148]: at ChildProcess.exithandler (node:child_process:413:7)
Aug 27 09:12:30 kitchen volumio[1148]: at ChildProcess.emit (node:events:514:28)
Aug 27 09:12:30 kitchen volumio[1148]: at maybeClose (node:internal/child_process:1105:16)
Aug 27 09:12:30 kitchen volumio[1148]: at Socket. (node:internal/child_process:457:11)
Aug 27 09:12:30 kitchen volumio[1148]: at Socket.emit (node:events:514:28)
Aug 27 09:12:30 kitchen volumio[1148]: at Pipe. (node:net:337:12)
Aug 27 09:12:30 kitchen volumio[1148]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 27 09:12:30 kitchen sudo[3101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service
Aug 27 09:12:30 kitchen sudo[3101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 27 09:12:30 kitchen sudo[3101]: pam_unix(sudo:session): session closed for user root
Aug 27 09:12:30 kitchen systemd[1]: Reloading.
Aug 27 09:12:31 kitchen sudo[3136]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-27 09:11'
Aug 27 09:12:31 kitchen sudo[3136]: 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"