-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2026-03-29 19:20:26 CEST. -- Mar 29 19:19:02 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:02 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::ClearQueue Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::serviceStop Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::serviceStop Mar 29 19:19:02 volumio volumio[1073]: info: [1774804742632] ControllerWebradio::stop Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::clearPlayQueue Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::addQueueItems Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::addQueueItems Mar 29 19:19:02 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:02 volumio volumio[1073]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s196839 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 29 19:19:02 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:02.658+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:02 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:02.659+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://streams.norawebstreams.de/nora-event01/mp3-192/tunein/play.m3u title="NORA Webstream Weihnachten" Mar 29 19:19:02 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:02 volumio volumio[1073]: info: Mar 29 19:19:02 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand stop took 191 milliseconds Mar 29 19:19:02 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:02 volumio volumio[1073]: info: Mar 29 19:19:02 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:02 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:02 volumio volumio[1073]: info: Mar 29 19:19:02 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:02 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand status took 59 milliseconds Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand status took 57 milliseconds Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand status took 54 milliseconds Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 29 19:19:02 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:02 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:02 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Harry Connick Jr. - When My Heart Finds Christmas","artist":"NORA Weihnachten Stream","album":null,"uri":"http://regiocast.streamabc.net/regc-noraweihnachten-mp3-192-8269748?sABC=69p95o30%230%2399o30s16nq4o44sqpoopp55so9sn781o%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1774803760","trackType":""} Mar 29 19:19:02 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:02 volumio volumio[1073]: info: No code Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:02 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:02 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:02 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:02 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Harry Connick Jr. - When My Heart Finds Christmas","artist":"NORA Weihnachten Stream","album":null,"uri":"http://regiocast.streamabc.net/regc-noraweihnachten-mp3-192-8269748?sABC=69p95o30%230%2399o30s16nq4o44sqpoopp55so9sn781o%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1774803760","trackType":""} Mar 29 19:19:03 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio[1073]: info: No code Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Harry Connick Jr. - When My Heart Finds Christmas","artist":"NORA Weihnachten Stream","album":null,"uri":"http://regiocast.streamabc.net/regc-noraweihnachten-mp3-192-8269748?sABC=69p95o30%230%2399o30s16nq4o44sqpoopp55so9sn781o%23gharva&aw_0_1st.playerid=tunein&amsparams=playerid:tunein;skey:1774803760","trackType":""} Mar 29 19:19:03 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio[1073]: info: No code Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.080+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.082+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.088+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.090+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.091+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.091+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.092+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.092+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.095+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.096+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.101+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.102+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.105+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.106+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.119+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:03 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:03.120+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:03 volumio volumio[1073]: info: ------------------------------ 425ms Mar 29 19:19:03 volumio volumio[1073]: info: ------------------------------ 422ms Mar 29 19:19:03 volumio volumio[1073]: info: ------------------------------ 421ms Mar 29 19:19:03 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:03 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::play index 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::play index undefined Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Mar 29 19:19:03 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:03 volumio volumio[1073]: info: [1774804743632] ControllerWebradio::clearAddPlayTrack Mar 29 19:19:03 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:03 volumio volumio[1073]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 29 19:19:03 volumio volumio[1073]: info: sendMpdCommand stop took 23 milliseconds Mar 29 19:19:03 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 19:19:03 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:03 volumio volumio[1073]: info: Mar 29 19:19:03 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:03 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:03 volumio volumio[1073]: info: sendMpdCommand clear took 15 milliseconds Mar 29 19:19:03 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand load "http://94media.net/stations/jimfm/jim128.pls" Mar 29 19:19:03 volumio volumio[1073]: info: Mar 29 19:19:03 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:03 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:03 volumio volumio[1073]: info: Mar 29 19:19:03 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:03 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:03 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:03 volumio volumio[1073]: info: ------------------------------ 22ms Mar 29 19:19:07 volumio volumio[1073]: info: sendMpdCommand load "http://94media.net/stations/jimfm/jim128.pls" took 4263 milliseconds Mar 29 19:19:07 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 19:19:07 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Mar 29 19:19:07 volumio volumio[1073]: info: Mar 29 19:19:07 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:07 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:07 volumio volumio[1073]: info: ------------------------------ 4265ms Mar 29 19:19:07 volumio volumio[1073]: info: ------------------------------ 4261ms Mar 29 19:19:07 volumio volumio[1073]: info: Mar 29 19:19:07 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:07 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:07 volumio volumio[1073]: info: Mar 29 19:19:07 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:07 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:07 volumio volumio[1073]: info: sendMpdCommand play took 7 milliseconds Mar 29 19:19:07 volumio volumio[1073]: info: ------------------------------ 6ms Mar 29 19:19:07 volumio volumio[1073]: info: ------------------------------ 3ms Mar 29 19:19:07 volumio volumio[1073]: info: ------------------------------ 3ms Mar 29 19:19:08 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 5 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: Mar 29 19:19:09 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 5 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:09 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:09 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:09 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:09 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:09 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:09 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:09 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:09 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:09 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:09 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:09 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:09 volumio volumio[1073]: info: ------------------------------ 43ms Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.942+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.943+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.945+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.945+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.947+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.948+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.949+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:09 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:09.950+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:09 volumio volumio[1073]: info: ------------------------------ 89ms Mar 29 19:19:09 volumio volumio[1073]: info: ------------------------------ 88ms Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 76 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 78 milliseconds Mar 29 19:19:09 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 79 milliseconds Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:09 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:09 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:09 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:09 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:09 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:09 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:09 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:10 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:10 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: 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":"Absolute Classic Hits - 70s, 80s, and More","artist":null,"album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:10 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:10 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.072+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.073+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.074+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.075+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.077+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.078+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.081+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.082+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.083+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.084+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.085+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.087+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Absolute Classic Hits - 70s, 80s, and More" Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 287ms Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 283ms Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 284ms Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:10 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:10 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:10 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 63ms Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand status took 62 milliseconds Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 58ms Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand status took 56 milliseconds Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 54ms Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand status took 52 milliseconds Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1085,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:10 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:10 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1085,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:10 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:10 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1085,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:10 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:10 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.489+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.490+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.492+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.493+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.498+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.500+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.501+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.503+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.504+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.506+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.508+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=418 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.509+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://audiovision.cdnstream1.com/2139_128.mp3 title="Live365 - Advertisement" Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 299ms Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 292ms Mar 29 19:19:10 volumio volumio[1073]: info: ------------------------------ 288ms Mar 29 19:19:10 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:10 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:10 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::ClearQueue Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::serviceStop Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::serviceStop Mar 29 19:19:10 volumio volumio[1073]: info: [1774804750861] ControllerWebradio::stop Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::clearPlayQueue Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:10 volumio volumio[1073]: info: CoreStateMachine::addQueueItems Mar 29 19:19:10 volumio volumio[1073]: info: CorePlayQueue::addQueueItems Mar 29 19:19:10 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:10 volumio volumio[1073]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s300554 Mar 29 19:19:10 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.882+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:10 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:10.883+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id=http://94media.net/stations/jimfm/jim128.pls title="Absolute Classic Hits" Mar 29 19:19:10 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: sendMpdCommand stop took 92 milliseconds Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:10 volumio volumio[1073]: info: Mar 29 19:19:10 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:10 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:10 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand status took 56 milliseconds Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand status took 52 milliseconds Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand status took 50 milliseconds Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 20 milliseconds Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:11 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:11 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: No code Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:11 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: No code Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Live365 - Advertisement","artist":"Absolute Classic Hits","album":null,"uri":"http://audiovision.cdnstream1.com/2139_128.mp3","trackType":"mp3"} Mar 29 19:19:11 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio[1073]: info: No code Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.145+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.145+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.147+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.151+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.152+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.148+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.155+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.156+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.160+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.161+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.163+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.163+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.166+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.168+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.172+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.173+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.176+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:11 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:11.177+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id= title= Mar 29 19:19:11 volumio volumio[1073]: info: ------------------------------ 367ms Mar 29 19:19:11 volumio volumio[1073]: info: ------------------------------ 362ms Mar 29 19:19:11 volumio volumio[1073]: info: ------------------------------ 360ms Mar 29 19:19:11 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:11 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::play index 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::play index undefined Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Mar 29 19:19:11 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:11 volumio volumio[1073]: info: [1774804751596] ControllerWebradio::clearAddPlayTrack Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand stop took 6 milliseconds Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 19:19:11 volumio volumio[1073]: info: Mar 29 19:19:11 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:11 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:11 volumio volumio[1073]: info: sendMpdCommand clear took 2 milliseconds Mar 29 19:19:11 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" Mar 29 19:19:11 volumio volumio[1073]: info: Mar 29 19:19:11 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:11 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:11 volumio volumio[1073]: info: Mar 29 19:19:11 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:11 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:11 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:11 volumio volumio[1073]: info: ------------------------------ 10ms Mar 29 19:19:14 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" Mar 29 19:19:14 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:14 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:14 volumio volumio[1073]: info: Mar 29 19:19:14 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:14 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:14 volumio volumio[1073]: info: ------------------------------ 3062ms Mar 29 19:19:14 volumio volumio[1073]: info: ------------------------------ 3060ms Mar 29 19:19:14 volumio volumio[1073]: info: sendMpdCommand add "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" took 3 milliseconds Mar 29 19:19:14 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 19:19:14 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Mar 29 19:19:14 volumio volumio[1073]: Upnp client error: Error: This socket has been ended by the other party Mar 29 19:19:14 volumio volumio[1073]: info: Mar 29 19:19:14 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:14 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:14 volumio volumio[1073]: info: Mar 29 19:19:14 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:14 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:14 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:19:14 volumio volumio[1073]: info: sendMpdCommand play took 6 milliseconds Mar 29 19:19:14 volumio volumio[1073]: info: ------------------------------ 3ms Mar 29 19:19:14 volumio volumio[1073]: info: ------------------------------ 2ms Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio volumio[1073]: info: Mar 29 19:19:16 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 17 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 16 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 14 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 22 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand status took 17 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 29 19:19:16 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:16 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:16 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:16 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:16 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:16 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:16 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:16 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:16 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:16 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:16 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:16 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:16 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:16 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:16 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:16 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:16 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:16 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:16 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:16 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:17 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:17 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:17 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:17 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 125ms Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.074+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.076+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.081+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.082+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.086+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.087+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.093+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.094+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.098+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.099+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.102+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.104+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 275ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 274ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 272ms Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 254 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 248 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: 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?aggregator=TuneIn","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:17 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:17 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: 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?aggregator=TuneIn","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:17 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:17 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.328+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=364 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.330+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.334+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=364 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.335+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.340+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=364 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.341+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.349+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=364 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.350+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 479ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 478ms Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 319ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 314 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 318ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 310 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 111ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 108 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 109ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 106 milliseconds Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::ClearQueue Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::serviceStop Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::serviceStop Mar 29 19:19:17 volumio volumio[1073]: info: [1774804757671] ControllerWebradio::stop Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::clearPlayQueue Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::addQueueItems Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::addQueueItems Mar 29 19:19:17 volumio volumio[1073]: info: Preload queue cleared Mar 29 19:19:17 volumio volumio[1073]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s300554 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.703+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=0 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.704+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::saveQueue Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::updateTrackBlock Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrackBlock Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPlay Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::play index 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::stop Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::play index undefined Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::startPlaybackTimer Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: [1774804757794] ControllerWebradio::clearAddPlayTrack Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand stop Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 270ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 261 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 259 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 257 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 257 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 235 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 194ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 190 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 188ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 185 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand stop took 140 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand stop took 17 milliseconds Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand clear Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 621ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 619ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 411ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 406ms Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 66 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 66 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 62 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 52 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand clear took 51 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 36ms Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 32 milliseconds Mar 29 19:19:17 volumio volumio[1073]: info: sendMpdCommand status took 29 milliseconds Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:17 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:17 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:17 volumio volumio[1073]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 403ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 323ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 317ms Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.952+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=8 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.953+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.964+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_STOPPED positionMs=8 volume=76 Mar 29 19:19:17 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:17.965+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 140ms Mar 29 19:19:17 volumio volumio[1073]: info: ------------------------------ 137ms Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:17 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:17 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:17 volumio volumio[1073]: info: Mar 29 19:19:17 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:17 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:18 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:18 volumio volumio[1073]: info: ------------------------------ 182ms Mar 29 19:19:18 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 175 milliseconds Mar 29 19:19:18 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:18 volumio volumio[1073]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 29 19:19:18 volumio volumio[1073]: info: ------------------------------ 261ms Mar 29 19:19:18 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:19 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" Mar 29 19:19:19 volumio volumio[1073]: error: updateQueue error: null Mar 29 19:19:19 volumio volumio[1073]: info: Mar 29 19:19:19 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:19 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 1578ms Mar 29 19:19:19 volumio volumio[1073]: info: sendMpdCommand status took 1573 milliseconds Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 1573ms Mar 29 19:19:19 volumio volumio[1073]: info: sendMpdCommand add "https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" took 4 milliseconds Mar 29 19:19:19 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 29 19:19:19 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand play Mar 29 19:19:19 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:19 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:19 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:19 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:19 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:19 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 29 19:19:19 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:19 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:19 volumio volumio[1073]: info: No code Mar 29 19:19:19 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:19 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.593+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1765 volume=76 Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.594+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.595+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1765 volume=76 Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.596+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.598+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1765 volume=76 Mar 29 19:19:19 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:19.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 1629ms Mar 29 19:19:19 volumio volumio[1073]: info: Mar 29 19:19:19 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:19 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:19 volumio volumio[1073]: info: Mar 29 19:19:19 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:19 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 62ms Mar 29 19:19:19 volumio volumio[1073]: info: sendMpdCommand play took 59 milliseconds Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 7ms Mar 29 19:19:19 volumio volumio[1073]: info: ------------------------------ 5ms Mar 29 19:19:19 volumio volumio[1073]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 20 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 12 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 8 milliseconds Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:21 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:21 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:21 volumio volumio[1073]: info: Mar 29 19:19:21 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 54 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 51 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 47 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 42 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: info: sendMpdCommand status took 38 milliseconds Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:21 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:21 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:21 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:21 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:21 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:21 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:21 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:21 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:21 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:21 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:21 volumio volumio[1073]: 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?aggregator=TuneIn","artist":null,"album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:21 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:21 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:21 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:21 volumio volumio[1073]: info: ------------------------------ 140ms Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.004+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.006+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.010+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.011+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.013+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.014+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.017+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=0 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.018+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 263ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 254ms Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:22 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:22 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 275ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 263 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 274ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 263 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 263 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 261 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 260 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 80ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 77 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 76ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 74 milliseconds Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: 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":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: 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":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.314+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.315+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.319+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.320+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.321+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.322+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.328+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.329+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.332+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.333+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.337+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=376 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.340+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 556ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 543ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 541ms Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:22 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:22 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:22 volumio volumio[1073]: info: Mar 29 19:19:22 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 279 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 280 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 281 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 281 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 63ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 59 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 58ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand status took 55 milliseconds Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1080,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1080,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.613+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.614+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.616+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.617+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.621+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.622+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.625+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.628+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.630+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.630+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.635+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.639+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.641+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.641+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.645+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=669 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.646+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 836ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 836ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 640ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 636ms Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 266 milliseconds Mar 29 19:19:22 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 265 milliseconds Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:22 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:22 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1377,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:22 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:22 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:22 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.841+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=956 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.842+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.845+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=956 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.847+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.851+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=956 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.852+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.857+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=956 volume=76 Mar 29 19:19:22 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:22.858+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 477ms Mar 29 19:19:22 volumio volumio[1073]: info: ------------------------------ 473ms Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:23 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:23 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:23 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:23 volumio volumio[1073]: info: Mar 29 19:19:23 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 11ms Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand status took 10 milliseconds Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 9ms Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand status took 8 milliseconds Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:23 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:23 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:23 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:23 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:23 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:23 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:23 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:23 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:23 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:23 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:23 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:23 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:23 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.656+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.657+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.659+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.660+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.662+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.662+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.664+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.665+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.666+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.667+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.669+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=1706 volume=76 Mar 29 19:19:23 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:23.669+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics" Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 135ms Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 135ms Mar 29 19:19:23 volumio volumio[1073]: info: ------------------------------ 134ms Mar 29 19:19:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 19:19:26 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 19:19:29 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:19:32 volumio volumio[1073]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 29 19:19:32 volumio volumio[1073]: info: Loaded the previous config. Mar 29 19:19:32 volumio volumio[1073]: info: ## populating UI... Mar 29 19:19:32 volumio volumio[1073]: info: 1/1 settings loaded Mar 29 19:19:32 volumio volumio[1073]: info: Populated config screen. Mar 29 19:19:33 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:37 volumio volumio[1073]: info: CALLMETHOD: system_controller audiophonicsonoff updateButtonConfig [object Object] Mar 29 19:19:37 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: audiophonicsonoff , updateButtonConfig Mar 29 19:19:37 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:19:42 volumio ntpd[779]: 90.187.112.137 local addr 192.168.178.192 -> Mar 29 19:19:43 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 19:19:46 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 19:19:48 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:48 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:48 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:48 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:48 volumio volumio[1073]: info: Mar 29 19:19:48 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:48 volumio volumio[1073]: info: ------------------------------ 7ms Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:19:48 volumio volumio[1073]: info: ------------------------------ 6ms Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand status took 5 milliseconds Mar 29 19:19:48 volumio volumio[1073]: info: ------------------------------ 5ms Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 19:19:48 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:48 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:48 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:48 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:48 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:48 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:48 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:48 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:48 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:48 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:48 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:48 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27586,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:48 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:48 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:48 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.654+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.655+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.657+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.658+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.658+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.659+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.661+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.661+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.663+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.663+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.665+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=26761 volume=76 Mar 29 19:19:48 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:48.665+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:48 volumio volumio[1073]: info: ------------------------------ 110ms Mar 29 19:19:48 volumio volumio[1073]: info: ------------------------------ 109ms Mar 29 19:19:50 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:51 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:51 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:51 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:51 volumio volumio[1073]: info: Mar 29 19:19:51 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 19ms Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand status took 16 milliseconds Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 16ms Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand status took 10 milliseconds Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:51 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:51 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:51 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:51 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30488,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:51 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:51 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:51 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:51 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30488,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:51 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:51 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:51 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:51 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":30488,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:51 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:51 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:51 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.587+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.588+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.593+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.594+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.597+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.599+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.602+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.603+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.607+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.608+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.611+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=29521 volume=76 Mar 29 19:19:51 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:51.612+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 214ms Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 209ms Mar 29 19:19:51 volumio volumio[1073]: info: ------------------------------ 206ms Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:53 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:53 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:53 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:53 volumio volumio[1073]: info: Mar 29 19:19:53 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:53 volumio volumio[1073]: info: ------------------------------ 7ms Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:19:53 volumio volumio[1073]: info: ------------------------------ 6ms Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand status took 4 milliseconds Mar 29 19:19:53 volumio volumio[1073]: info: ------------------------------ 5ms Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand status took 3 milliseconds Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 19:19:53 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:53 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:53 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:53 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:53 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:53 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:53 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:53 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:53 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:53 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:53 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:53 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"TINA TURNER - WE DON'T NEED ANOTHER HERO","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:53 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:53 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:53 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.048+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.049+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.051+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.051+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.053+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.053+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.055+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.055+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.057+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.058+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.059+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=31149 volume=76 Mar 29 19:19:53 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:53.060+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="TINA TURNER - WE DON'T NEED ANOTHER HERO" Mar 29 19:19:53 volumio volumio[1073]: info: ------------------------------ 105ms Mar 29 19:19:53 volumio volumio[1073]: info: ------------------------------ 104ms Mar 29 19:19:54 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:55 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:55 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:55 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:55 volumio volumio[1073]: info: Mar 29 19:19:55 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:55 volumio volumio[1073]: info: ------------------------------ 11ms Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Mar 29 19:19:55 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand status took 7 milliseconds Mar 29 19:19:55 volumio volumio[1073]: info: ------------------------------ 6ms Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand status took 5 milliseconds Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 19:19:55 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:55 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:55 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:55 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34783,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:55 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:55 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:55 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:55 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34783,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:55 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:55 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:55 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:55 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34783,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:55 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:55 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:55 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.951+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.953+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.955+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.956+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.960+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.962+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.969+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.970+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.974+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.975+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.978+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=33901 volume=76 Mar 29 19:19:55 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:55.980+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:56 volumio volumio[1073]: info: ------------------------------ 217ms Mar 29 19:19:56 volumio volumio[1073]: info: ------------------------------ 216ms Mar 29 19:19:56 volumio volumio[1073]: info: ------------------------------ 216ms Mar 29 19:19:56 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:58 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:58 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:19:58 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:19:58 volumio volumio[1073]: info: Mar 29 19:19:58 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 15ms Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand status took 13 milliseconds Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 11ms Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:58 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:58 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:58 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:58 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:58 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:58 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:58 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:58 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:58 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:58 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:19:58 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:19:58 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37077,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut Oldie Classics - Greatest Hits","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:19:58 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:19:58 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:19:58 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.221+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.222+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.226+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.227+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.237+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.238+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.241+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.242+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.244+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.245+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.248+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=36263 volume=76 Mar 29 19:19:58 volumio volumio5-onboarding[1226]: time=2026-03-29T19:19:58.249+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="Absolut Oldie Classics - Greatest Hits" Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 225ms Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 222ms Mar 29 19:19:58 volumio volumio[1073]: info: ------------------------------ 221ms Mar 29 19:20:00 volumio volumio[1073]: info: Enabling plugin audiophonicsonoff Mar 29 19:20:00 volumio volumio[1073]: info: Loading plugin "audiophonicsonoff"... Mar 29 19:20:00 volumio volumio[1073]: info: Applying required configuration parameters for plugin audiophonicsonoff Mar 29 19:20:00 volumio volumio[1073]: info: Audiophonics on/off initiated Mar 29 19:20:00 volumio volumio[1073]: info: PLUGIN START: audiophonicsonoff Mar 29 19:20:00 volumio volumio[1073]: info: Configuring GPIO pins Mar 29 19:20:00 volumio volumio[1073]: info: Error: Error: EINVAL: invalid argument, write Mar 29 19:20:00 volumio kernel: export_store: invalid GPIO 4 Mar 29 19:20:01 volumio volumio[1073]: info: Enabling plugin audiophonicsonoff Mar 29 19:20:01 volumio volumio[1073]: info: Loading plugin "audiophonicsonoff"... Mar 29 19:20:01 volumio volumio[1073]: info: Applying required configuration parameters for plugin audiophonicsonoff Mar 29 19:20:01 volumio volumio[1073]: info: Audiophonics on/off initiated Mar 29 19:20:01 volumio volumio[1073]: info: PLUGIN START: audiophonicsonoff Mar 29 19:20:01 volumio volumio[1073]: info: Configuring GPIO pins Mar 29 19:20:01 volumio volumio[1073]: info: Error: Error: EINVAL: invalid argument, write Mar 29 19:20:01 volumio kernel: export_store: invalid GPIO 4 Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:06 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:06 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:06 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:06 volumio volumio[1073]: info: Mar 29 19:20:06 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 9ms Mar 29 19:20:06 volumio volumio[1073]: info: sendMpdCommand status took 8 milliseconds Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 8ms Mar 29 19:20:06 volumio volumio[1073]: info: sendMpdCommand status took 7 milliseconds Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 7ms Mar 29 19:20:06 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:06 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 29 19:20:06 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:20:06 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:06 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:06 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:06 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:06 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:06 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:06 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:06 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:06 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45177,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:06 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:06 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:06 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.245+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.246+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.248+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.249+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.249+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.250+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.251+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.252+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.253+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.254+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.255+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=44276 volume=76 Mar 29 19:20:06 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:06.256+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 97ms Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 98ms Mar 29 19:20:06 volumio volumio[1073]: info: ------------------------------ 97ms Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:08 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:08 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces system playlist update Mar 29 19:20:08 volumio volumio[1073]: info: Ignoring MPD Status Update Mar 29 19:20:08 volumio volumio[1073]: info: Mar 29 19:20:08 volumio volumio[1073]: ---------------------------- MPD announces state update: player Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::getState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 14ms Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand status took 12 milliseconds Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 11ms Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand status took 9 milliseconds Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 9ms Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand status took 6 milliseconds Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseState Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:20:08 volumio volumio[1073]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:20:08 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:08 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:08 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:08 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:08 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:08 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:08 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:08 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:08 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio[1073]: info: ControllerMpd::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::servicePushState Mar 29 19:20:08 volumio volumio[1073]: info: CorePlayQueue::getTrack 0 Mar 29 19:20:08 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47384,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"SUPERTRAMP - GOODBYE STRANGER","artist":"Absolut Oldie Classics","album":null,"uri":"https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn","trackType":""} Mar 29 19:20:08 volumio volumio[1073]: verbose: CURRENT POSITION 0 Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play Mar 29 19:20:08 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreStateMachine::pushState Mar 29 19:20:08 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.496+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.497+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.504+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.505+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.506+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.507+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.510+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.512+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.513+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.515+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.515+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" state=STATUS_PLAYING positionMs=46530 volume=76 Mar 29 19:20:08 volumio volumio5-onboarding[1226]: time=2026-03-29T19:20:08.516+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.178.53:50040,192.168.178.53:50042,00:00:00:00:00:00%01 @ 0x1d28db0" id="https://absolut-oldieclassics.live-sm.absolutradio.de/absolut-oldieclassics/stream/mp3?aggregator=TuneIn" title="SUPERTRAMP - GOODBYE STRANGER" Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 197ms Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 195ms Mar 29 19:20:08 volumio volumio[1073]: info: ------------------------------ 193ms Mar 29 19:20:17 volumio kernel: hwmon hwmon1: Voltage normalised Mar 29 19:20:23 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 29 19:20:25 volumio volumio[1073]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Mar 29 19:20:25 volumio volumio[1073]: info: PLUGIN onReboot : networkfs Mar 29 19:20:25 volumio volumio[1073]: info: PLUGIN onReboot : audiophonicsonoff Mar 29 19:20:25 volumio volumio[1073]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 19:20:25 volumio volumio[1073]: TypeError: Cannot read property 'writeSync' of undefined Mar 29 19:20:25 volumio volumio[1073]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Mar 29 19:20:25 volumio volumio[1073]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Mar 29 19:20:25 volumio volumio[1073]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Mar 29 19:20:25 volumio volumio[1073]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 29 19:20:25 volumio volumio[1073]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 29 19:20:25 volumio volumio[1073]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Mar 29 19:20:25 volumio volumio[1073]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Mar 29 19:20:25 volumio volumio[1073]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:870:33) Mar 29 19:20:25 volumio volumio[1073]: at Socket.emit (events.js:315:20) Mar 29 19:20:25 volumio volumio[1073]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 29 19:20:25 volumio volumio[1073]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 29 19:20:25 volumio volumio[1073]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 19:20:26 volumio sudo[6677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-29 19:19 Mar 29 19:20:26 volumio sudo[6677]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"