-- Logs begin at Tue 2026-06-02 00:18:07 +03, end at Tue 2026-06-02 00:50:42 +03. -- Jun 02 00:49:00 primo volumio[3357]: info: Preload queue cleared Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::ClearQueue Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::stop Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::stPlaybackTimer Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::updateTrackBlock Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::getTrackBlock Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::getTrack 3 Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::getTrack 3 Jun 02 00:49:00 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:00 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::serviceStop Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::getTrack 3 Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::serviceStop Jun 02 00:49:00 primo volumio[3357]: info: [1780350540972] ControllerQobuz::stop Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 02 00:49:00 primo volumio[3357]: info: ControllerMpd::stop Jun 02 00:49:00 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::clearPlayQueue Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::saveQueue Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioPushQueue Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::addQueueItems Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::addQueueItems Jun 02 00:49:00 primo volumio[3357]: info: Preload queue cleared Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383780 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383780 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383781 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383781 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383782 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383782 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383783 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383783 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383784 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383784 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383785 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383785 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383786 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383786 Jun 02 00:49:00 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:00.980+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_STOPPED positionMs=0 volume=75 Jun 02 00:49:00 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:00.980+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/188156031 title="Générique début" Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioPushQueue Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::saveQueue Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::updateTrackBlock Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::getTrackBlock Jun 02 00:49:00 primo volumio[3357]: info: CoreCommandRouter::volumioPlay Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::play index 6 Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 00:49:00 primo volumio[3357]: info: CoreStateMachine::addQueueItems Jun 02 00:49:00 primo volumio[3357]: info: CorePlayQueue::addQueueItems Jun 02 00:49:00 primo volumio[3357]: info: Preload queue cleared Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383787 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383787 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383788 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383788 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383789 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383789 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383790 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383790 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383791 Jun 02 00:49:00 primo volumio[3357]: info: Using cached record of: qobuz://song/63383791 Jun 02 00:49:00 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383792 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383792 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383793 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383793 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383794 Jun 02 00:49:01 primo kernel: asoc-aml-card auge_sound: tdm playback stop Jun 02 00:49:01 primo kernel: spdif_a is set to disable Jun 02 00:49:01 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Jun 02 00:49:01 primo kernel: aml_dai_tdm_hw_free(), disable mclk for TDM-B Jun 02 00:49:01 primo kernel: tdm playback mute: 1, lane_cnt = 8 Jun 02 00:49:01 primo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:tdm@1 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383794 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383795 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383795 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383796 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383796 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383797 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383797 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383798 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383798 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383799 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383799 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383800 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383800 Jun 02 00:49:01 primo volumio[3357]: info: Adding Item to queue: qobuz://song/63383801 Jun 02 00:49:01 primo volumio[3357]: info: Using cached record of: qobuz://song/63383801 Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::stop Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::volumioPushQueue Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::saveQueue Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::play index undefined Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::updateTrackBlock Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrackBlock Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::startPlaybackTimer Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: [1780350541030] ControllerQobuz::clearAddPlayTrack Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 00:49:01 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand stop took 98 milliseconds Jun 02 00:49:01 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand stop took 21 milliseconds Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:01 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:01 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:01 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand status took 20 milliseconds Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand clear took 20 milliseconds Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand status took 18 milliseconds Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand status took 17 milliseconds Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/63383786" Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:01 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:01 primo volumio[3357]: STREAMING PROXY: Handling url /?data=qobuz://song/63383786 Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:01 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jun 02 00:49:01 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:01 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:01 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:01 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:01 primo volumio[3357]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received mpd Jun 02 00:49:01 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:01.130+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_STOPPED positionMs=23 volume=75 Jun 02 00:49:01 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:01.131+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:01 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:01.131+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_STOPPED positionMs=23 volume=75 Jun 02 00:49:01 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:01.132+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:01 primo volumio[3357]: info: ------------------------------ 64ms Jun 02 00:49:01 primo volumio[3357]: info: ------------------------------ 63ms Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:01 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:01 primo volumio[3357]: info: Jun 02 00:49:01 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:01 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:01 primo volumio[3357]: error: updateQueue error: null Jun 02 00:49:01 primo volumio[3357]: info: ------------------------------ 56ms Jun 02 00:49:01 primo volumio[3357]: info: sendMpdCommand playlistinfo took 54 milliseconds Jun 02 00:49:01 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:01 primo volumio[3357]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 00:49:01 primo volumio[3357]: info: ------------------------------ 79ms Jun 02 00:49:01 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:01 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:01 primo volumio[3357]: info: MCU Signalled Playback Inactive Jun 02 00:49:01 primo volumio[3357]: info: Executing endpoint getStreamUrlqobuz Jun 02 00:49:01 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jun 02 00:49:01 primo volumio[3357]: info: getStreamUrl took 401 milliseconds Jun 02 00:49:01 primo volumio[3357]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=11451729&eid=63383786&fmt=6&profile=raw&app_id=539451548&cid=4089136&etsp=1780354141&hmac=ZP5tFEcPz1Gw1D4Uc0rTSy-yYz8 Jun 02 00:49:01 primo volumio[3357]: STREAMING PROXY: Requesting upstream with range: none Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Upstream status code: 200 Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Client closed connection Jun 02 00:49:02 primo volumio[3357]: error: updateQueue error: null Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Upstream closed. Received 16384 bytes Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Incomplete transfer. Expected 17562443, got 16384 Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Retrying with range: bytes=16384- (attempt 1) Jun 02 00:49:02 primo volumio[3357]: error: updateQueue error: null Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/63383786" Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 986ms Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 984ms Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:02 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/63383786" took 3 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand play Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:02 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces system playlist update Jun 02 00:49:02 primo volumio[3357]: info: Ignoring MPD Status Update Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Handling url /?data=qobuz://song/63383786 Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 6ms Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand play took 5 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 5ms Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 3ms Jun 02 00:49:02 primo volumio[3357]: info: Executing endpoint getStreamUrlqobuz Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jun 02 00:49:02 primo volumio[3357]: info: getStreamUrl took 395 milliseconds Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=11451729&eid=63383786&fmt=6&profile=raw&app_id=539451548&cid=4089136&etsp=1780354142&hmac=8dC-ZOneyT6Dx7p3rM5HHjY4htI Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Requesting upstream with range: none Jun 02 00:49:02 primo volumio[3357]: STREAMING PROXY: Upstream status code: 200 Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo kernel: aml_tdm_open Jun 02 00:49:02 primo kernel: Not init audio effects Jun 02 00:49:02 primo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:tdm@1 Jun 02 00:49:02 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Jun 02 00:49:02 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Jun 02 00:49:02 primo kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Jun 02 00:49:02 primo kernel: asoc aml_dai_set_tdm_fmt, 0x4001, ffffffc03d02b418, id(1), clksel(1) Jun 02 00:49:02 primo kernel: aml_dai_set_tdm_fmt(), fmt not change Jun 02 00:49:02 primo kernel: dump_pcm_setting(ffffffc03d02b418) Jun 02 00:49:02 primo kernel: pcm_mode(1) Jun 02 00:49:02 primo kernel: sysclk(11289600) Jun 02 00:49:02 primo kernel: sysclk_bclk_ratio(4) Jun 02 00:49:02 primo kernel: bclk(2822400) Jun 02 00:49:02 primo kernel: bclk_lrclk_ratio(64) Jun 02 00:49:02 primo kernel: lrclk(44100) Jun 02 00:49:02 primo kernel: tx_mask(0x3) Jun 02 00:49:02 primo kernel: rx_mask(0x3) Jun 02 00:49:02 primo kernel: slots(2) Jun 02 00:49:02 primo kernel: slot_width(32) Jun 02 00:49:02 primo kernel: lane_mask_in(0x2) Jun 02 00:49:02 primo kernel: lane_mask_out(0x1) Jun 02 00:49:02 primo kernel: lane_oe_mask_in(0x0) Jun 02 00:49:02 primo kernel: lane_oe_mask_out(0x0) Jun 02 00:49:02 primo kernel: lane_lb_mask_in(0x0) Jun 02 00:49:02 primo kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Jun 02 00:49:02 primo kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Jun 02 00:49:02 primo kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Jun 02 00:49:02 primo kernel: aml_dai_set_clkdiv, div 4, clksel(1) Jun 02 00:49:02 primo kernel: aml_dai_set_bclk_ratio, select I2S mode Jun 02 00:49:02 primo kernel: aml_dai_tdm_hw_params(), enable mclk for TDM-B Jun 02 00:49:02 primo kernel: aml_tdm_prepare(), reset fddr Jun 02 00:49:02 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Jun 02 00:49:02 primo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Jun 02 00:49:02 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Jun 02 00:49:02 primo kernel: tdm playback mute: 0, lane_cnt = 8 Jun 02 00:49:02 primo kernel: aml_tdm_prepare(), reset fddr Jun 02 00:49:02 primo kernel: spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 Jun 02 00:49:02 primo kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0 Jun 02 00:49:02 primo kernel: audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 Jun 02 00:49:02 primo kernel: tdm playback mute: 0, lane_cnt = 8 Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 6 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 4 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 4 milliseconds Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: Jun 02 00:49:02 primo volumio[3357]: ---------------------------- MPD announces state update: player Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::getState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand status Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 8 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 5 milliseconds Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand status took 3 milliseconds Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseState Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus stop Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus play Jun 02 00:49:02 primo volumio[3357]: info: Received an update from plugin. extracting info from payload Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus play Jun 02 00:49:02 primo volumio[3357]: info: Received an update from plugin. extracting info from payload Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 49ms Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.663+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.663+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.663+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.664+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.664+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.664+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.665+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.665+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 69ms Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 68ms Jun 02 00:49:02 primo volumio[3357]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:02 primo volumio[3357]: verbose: ControllerMpd::parseTrackInfo Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus play Jun 02 00:49:02 primo volumio[3357]: info: Received an update from plugin. extracting info from payload Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus play Jun 02 00:49:02 primo volumio[3357]: info: Received an update from plugin. extracting info from payload Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: ControllerMpd::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::servicePushState Jun 02 00:49:02 primo volumio[3357]: info: CorePlayQueue::getTrack 6 Jun 02 00:49:02 primo volumio[3357]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"63383786","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/63383786","trackType":"qobuz"} Jun 02 00:49:02 primo volumio[3357]: verbose: CURRENT POSITION 6 Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState stateService play Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::syncState currentStatus play Jun 02 00:49:02 primo volumio[3357]: info: Received an update from plugin. extracting info from payload Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:02 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:02 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.750+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.751+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.752+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.753+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.754+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.754+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.755+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.755+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.756+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.756+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.757+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=0 volume=75 Jun 02 00:49:02 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:02.758+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:02 primo kernel: asoc-aml-card auge_sound: tdm playback enable Jun 02 00:49:02 primo kernel: spdif_a is set to enable Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 169ms Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 165ms Jun 02 00:49:02 primo volumio[3357]: info: ------------------------------ 165ms Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:02 primo volumio[3357]: info: MCU Signalled Playback Active Jun 02 00:49:03 primo volumio[3357]: STREAMING PROXY: Resuming with range: bytes=16384- Jun 02 00:49:03 primo volumio[3357]: STREAMING PROXY: Resume upstream status code: 206 Jun 02 00:49:03 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:49:03 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:49:03 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:49:03 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:49:03 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:49:03 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:49:04 primo volumio[3357]: STREAMING PROXY: Resume ended. Received 17546059 bytes Jun 02 00:49:06 primo volumio[3357]: STREAMING PROXY: Upstream closed. Received 17562443 bytes Jun 02 00:49:06 primo volumio[3357]: STREAMING PROXY: Client closed connection Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume Jun 02 00:49:08 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:08 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:08 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:08 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:08.523+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=5849 volume=76 Jun 02 00:49:08 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:08.523+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:08 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:08 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:08 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:08 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:08 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:08 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:08 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:08.612+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=5849 volume=76 Jun 02 00:49:08 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:08.612+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:08 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:08 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: inputs , alsavolume Jun 02 00:49:09 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:09 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:09 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:09 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:09.603+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=6849 volume=77 Jun 02 00:49:09 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:09.604+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:09 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:09 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:49:09 primo volumio[3357]: info: CoreStateMachine::pushState Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::volumioPushState Jun 02 00:49:09 primo volumio[3357]: info: CoreCommandRouter::volumioGetState Jun 02 00:49:09 primo volumio[3357]: info: MRS: Pushing multiroomSync output update for this device Jun 02 00:49:09 primo volumio[3357]: info: MRS: Pushing multiroomSync output Jun 02 00:49:09 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:09.686+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" state=STATUS_PLAYING positionMs=7099 volume=77 Jun 02 00:49:09 primo volumio5-onboarding[3931]: time=2026-06-02T00:49:09.687+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.223:56988 @ 0x2cca570" id=qobuz://song/63383786 title="Water Works" Jun 02 00:49:09 primo volumio[3357]: info: Signalling Playback active due to playback status change Jun 02 00:49:09 primo volumio[3357]: info: Updating RAAT Signal Path Jun 02 00:50:07 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:07 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:07 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:07 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:14 primo volumio[3357]: error: Failed request for metavolumio API Jun 02 00:50:17 primo volumio[3357]: Searching plugin music_service/qobuz Jun 02 00:50:17 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 02 00:50:18 primo volumio[3357]: info: searchQOBUZUri took 1124 milliseconds Jun 02 00:50:18 primo volumio[3357]: info: All search sources collected, pushing search results Jun 02 00:50:19 primo volumio[3357]: Searching plugin music_service/qobuz Jun 02 00:50:19 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 02 00:50:20 primo volumio[3357]: info: searchQOBUZUri took 1230 milliseconds Jun 02 00:50:20 primo volumio[3357]: info: All search sources collected, pushing search results Jun 02 00:50:24 primo volumio[3357]: Searching plugin music_service/qobuz Jun 02 00:50:24 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 02 00:50:25 primo volumio[3357]: info: searchQOBUZUri took 1058 milliseconds Jun 02 00:50:25 primo volumio[3357]: info: All search sources collected, pushing search results Jun 02 00:50:28 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jun 02 00:50:29 primo volumio[3357]: info: handleBrowseUri took 1135 milliseconds Jun 02 00:50:29 primo volumio[3357]: info: Preload queue cleared Jun 02 00:50:29 primo volumio[3357]: info: Executing endpoint getSimilarArtists Jun 02 00:50:29 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 02 00:50:29 primo volumio[3357]: info: Executing endpoint getSimilarArtists Jun 02 00:50:29 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jun 02 00:50:29 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:29 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:29 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:29 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:36 primo volumio[3357]: error: Failed request for metavolumio API Jun 02 00:50:37 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jun 02 00:50:37 primo volumio[3357]: error: Failed request for metavolumio API Jun 02 00:50:38 primo volumio[3357]: info: handleBrowseUri took 611 milliseconds Jun 02 00:50:38 primo volumio[3357]: info: Preload queue cleared Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249898 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249899 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249900 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249901 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249902 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249903 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249904 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249905 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249906 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249907 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249908 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249909 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249910 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249911 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249912 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249913 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249914 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249915 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249916 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249917 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249918 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249919 Jun 02 00:50:38 primo volumio[3357]: info: Preloading song: qobuz://song/7249920 Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249898 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249899 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Executing endpoint getSimilarAlbums Jun 02 00:50:38 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jun 02 00:50:38 primo volumio[3357]: info: Executing endpoint getSimilarAlbums Jun 02 00:50:38 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249900 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249901 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:38 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:38 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:38 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249902 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249903 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249904 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249905 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:38 primo volumio[3357]: info: Exploding uri qobuz://song/7249906 in service qobuz Jun 02 00:50:38 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249907 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 460 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249908 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249909 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 486 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 440 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249910 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 584 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249911 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 472 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249912 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249913 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 500 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 485 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249914 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 436 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 489 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249915 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 458 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249916 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 437 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249917 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 447 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249918 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249919 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 452 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 432 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: Exploding uri qobuz://song/7249920 in service qobuz Jun 02 00:50:39 primo volumio[3357]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 429 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 443 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 489 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 457 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 422 milliseconds Jun 02 00:50:39 primo volumio[3357]: info: explodeUri took 423 milliseconds Jun 02 00:50:40 primo volumio[3357]: info: explodeUri took 470 milliseconds Jun 02 00:50:40 primo volumio[3357]: info: explodeUri took 457 milliseconds Jun 02 00:50:40 primo volumio[3357]: info: explodeUri took 430 milliseconds Jun 02 00:50:41 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:41 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:41 primo volumio[3357]: info: Executing endpoint metavolumio Jun 02 00:50:41 primo volumio[3357]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 00:50:41 primo volumio[3357]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 00:50:41 primo volumio[3357]: TypeError: Cannot read property 'slice' of null Jun 02 00:50:41 primo volumio[3357]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jun 02 00:50:41 primo volumio[3357]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jun 02 00:50:41 primo volumio[3357]: at Object.onceWrapper (events.js:520:26) Jun 02 00:50:41 primo volumio[3357]: at ClientRequest.emit (events.js:400:28) Jun 02 00:50:41 primo volumio[3357]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Jun 02 00:50:41 primo volumio[3357]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Jun 02 00:50:41 primo volumio[3357]: at TLSSocket.socketOnData (_http_client.js:515:22) Jun 02 00:50:41 primo volumio[3357]: at TLSSocket.emit (events.js:400:28) Jun 02 00:50:41 primo volumio[3357]: at addChunk (internal/streams/readable.js:293:12) Jun 02 00:50:41 primo volumio[3357]: at readableAddChunk (internal/streams/readable.js:267:9) Jun 02 00:50:41 primo volumio[3357]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Jun 02 00:50:41 primo volumio[3357]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Jun 02 00:50:41 primo volumio[3357]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 00:50:42 primo sudo[9655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 00:49 Jun 02 00:50:42 primo sudo[9655]: 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"