-- Logs begin at Sat 2026-03-28 12:51:42 CET, end at Sat 2026-03-28 13:22:27 CET. --
Mar 28 13:21:00 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:00 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:01 primo kernel: hdmitx: system: plugout
Mar 28 13:21:01 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:01 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:01 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:01 primo kernel: hdmitx: system: plugout
Mar 28 13:21:01 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:01 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:01 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:01 primo kernel: hdmitx: system: plugout
Mar 28 13:21:01 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:03 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 28 13:21:03 primo volumio[3190]: info: CURURI: music-library/USB/SanDisk/Basstest
Mar 28 13:21:03 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:03 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:03 primo kernel: hdmitx: system: plugout
Mar 28 13:21:03 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:03 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:04 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:04 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:04 primo kernel: hdmitx: system: plugout
Mar 28 13:21:04 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:04 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:04 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:04 primo kernel: hdmitx: system: plugout
Mar 28 13:21:04 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:06 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:06 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:06 primo kernel: hdmitx: system: plugout
Mar 28 13:21:06 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:07 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::ClearQueue
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::serviceStop
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::serviceStop
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::stop
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::clearPlayQueue
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::addQueueItems
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::addQueueItems
Mar 28 13:21:07 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Christine and the Queens - _Full of Life_ - Passengers - ARTE Concert.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Christine and the Queens - _Full of Life_ - Passengers - ARTE Concert.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Cosmo Sheldrake - The Fly.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Cosmo Sheldrake - The Fly.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.691+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.691+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.692+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Klassik Test/Vivaldi_ The Four Seasons (Orquesta Reino de Aragón).flac" title="Vivaldi_ The Four Seasons (Orquesta Reino de Aragón).flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.692+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Klassik Test/Vivaldi_ The Four Seasons (Orquesta Reino de Aragón).flac" title="Vivaldi_ The Four Seasons (Orquesta Reino de Aragón).flac"
Mar 28 13:21:07 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:07 primo kernel: asoc-aml-card auge_sound: tdm playback stop
Mar 28 13:21:07 primo kernel: spdif_a is set to disable
Mar 28 13:21:07 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:07 primo kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B
Mar 28 13:21:07 primo kernel: tdm playback mute: 1, lane_cnt = 8
Mar 28 13:21:07 primo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPlay
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::play index 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::addQueueItems
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::addQueueItems
Mar 28 13:21:07 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Dub in a Time of Cholera.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Dub in a Time of Cholera.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Francis Poulenc - Concerto for Organ, Timpani and Strings in G minor.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Francis Poulenc - Concerto for Organ, Timpani and Strings in G minor.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/James Blake - Limit To Your Love.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/James Blake - Limit To Your Love.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Little Simz - I Love You, I Hate You (Official Video).flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Little Simz - I Love You, I Hate You (Official Video).flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Marais maison.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Marais maison.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/MEUTE - Sail (Awolnation Rework).flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/MEUTE - Sail (Awolnation Rework).flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Victoria Monét - On My Mama (Official Video).flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Victoria Monét - On My Mama (Official Video).flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Weiße Wand - AnnenMayKantereit.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Weiße Wand - AnnenMayKantereit.flac
Mar 28 13:21:07 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/What Will We Do When We Have No Money - Lankum - Vinyl HQ Audio.flac
Mar 28 13:21:07 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/What Will We Do When We Have No Money - Lankum - Vinyl HQ Audio.flac
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::play index undefined
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::startPlaybackTimer
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::clearAddPlayTracks USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 13:21:07 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand stop took 61 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand stop took 17 milliseconds
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 8 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand clear took 7 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 6 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 4 milliseconds
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand add "USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: 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 28 13:21:07 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState stateService stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: No code
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: 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 28 13:21:07 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState stateService stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:07 primo volumio[3190]: info: No code
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo kernel: hdmitx: system: plugout
Mar 28 13:21:07 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.808+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.809+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.809+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.809+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.810+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.810+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.810+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.809+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.811+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.811+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.812+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.812+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.813+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.813+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.813+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.813+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.813+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.814+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.814+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=1 volume=70
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.816+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:07.817+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 76ms
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 76ms
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo volumio[3190]: error: updateQueue error: null
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 86ms
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand playlistinfo took 83 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand add "USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" took 84 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 13ms
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 12ms
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 13:21:07 primo volumio[3190]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 99ms
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:07 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:07 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:07 primo kernel: aml_tdm_open
Mar 28 13:21:07 primo kernel: Not init audio effects
Mar 28 13:21:07 primo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1
Mar 28 13:21:07 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk
Mar 28 13:21:07 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk
Mar 28 13:21:07 primo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987
Mar 28 13:21:07 primo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0501fb618, id(1), clksel(1)
Mar 28 13:21:07 primo kernel: aml_dai_set_tdm_fmt(), fmt not change
Mar 28 13:21:07 primo kernel: dump_pcm_setting(ffffffc0501fb618)
Mar 28 13:21:07 primo kernel: pcm_mode(1)
Mar 28 13:21:07 primo kernel: sysclk(12288000)
Mar 28 13:21:07 primo kernel: sysclk_bclk_ratio(4)
Mar 28 13:21:07 primo kernel: bclk(3072000)
Mar 28 13:21:07 primo kernel: bclk_lrclk_ratio(64)
Mar 28 13:21:07 primo kernel: lrclk(48000)
Mar 28 13:21:07 primo kernel: tx_mask(0x3)
Mar 28 13:21:07 primo kernel: rx_mask(0x3)
Mar 28 13:21:07 primo kernel: slots(2)
Mar 28 13:21:07 primo kernel: slot_width(32)
Mar 28 13:21:07 primo kernel: lane_mask_in(0x2)
Mar 28 13:21:07 primo kernel: lane_mask_out(0x1)
Mar 28 13:21:07 primo kernel: lane_oe_mask_in(0x0)
Mar 28 13:21:07 primo kernel: lane_oe_mask_out(0x0)
Mar 28 13:21:07 primo kernel: lane_lb_mask_in(0x0)
Mar 28 13:21:07 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk
Mar 28 13:21:07 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk
Mar 28 13:21:07 primo kernel: set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987
Mar 28 13:21:07 primo kernel: aml_dai_set_clkdiv, div 4, clksel(1)
Mar 28 13:21:07 primo kernel: aml_dai_set_bclk_ratio, select I2S mode
Mar 28 13:21:07 primo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B
Mar 28 13:21:07 primo kernel: aml_tdm_prepare(), reset fddr
Mar 28 13:21:07 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10
Mar 28 13:21:07 primo kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200
Mar 28 13:21:07 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:07 primo kernel: tdm playback mute: 0, lane_cnt = 8
Mar 28 13:21:07 primo kernel: aml_tdm_prepare(), reset fddr
Mar 28 13:21:07 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10
Mar 28 13:21:07 primo kernel: spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200
Mar 28 13:21:07 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:07 primo kernel: tdm playback mute: 0, lane_cnt = 8
Mar 28 13:21:07 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 53ms
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand play took 49 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 47ms
Mar 28 13:21:07 primo volumio[3190]: info: ------------------------------ 46ms
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 15 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 13 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 11 milliseconds
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info:
Mar 28 13:21:07 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 15 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand playlistinfo took 13 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand playlistinfo took 12 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 9 milliseconds
Mar 28 13:21:07 primo volumio[3190]: info: sendMpdCommand status took 8 milliseconds
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:07 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:07 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:07 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:07 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:07 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:07 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:07 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:07 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:07 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:07 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 115ms
Mar 28 13:21:08 primo kernel: asoc-aml-card auge_sound: tdm playback enable
Mar 28 13:21:08 primo kernel: spdif_a is set to enable
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.060+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.060+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.061+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.061+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.062+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.062+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.062+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.063+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.064+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.067+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.068+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.069+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.069+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.069+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=0 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.070+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.070+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 193ms
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 191ms
Mar 28 13:21:08 primo volumio[3190]: info: sendMpdCommand playlistinfo took 184 milliseconds
Mar 28 13:21:08 primo volumio[3190]: info: sendMpdCommand playlistinfo took 182 milliseconds
Mar 28 13:21:08 primo volumio[3190]: info: sendMpdCommand playlistinfo took 182 milliseconds
Mar 28 13:21:08 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:08 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:08 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:08 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1219,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:08 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:08 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1219,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:08 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:08 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1219,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"720 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:08 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:08 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:08 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:08 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:08 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.210+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.210+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.211+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.211+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.212+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.213+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.213+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.214+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.215+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.215+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo kernel: hdmitx: system: plugin
Mar 28 13:21:08 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.215+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.216+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.216+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.217+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.217+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.218+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1219 volume=70
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 327ms
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 319ms
Mar 28 13:21:08 primo volumio[3190]: info: ------------------------------ 317ms
Mar 28 13:21:08 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.219+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:08.219+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:08 primo volumio[3190]: info: MCU Signalled Playback Inactive
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:08 primo volumio[3190]: info: MCU Signalled Playback Active
Mar 28 13:21:08 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:21:08 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:21:08 primo kernel: hdmitx: edid: set default vic
Mar 28 13:21:08 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:21:08 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:21:08 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:08 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:21:08 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:21:08 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:08 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:21:08 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:21:08 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:21:08 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:21:08 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:21:08 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:21:08 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:21:08 primo kernel: hdmitx: config HPLL done
Mar 28 13:21:08 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:21:08 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:21:08 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:21:08 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:08 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:08 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:08 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:21:08 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:08 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:21:08 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:08 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:08 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:08 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:08 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:08 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:08 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:08 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:08 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:08 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:08 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:08 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:09 primo kernel: hdmitx: system: plugin
Mar 28 13:21:09 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:09 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:09 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:21:09 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:21:09 primo kernel: hdmitx: edid: set default vic
Mar 28 13:21:09 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:21:09 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:21:09 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:09 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:21:09 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:21:09 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:09 primo kernel: hdmitx: system: [set_disp_mode_auto] ALREADY init VIC = 16
Mar 28 13:21:09 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:09 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:09 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:09 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:09 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:09 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:12 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:12 primo kernel: hdmitx: system: plugout
Mar 28 13:21:12 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:13 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:13 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:13 primo kernel: hdmitx: system: plugout
Mar 28 13:21:13 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:14 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:14 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:14 primo kernel: hdmitx: system: plugout
Mar 28 13:21:14 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume
Mar 28 13:21:14 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:14 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:14 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:14 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:14 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:14 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.644+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=7727 volume=65
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.644+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=7727 volume=65
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.645+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.645+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:14 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:14 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:14 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:14 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:14 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:14 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:14 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:14 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.677+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=7727 volume=65
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.678+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=7727 volume=65
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.678+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:14 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:14.679+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:14 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:14 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:14 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:14 primo kernel: hdmitx: system: plugout
Mar 28 13:21:14 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume
Mar 28 13:21:15 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.286+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=8227 volume=55
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.287+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=8227 volume=55
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.287+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.287+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:15 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:15 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.321+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=8227 volume=55
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.321+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=8227 volume=55
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.322+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.322+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:15 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:15 primo kernel: hdmitx: system: plugout
Mar 28 13:21:15 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:15 primo kernel: hdmitx: system: plugout
Mar 28 13:21:15 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume
Mar 28 13:21:15 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.558+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=8477 volume=50
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.558+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=8477 volume=50
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.559+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.559+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:15 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:15 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:15 primo kernel: hdmitx: system: plugout
Mar 28 13:21:15 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:15 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:15 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:15 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:15 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.664+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=8728 volume=50
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.664+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=8728 volume=50
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.665+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:15.665+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:15 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:15 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:15 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:15 primo kernel: hdmitx: system: plugout
Mar 28 13:21:15 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:16 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:16 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:16 primo kernel: hdmitx: system: plugout
Mar 28 13:21:16 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:17 primo kernel: hdmitx: system: irq 80000002 0
Mar 28 13:21:17 primo kernel: hdmitx: system: plugin
Mar 28 13:21:17 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:21:17 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:21:17 primo kernel: hdmitx: edid: set default vic
Mar 28 13:21:17 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:21:17 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:21:17 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:17 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:21:17 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:21:17 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:17 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:21:17 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:21:17 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:21:17 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:21:17 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:21:17 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:21:17 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:21:17 primo kernel: hdmitx: config HPLL done
Mar 28 13:21:17 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:21:17 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:21:17 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:21:17 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:17 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:18 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:21:18 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:21:18 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:18 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:18 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:18 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:18 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:18 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:18 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:18 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:18 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:18 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:18 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:18 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:20 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:20 primo kernel: hdmitx: system: plugout
Mar 28 13:21:20 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:21 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:21 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:21 primo kernel: hdmitx: system: plugout
Mar 28 13:21:21 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:22 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:22 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:22 primo kernel: hdmitx: system: plugout
Mar 28 13:21:22 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:22 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:23 primo kernel: hdmitx: system: plugin
Mar 28 13:21:23 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:23 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:21:23 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:21:23 primo kernel: hdmitx: edid: set default vic
Mar 28 13:21:23 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:21:23 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:21:23 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:23 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:21:23 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:21:23 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:23 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:21:23 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:21:23 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:21:23 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:21:23 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:21:23 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:21:23 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:21:23 primo kernel: hdmitx: config HPLL done
Mar 28 13:21:23 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:21:23 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:21:23 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:21:23 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:23 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:23 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:21:23 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:21:23 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:23 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:23 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:23 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:23 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:23 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:23 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:23 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:23 primo kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 148352
Mar 28 13:21:23 primo kernel: hdmitx: hw: aud_n_para = 5824
Mar 28 13:21:23 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:23 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:28 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:28 primo kernel: hdmitx: system: plugout
Mar 28 13:21:28 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioPause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::servicePause
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::servicePause
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::pause
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand pause
Mar 28 13:21:29 primo kernel: asoc-aml-card auge_sound: tdm playback stop
Mar 28 13:21:29 primo kernel: spdif_a is set to disable
Mar 28 13:21:29 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:29 primo kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B
Mar 28 13:21:29 primo kernel: tdm playback mute: 1, lane_cnt = 8
Mar 28 13:21:29 primo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1
Mar 28 13:21:29 primo volumio[3190]: info:
Mar 28 13:21:29 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand pause took 3 milliseconds
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:29 primo volumio[3190]: info:
Mar 28 13:21:29 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:29 primo volumio[3190]: info:
Mar 28 13:21:29 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand status took 5 milliseconds
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand status took 3 milliseconds
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand status took 3 milliseconds
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 28 13:21:29 primo volumio[3190]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:29 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22849,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"994 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:29 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState stateService pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22849,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"994 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:29 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState stateService pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:29 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22849,"duration":369,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"994 Kbps","isStreaming":false,"title":"Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac","trackType":"flac"}
Mar 28 13:21:29 primo volumio[3190]: verbose: CURRENT POSITION 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState stateService pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus pause
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:29 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:29 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:29 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:29 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.434+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.435+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.435+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.435+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.437+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.437+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.437+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo volumio[3190]: info: ------------------------------ 52ms
Mar 28 13:21:29 primo volumio[3190]: info: ------------------------------ 51ms
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.438+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.439+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.439+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PAUSED positionMs=33034 volume=50
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.440+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:29.441+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:29 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:29 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:29 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:29 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:29 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:29 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:29 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:29 primo volumio[3190]: info: MCU Signalled Playback Inactive
Mar 28 13:21:29 primo kernel: hdmitx: system: plugout
Mar 28 13:21:29 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:30 primo volumio[3190]: verbose: New Socket.io Connection to 192.168.7.144 from 192.168.7.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:148.0) Gecko/20100101 Firefox/148.0 Engine version: 3 Transport: polling Total Clients: 9
Mar 28 13:21:31 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:31 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:31 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 13:21:31 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 28 13:21:31 primo volumio[3190]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 28 13:21:31 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 13:21:31 primo volumio[3190]: info: Listing playlists
Mar 28 13:21:31 primo volumio[3190]: info: CoreCommandRouter::volumioGetQueue
Mar 28 13:21:31 primo volumio[3190]: info: CoreStateMachine::getQueue
Mar 28 13:21:31 primo volumio[3190]: info: CorePlayQueue::getQueue
Mar 28 13:21:33 primo ntpd[3411]: 78.46.87.46 local addr 192.168.7.144 ->
Mar 28 13:21:34 primo ntpd[3411]: 77.42.16.222 local addr 192.168.7.144 ->
Mar 28 13:21:49 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 28 13:21:49 primo volumio[3190]: info: CURURI: music-library/USB/SanDisk/Basstest
Mar 28 13:21:49 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:51 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioReplaceandPlayItems
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::ClearQueue
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::stPlaybackTimer
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::serviceStop
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 3
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::serviceStop
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::stop
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::clearPlayQueue
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::addQueueItems
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::addQueueItems
Mar 28 13:21:51 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Christine and the Queens - _Full of Life_ - Passengers - ARTE Concert.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Christine and the Queens - _Full of Life_ - Passengers - ARTE Concert.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Cosmo Sheldrake - The Fly.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Cosmo Sheldrake - The Fly.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.341+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.342+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.342+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.342+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac" title="Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac"
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPlay
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::play index 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::addQueueItems
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::addQueueItems
Mar 28 13:21:51 primo volumio[3190]: info: Preload queue cleared
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Douala, Olivier Cahours guitare, Bertrand Renaudin composition et batterie..flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Dub in a Time of Cholera.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Dub in a Time of Cholera.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Francis Poulenc - Concerto for Organ, Timpani and Strings in G minor.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Francis Poulenc - Concerto for Organ, Timpani and Strings in G minor.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/James Blake - Limit To Your Love.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/James Blake - Limit To Your Love.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Little Simz - I Love You, I Hate You (Official Video).flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Little Simz - I Love You, I Hate You (Official Video).flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Marais maison.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Marais maison.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/MEUTE - Sail (Awolnation Rework).flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/MEUTE - Sail (Awolnation Rework).flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Victoria Monét - On My Mama (Official Video).flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Victoria Monét - On My Mama (Official Video).flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/Weiße Wand - AnnenMayKantereit.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/Weiße Wand - AnnenMayKantereit.flac
Mar 28 13:21:51 primo volumio[3190]: info: Adding Item to queue: music-library/USB/SanDisk/Basstest/What Will We Do When We Have No Money - Lankum - Vinyl HQ Audio.flac
Mar 28 13:21:51 primo volumio[3190]: info: Using cached record of: music-library/USB/SanDisk/Basstest/What Will We Do When We Have No Money - Lankum - Vinyl HQ Audio.flac
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushQueue
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::saveQueue
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::play index undefined
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::setConsumeUpdateService undefined
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::updateTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrackBlock
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::startPlaybackTimer
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::clearAddPlayTracks USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand stop
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand stop took 51 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand stop took 13 milliseconds
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand clear
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 12 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand clear took 12 milliseconds
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand add "USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo volumio[3190]: error: updateQueue error: null
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 26 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 25 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 20ms
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand playlistinfo took 17 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand add "USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" took 18 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 16ms
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand play
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: 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 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: No code
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: 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 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: No code
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Mar 28 13:21:51 primo kernel: aml_tdm_open
Mar 28 13:21:51 primo kernel: Not init audio effects
Mar 28 13:21:51 primo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1
Mar 28 13:21:51 primo kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186
Mar 28 13:21:51 primo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc0501fb618, id(1), clksel(1)
Mar 28 13:21:51 primo kernel: aml_dai_set_tdm_fmt(), fmt not change
Mar 28 13:21:51 primo kernel: dump_pcm_setting(ffffffc0501fb618)
Mar 28 13:21:51 primo kernel: pcm_mode(1)
Mar 28 13:21:51 primo kernel: sysclk(11289600)
Mar 28 13:21:51 primo kernel: sysclk_bclk_ratio(4)
Mar 28 13:21:51 primo kernel: bclk(2822400)
Mar 28 13:21:51 primo kernel: bclk_lrclk_ratio(64)
Mar 28 13:21:51 primo kernel: lrclk(44100)
Mar 28 13:21:51 primo kernel: tx_mask(0x3)
Mar 28 13:21:51 primo kernel: rx_mask(0x3)
Mar 28 13:21:51 primo kernel: slots(2)
Mar 28 13:21:51 primo kernel: slot_width(32)
Mar 28 13:21:51 primo kernel: lane_mask_in(0x2)
Mar 28 13:21:51 primo kernel: lane_mask_out(0x1)
Mar 28 13:21:51 primo kernel: lane_oe_mask_in(0x0)
Mar 28 13:21:51 primo kernel: lane_oe_mask_out(0x0)
Mar 28 13:21:51 primo kernel: lane_lb_mask_in(0x0)
Mar 28 13:21:51 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk
Mar 28 13:21:51 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk
Mar 28 13:21:51 primo kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186
Mar 28 13:21:51 primo kernel: aml_dai_set_clkdiv, div 4, clksel(1)
Mar 28 13:21:51 primo kernel: aml_dai_set_bclk_ratio, select I2S mode
Mar 28 13:21:51 primo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B
Mar 28 13:21:51 primo kernel: aml_tdm_prepare(), reset fddr
Mar 28 13:21:51 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10
Mar 28 13:21:51 primo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
Mar 28 13:21:51 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:51 primo kernel: tdm playback mute: 0, lane_cnt = 8
Mar 28 13:21:51 primo kernel: aml_tdm_prepare(), reset fddr
Mar 28 13:21:51 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10
Mar 28 13:21:51 primo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
Mar 28 13:21:51 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3
Mar 28 13:21:51 primo kernel: tdm playback mute: 0, lane_cnt = 8
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.510+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.510+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.511+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.511+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.511+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.511+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.511+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.512+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.513+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.514+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.514+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.514+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.518+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.518+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.519+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.519+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.523+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.524+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.524+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.525+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.532+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.533+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_STOPPED positionMs=0 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.533+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.534+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 153ms
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 152ms
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 169ms
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 179ms
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 176ms
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand play took 169 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces system playlist update
Mar 28 13:21:51 primo volumio[3190]: info: Ignoring MPD Status Update
Mar 28 13:21:51 primo kernel: asoc-aml-card auge_sound: tdm playback enable
Mar 28 13:21:51 primo kernel: spdif_a is set to enable
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 134ms
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 134 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 134ms
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:51 primo volumio[3190]: info:
Mar 28 13:21:51 primo volumio[3190]: ---------------------------- MPD announces state update: player
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::getState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand status
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 47 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 42 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand playlistinfo took 37 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand status took 7 milliseconds
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseState
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1349,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"478 Kbps","isStreaming":false,"title":"Dominique Fils-Aimé _ Birds.flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac","trackType":"flac"}
Mar 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus stop
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 192ms
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand playlistinfo took 11 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand playlistinfo took 10 milliseconds
Mar 28 13:21:51 primo volumio[3190]: info: sendMpdCommand playlistinfo took 8 milliseconds
Mar 28 13:21:51 primo volumio[3190]: verbose: ControllerMpd::parseTrackInfo
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"399 Kbps","isStreaming":false,"title":"Dominique Fils-Aimé _ Birds.flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac","trackType":"flac"}
Mar 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:51 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"399 Kbps","isStreaming":false,"title":"Dominique Fils-Aimé _ Birds.flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac","trackType":"flac"}
Mar 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:51 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: ControllerMpd::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::servicePushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1715,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"372 Kbps","isStreaming":false,"title":"Dominique Fils-Aimé _ Birds.flac","artist":null,"album":null,"uri":"USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac","trackType":"flac"}
Mar 28 13:21:51 primo volumio[3190]: verbose: CURRENT POSITION 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState stateService play
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::syncState currentStatus play
Mar 28 13:21:51 primo volumio[3190]: info: Received an update from plugin. extracting info from payload
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo volumio[3190]: info: CoreStateMachine::pushState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioPushState
Mar 28 13:21:51 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:21:51 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output update for this device
Mar 28 13:21:51 primo volumio[3190]: info: MRS: Pushing multiroomSync output
Mar 28 13:21:51 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:51 primo kernel: hdmitx: system: plugout
Mar 28 13:21:51 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.857+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.857+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.858+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.858+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.858+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.858+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.859+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.859+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.860+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.861+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1715 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.862+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1715 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.862+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.863+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.863+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1715 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.864+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.864+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.865+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1601 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.865+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.865+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.865+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.864+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" state=STATUS_PLAYING positionMs=1715 volume=50
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.866+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.131:42312 @ 0x189dad0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio5-onboarding[4400]: time=2026-03-28T13:21:51.866+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.7.138:46888 @ 0x1ade0c0" id="mnt/USB/SanDisk/Basstest/Dominique Fils-Aimé _ Birds.flac" title="Dominique Fils-Aimé _ Birds.flac"
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 157ms
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 156ms
Mar 28 13:21:51 primo volumio[3190]: info: ------------------------------ 116ms
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Signalling Playback active due to playback status change
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo kernel: hdmitx: system: plugin
Mar 28 13:21:51 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:51 primo volumio[3190]: info: Updating RAAT Signal Path
Mar 28 13:21:51 primo volumio[3190]: info: MCU Signalled Playback Active
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:52 primo kernel: hdmitx: system: irq 80000004 0
Mar 28 13:21:52 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:21:52 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:21:52 primo kernel: hdmitx: edid: set default vic
Mar 28 13:21:52 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:21:52 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:21:52 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:52 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:21:52 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:21:52 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:52 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:21:52 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:21:52 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:21:52 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:21:52 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:21:52 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:21:52 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:21:52 primo kernel: hdmitx: config HPLL done
Mar 28 13:21:52 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:21:52 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:21:52 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:21:52 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:21:52 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:21:52 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:21:52 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:21:52 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:52 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:52 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:21:52 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:21:52 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:52 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:52 primo kernel: hdmitx: hw: set audio
Mar 28 13:21:52 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:21:52 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:21:52 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:21:52 primo kernel: hdmitx: hw: set channel status
Mar 28 13:21:52 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:21:52 primo kernel: hdmitx: system: plugout
Mar 28 13:21:52 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:53 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:53 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:53 primo kernel: hdmitx: system: plugout
Mar 28 13:21:53 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:55 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:55 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:55 primo kernel: hdmitx: system: plugout
Mar 28 13:21:55 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:21:58 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:21:58 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:21:58 primo kernel: hdmitx: system: plugout
Mar 28 13:21:58 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:02 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:02 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:02 primo kernel: hdmitx: system: plugout
Mar 28 13:22:02 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:02 primo volumio[3190]: verbose: New Socket.io Connection to 192.168.7.144 from 192.168.7.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:148.0) Gecko/20100101 Firefox/148.0 Engine version: 3 Transport: polling Total Clients: 9
Mar 28 13:22:03 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:22:03 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:22:03 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 13:22:03 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 28 13:22:03 primo volumio[3190]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 28 13:22:03 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 13:22:03 primo volumio[3190]: info: Listing playlists
Mar 28 13:22:03 primo volumio[3190]: info: CoreCommandRouter::volumioGetQueue
Mar 28 13:22:03 primo volumio[3190]: info: CoreStateMachine::getQueue
Mar 28 13:22:03 primo volumio[3190]: info: CorePlayQueue::getQueue
Mar 28 13:22:04 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:04 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:04 primo kernel: hdmitx: system: plugout
Mar 28 13:22:04 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:08 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:08 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:08 primo kernel: hdmitx: system: plugout
Mar 28 13:22:08 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:09 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:09 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:09 primo kernel: hdmitx: system: plugout
Mar 28 13:22:09 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:10 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:10 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:10 primo kernel: hdmitx: system: plugout
Mar 28 13:22:10 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:13 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:13 primo kernel: hdmitx: system: plugin
Mar 28 13:22:13 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:13 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:14 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:22:14 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:22:14 primo kernel: hdmitx: edid: set default vic
Mar 28 13:22:14 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:22:14 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:22:14 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:14 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:22:14 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:22:14 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:14 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:22:14 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:22:14 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:22:14 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:22:14 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:22:14 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:22:14 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:22:14 primo kernel: hdmitx: config HPLL done
Mar 28 13:22:14 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:22:14 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:22:14 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:22:14 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:14 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:14 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:22:14 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:22:14 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:14 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:14 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:14 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:14 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:14 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:14 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:14 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:14 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:14 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:14 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:14 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:15 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:15 primo kernel: hdmitx: system: plugout
Mar 28 13:22:15 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:16 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:16 primo kernel: hdmitx: system: plugin
Mar 28 13:22:16 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:17 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:22:17 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:22:17 primo kernel: hdmitx: edid: set default vic
Mar 28 13:22:17 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:22:17 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:22:17 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:17 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:22:17 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:22:17 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:17 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:22:17 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:22:17 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:22:17 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:22:17 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:22:17 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:22:17 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:22:17 primo kernel: hdmitx: config HPLL done
Mar 28 13:22:17 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:22:17 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:22:17 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:22:17 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:17 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:17 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:22:17 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:22:17 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:17 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:17 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:17 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:17 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:17 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:17 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:17 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:17 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:17 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:17 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:17 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:17 primo volumio5-onboarding[4400]: time=2026-03-28T13:22:17.260+01:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.7.138:46888 @ 0x1ade0c0" latency=22.658919ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE
Mar 28 13:22:18 primo sudo[14543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 28 13:22:18 primo sudo[14543]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 28 13:22:18 primo sudo[14543]: pam_unix(sudo:session): session closed for user root
Mar 28 13:22:18 primo sudo[14546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 28 13:22:18 primo sudo[14546]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 28 13:22:18 primo sudo[14546]: pam_unix(sudo:session): session closed for user root
Mar 28 13:22:18 primo volumio[3190]: verbose: New Socket.io Connection to 192.168.7.144 from 192.168.7.138 UA: Mozilla/5.0 (Linux; Android 11; Nokia 7.2 Build/RKQ1.210607.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 13:22:18 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:22:18 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 28 13:22:18 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 28 13:22:19 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:19 primo kernel: hdmitx: system: plugout
Mar 28 13:22:19 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:19 primo sudo[14553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 28 13:22:19 primo sudo[14553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 28 13:22:19 primo sudo[14553]: pam_unix(sudo:session): session closed for user root
Mar 28 13:22:19 primo sudo[14556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 28 13:22:19 primo sudo[14556]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 28 13:22:19 primo sudo[14556]: pam_unix(sudo:session): session closed for user root
Mar 28 13:22:19 primo volumio[3190]: verbose: New Socket.io Connection to 192.168.7.144 from 192.168.7.138 UA: Mozilla/5.0 (Linux; Android 11; Nokia 7.2 Build/RKQ1.210607.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Mar 28 13:22:19 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:22:19 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 13:22:19 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 28 13:22:19 primo volumio[3190]: info: Listing playlists
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 28 13:22:19 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 28 13:22:19 primo kernel: hdmitx: system: plugin
Mar 28 13:22:19 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:20 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:22:20 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:22:20 primo kernel: hdmitx: edid: set default vic
Mar 28 13:22:20 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:22:20 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:22:20 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:20 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:22:20 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:22:20 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:20 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:22:20 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:22:20 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:22:20 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:22:20 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:22:20 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:22:20 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:22:20 primo kernel: hdmitx: config HPLL done
Mar 28 13:22:20 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:22:20 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:22:20 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:22:20 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:20 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:20 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:22:20 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:22:20 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:20 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:20 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:20 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:20 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:20 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:20 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:20 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:20 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:20 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:20 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:20 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:23 primo volumio[3190]: verbose: New Socket.io Connection to 192.168.7.144 from 192.168.7.138 UA: Mozilla/5.0 (Linux; Android 11; Nokia 7.2 Build/RKQ1.210607.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Mar 28 13:22:23 primo volumio[3190]: info: CoreCommandRouter::volumioGetState
Mar 28 13:22:23 primo volumio[3190]: info: CorePlayQueue::getTrack 2
Mar 28 13:22:23 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 28 13:22:23 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 28 13:22:23 primo volumio[3190]: info: Listing playlists
Mar 28 13:22:23 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:23 primo kernel: hdmitx: system: plugout
Mar 28 13:22:23 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:24 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:24 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:24 primo kernel: hdmitx: system: plugout
Mar 28 13:22:24 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:25 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:25 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:25 primo kernel: hdmitx: system: plugout
Mar 28 13:22:25 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:26 primo kernel: hdmitx: system: plugout
Mar 28 13:22:26 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 4 0
Mar 28 13:22:26 primo kernel: hdmitx: system: plugout
Mar 28 13:22:26 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 2 0
Mar 28 13:22:26 primo kernel: hdmitx: system: plugin
Mar 28 13:22:26 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000105]: 0x00000001
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000170]: 0x00000004
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:27 primo kernel: hdmitx: edid: EDID Parser:
Mar 28 13:22:27 primo kernel: hdmitx: edid: EDID BlockCount=0
Mar 28 13:22:27 primo kernel: hdmitx: edid: set default vic
Mar 28 13:22:27 primo kernel: hdmitx: edid: edid blk0 checksum:0 ext_flag:0
Mar 28 13:22:27 primo kernel: hdmitx: edid: raw data are all zeroes
Mar 28 13:22:27 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:27 primo kernel: hdmitx: system: get current mode: 1080p60hz
Mar 28 13:22:27 primo kernel: hdmitx: system: update rx hdr info 0
Mar 28 13:22:27 primo kernel: hdmitx: system: update physcial size: 16 9
Mar 28 13:22:27 primo kernel: hdmitx: video: already init VIC = 0 Now VIC = 16
Mar 28 13:22:27 primo kernel: hdmitx: video: rx edid only support RGB format
Mar 28 13:22:27 primo kernel: hdmitx: hw: div40: 0
Mar 28 13:22:27 primo volumio[3190]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Mar 28 13:22:27 primo volumio[3190]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Mar 28 13:22:27 primo kernel: hdmitx: ddc w1b error 0x54 0x20 0x00
Mar 28 13:22:27 primo kernel: hdmitx: frac_rate = 1
Mar 28 13:22:27 primo kernel: hdmitx: config HPLL = 5940000 frac_rate = 1
Mar 28 13:22:27 primo kernel: hdmitx: HPLLv1: 0xdb3a04f7
Mar 28 13:22:27 primo kernel: hdmitx: config HPLL done
Mar 28 13:22:27 primo kernel: hdmitx: set_hpll_od3_clk_div[610] div = 6
Mar 28 13:22:27 primo kernel: hdmitx: j = 4 vid_clk_div = 1
Mar 28 13:22:27 primo kernel: hdmitx: set enc for VIC: 16
Mar 28 13:22:27 primo kernel: hdmitx: system: irq 80000001 0
Mar 28 13:22:27 primo volumio[3190]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 28 13:22:27 primo volumio[3190]: TypeError: Cannot read property 'then' of undefined
Mar 28 13:22:27 primo volumio[3190]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Mar 28 13:22:27 primo volumio[3190]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30)
Mar 28 13:22:27 primo volumio[3190]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26)
Mar 28 13:22:27 primo volumio[3190]: at Socket.emit (events.js:400:28)
Mar 28 13:22:27 primo volumio[3190]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Mar 28 13:22:27 primo volumio[3190]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Mar 28 13:22:27 primo volumio[3190]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000104]: 0x00000001
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000180]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000181]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000182]: 0x00000003
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000183]: 0x00000007
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000184]: 0x0000003f
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000185]: 0x00000002
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000187]: 0x000000ff
Mar 28 13:22:27 primo kernel: hdmitx: [0x10000188]: 0x00000003
Mar 28 13:22:27 primo kernel: hdmitx: hw: config hdmitx IP vic = 16 cd:4 cs: 0
Mar 28 13:22:27 primo kernel: hdmitx: video: Sink is HDMI device
Mar 28 13:22:27 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:27 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:27 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:27 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:27 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:27 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:27 primo kernel: hdmitx: hw: set audio
Mar 28 13:22:27 primo kernel: hdmitx: hw: hdmitx tx_aud_src = 0
Mar 28 13:22:27 primo kernel: hdmitx: fs = 2, cd = 4, tmds_clk = 148352
Mar 28 13:22:27 primo kernel: hdmitx: hw: aud_n_para = 8918
Mar 28 13:22:27 primo kernel: hdmitx: hw: set channel status
Mar 28 13:22:27 primo kernel: hdmitx: audio: Audio Type: PCM
Mar 28 13:22:27 primo sudo[14646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 13:21
Mar 28 13:22:27 primo sudo[14646]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="primo2rev2"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 12:16:07 PM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Primo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Primo"
VOLUMIO_HASH="88686576587e39571d6cf25f3920fbc0"