Apr 13 21:20:00 studio mpd[7356]: 2026-04-13T21:20:00 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 13 21:20:00 studio systemd[1]: Started mpd.service - Music Player Daemon.
Apr 13 21:20:00 studio volumio[1353]: error: MPD error: The expression evaluated to a falsy value:
Apr 13 21:20:00 studio volumio[1353]: assert.ok(self.idling)
Apr 13 21:20:00 studio volumio[1353]: error: The expression evaluated to a falsy value:
Apr 13 21:20:00 studio volumio[1353]: assert.ok(self.idling)
Apr 13 21:20:00 studio volumio[1353]: error: MPD error: The expression evaluated to a falsy value:
Apr 13 21:20:00 studio volumio[1353]: assert.ok(self.idling)
Apr 13 21:20:00 studio volumio[1353]: error: The expression evaluated to a falsy value:
Apr 13 21:20:00 studio volumio[1353]: assert.ok(self.idling)
Apr 13 21:20:00 studio volumio[1353]: error: updateQueue error: null
Apr 13 21:20:21 studio volumio[1353]: info: Preload queue cleared
Apr 13 21:20:21 studio volumio[1353]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 13 21:20:21 studio volumio[1353]: info: CoreStateMachine::ClearQueue
Apr 13 21:20:21 studio volumio[1353]: info: CoreStateMachine::stop
Apr 13 21:20:21 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:20:21 studio volumio[1353]: info: CorePlayQueue::clearPlayQueue
Apr 13 21:20:21 studio volumio[1353]: info: CorePlayQueue::saveQueue
Apr 13 21:20:21 studio volumio[1353]: info: CoreCommandRouter::volumioPushQueue
Apr 13 21:20:21 studio volumio[1353]: info: CoreStateMachine::addQueueItems
Apr 13 21:20:21 studio volumio[1353]: info: CorePlayQueue::addQueueItems
Apr 13 21:20:21 studio volumio[1353]: info: Preload queue cleared
Apr 13 21:20:21 studio volumio[1353]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s26014
Apr 13 21:20:21 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 13 21:20:22 studio volumio[1353]: info: CoreCommandRouter::volumioPushQueue
Apr 13 21:20:22 studio volumio[1353]: info: CorePlayQueue::saveQueue
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::updateTrackBlock
Apr 13 21:20:22 studio volumio[1353]: info: CorePlayQueue::getTrackBlock
Apr 13 21:20:22 studio volumio[1353]: info: CoreCommandRouter::volumioPlay
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::play index 0
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::stop
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::play index undefined
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:20:22 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:22 studio volumio[1353]: info: CoreStateMachine::startPlaybackTimer
Apr 13 21:20:22 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:22 studio volumio[1353]: info: [1776108022054] ControllerWebradio::clearAddPlayTrack
Apr 13 21:20:22 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand stop
Apr 13 21:20:22 studio volumio[1353]: info: sendMpdCommand stop took 1 milliseconds
Apr 13 21:20:22 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand clear
Apr 13 21:20:22 studio volumio[1353]: info: sendMpdCommand clear took 0 milliseconds
Apr 13 21:20:22 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand load "https://stream.m-1.fm/m-1dance/mp3"
Apr 13 21:20:22 studio volumio[1353]: info:
Apr 13 21:20:22 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:22 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:22 studio volumio[1353]: info:
Apr 13 21:20:22 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:22 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand add "https://stream.m-1.fm/m-1dance/mp3"
Apr 13 21:20:23 studio volumio[1353]: error: updateQueue error: null
Apr 13 21:20:23 studio volumio[1353]: error: updateQueue error: null
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 965ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 965ms
Apr 13 21:20:23 studio volumio[1353]: error: updateQueue error: null
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand add "https://stream.m-1.fm/m-1dance/mp3" took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand play
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand play took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 1ms
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 25 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 25 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 24 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 1 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus stop
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 33ms
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.792+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.792+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.793+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.793+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.793+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.794+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.793+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.794+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 36ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 36ms
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 11 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 1 milliseconds
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.800+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.800+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.801+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.801+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 18ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: 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":"mp3","artist":null,"album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.813+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=95 volume=17
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 30ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 19ms
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.813+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=95 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.813+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=95 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.814+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.814+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=95 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.815+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.815+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.816+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:20:23 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:20:23 studio volumio[1353]: info:
Apr 13 21:20:23 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 6ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 5 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 1ms
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand status took 1 milliseconds
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kellerkind - Backflash","artist":"m-1 dance mp3","album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kellerkind - Backflash","artist":"m-1 dance mp3","album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:20:23 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:20:23 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Kellerkind - Backflash","artist":"m-1 dance mp3","album":null,"uri":"https://stream.m-1.fm/m-1dance/mp3","trackType":""}
Apr 13 21:20:23 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:20:23 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:23 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.833+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.833+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.833+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=114 volume=17
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.834+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.835+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:23.835+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 19ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 16ms
Apr 13 21:20:23 studio volumio[1353]: info: ------------------------------ 15ms
Apr 13 21:20:32 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:32.944+02:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" latency=-61.205201ms timeout=3s volume=18
Apr 13 21:20:32 studio volumio[1353]: info: VolumeController::SetAlsaVolume18
Apr 13 21:20:32 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:32 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:20:32 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:32 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:32.954+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=9141 volume=18
Apr 13 21:20:32 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:32.955+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:33 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:33.899+02:00 level=INFO msg="set volume" component=server type=REQUEST_TYPE_SET_VOLUME peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" latency=-76.341539ms timeout=3s volume=19
Apr 13 21:20:33 studio volumio[1353]: info: VolumeController::SetAlsaVolume19
Apr 13 21:20:33 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:20:33 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:20:33 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:20:33 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:33.909+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=10141 volume=19
Apr 13 21:20:33 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:33.910+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="Kellerkind - Backflash"
Apr 13 21:20:38 studio volumio[1353]: info: Received Get System Info
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 21:20:38 studio volumio[1353]: info: Discovery: Getting this device information
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::volumioGetState
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 21:20:38 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:38.469+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" available=true connected=true macAddress=d0:c0:bf:67:c8:7b ip4Address=192.168.178.131/24 ip6Address= ssid=TIM-05884133
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 13 21:20:38 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 13 21:20:39 studio volumio5-onboarding[1665]: time=2026-04-13T21:20:39.446+02:00 level=INFO msg="service successfully established" component=discovery/localnet
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 21:20:51 studio volumio[1353]: info: Discovery: Getting this device information
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::volumioGetState
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 21:20:51 studio volumio[1353]: verbose: New Socket.io Connection to 192.168.178.131:3000 from 192.168.178.32 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Apr 13 21:20:51 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Apr 13 21:21:12 studio volumio[1353]: info: Preload queue cleared
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::ClearQueue
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::stop
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::stPlaybackTimer
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::updateTrackBlock
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrackBlock
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::serviceStop
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::serviceStop
Apr 13 21:21:12 studio volumio[1353]: info: [1776108072236] ControllerWebradio::stop
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand stop
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::clearPlayQueue
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::saveQueue
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPushQueue
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::addQueueItems
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::addQueueItems
Apr 13 21:21:12 studio volumio[1353]: info: Preload queue cleared
Apr 13 21:21:12 studio volumio[1353]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.238+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_STOPPED positionMs=0 volume=19
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.239+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://stream.m-1.fm/m-1dance/mp3 title="M1 DANCE"
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPushQueue
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::saveQueue
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::updateTrackBlock
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrackBlock
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPlay
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::play index 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::stop
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::play index undefined
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::startPlaybackTimer
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: [1776108072245] ControllerWebradio::clearAddPlayTrack
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand stop
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand stop took 15 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand stop took 7 milliseconds
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand clear
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:12 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:12 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand status took 3 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand clear took 3 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand status took 2 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand status took 1 milliseconds
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320"
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:12 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 13 21:21:12 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:12 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:12 studio volumio[1353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.260+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_STOPPED positionMs=1 volume=19
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.261+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" title="Dance Wave!"
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.262+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_STOPPED positionMs=1 volume=19
Apr 13 21:21:12 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:12.262+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" title="Dance Wave!"
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 10ms
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 10ms
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: error: updateQueue error: null
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 252ms
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand playlistinfo took 252 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 252 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 243ms
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 242ms
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:12 studio volumio[1353]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 13 21:21:12 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand play
Apr 13 21:21:12 studio volumio[1353]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 257ms
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: info:
Apr 13 21:21:12 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:12 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 4ms
Apr 13 21:21:12 studio volumio[1353]: info: sendMpdCommand play took 3 milliseconds
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:21:12 studio volumio[1353]: info: ------------------------------ 2ms
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 14 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 14 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 13 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus stop
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 17ms
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 4 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 3 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 2 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"dance.mp3","artist":"(#1 - 8314/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.642+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.643+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.643+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.643+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.643+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.644+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.644+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.644+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="Dance Wave!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 30ms
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 29ms
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 14 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 14 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 13 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.657+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.657+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.657+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.657+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.658+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.658+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.658+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.659+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.659+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.659+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.659+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.659+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 32ms
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 32ms
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 30ms
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 26ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 25 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 26ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 25 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 10ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 9 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 9ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 8 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces system playlist update
Apr 13 21:21:13 studio volumio[1353]: info: Ignoring MPD Status Update
Apr 13 21:21:13 studio volumio[1353]: info:
Apr 13 21:21:13 studio volumio[1353]: ---------------------------- MPD announces state update: player
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::getState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand status
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 5ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 4 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 4ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand status took 3 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseState
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.697+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.698+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.698+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.698+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.698+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.699+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.699+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.699+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.700+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 54ms
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.701+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 54ms
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.701+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.702+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 39ms
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.701+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.701+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.702+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.702+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 38ms
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 23 milliseconds
Apr 13 21:21:13 studio volumio[1353]: info: sendMpdCommand playlistinfo took 23 milliseconds
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: verbose: ControllerMpd::parseTrackInfo
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: ControllerMpd::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::servicePushState
Apr 13 21:21:13 studio volumio[1353]: info: CorePlayQueue::getTrack 0
Apr 13 21:21:13 studio volumio[1353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"}
Apr 13 21:21:13 studio volumio[1353]: verbose: CURRENT POSITION 0
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState stateService play
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::syncState currentStatus play
Apr 13 21:21:13 studio volumio[1353]: info: Received an update from plugin. extracting info from payload
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreStateMachine::pushState
Apr 13 21:21:13 studio volumio[1353]: info: CoreCommandRouter::volumioPushState
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.712+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.713+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.712+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.712+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" state=STATUS_PLAYING positionMs=0 volume=19
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.713+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.714+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.714+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio5-onboarding[1665]: time=2026-04-13T21:21:13.714+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.32:39680,00:00:00:00:00:00%03 @ 0x336a930" id=https://dancewave.online:443/dance.mp3 title="All about Dance from 2000 till today!"
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 40ms
Apr 13 21:21:13 studio volumio[1353]: info: ------------------------------ 39ms
Apr 13 21:21:14 studio volumio[1353]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 21:21:14 studio volumio[1353]: TypeError: Cannot read properties of null (reading 'slice')
Apr 13 21:21:14 studio volumio[1353]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Apr 13 21:21:14 studio volumio[1353]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Apr 13 21:21:14 studio volumio[1353]: at Object.onceWrapper (node:events:629:26)
Apr 13 21:21:14 studio volumio[1353]: at ClientRequest.emit (node:events:514:28)
Apr 13 21:21:14 studio volumio[1353]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Apr 13 21:21:14 studio volumio[1353]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Apr 13 21:21:14 studio volumio[1353]: at TLSSocket.socketOnData (node:_http_client:535:22)
Apr 13 21:21:14 studio volumio[1353]: at TLSSocket.emit (node:events:514:28)
Apr 13 21:21:14 studio volumio[1353]: at addChunk (node:internal/streams/readable:343:12)
Apr 13 21:21:14 studio volumio[1353]: at readableAddChunk (node:internal/streams/readable:316:9)
Apr 13 21:21:14 studio volumio[1353]: at Readable.push (node:internal/streams/readable:253:10)
Apr 13 21:21:14 studio volumio[1353]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Apr 13 21:21:14 studio volumio[1353]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 21:21:14 studio sudo[7509]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-13 21:20'
Apr 13 21:21:14 studio sudo[7509]: 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"