[ 5616.109314] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 3 dir 1 cmd 0 [ 5616.109322] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 3 [ 5616.109330] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.119830] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5616.119856] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.120229] kernel: soundwire_bus:sdw_bus_wait_for_clk_prep_deprep: soundwire sdw-master-1: clock stop prep/de-prep done slave:15 [ 5616.131009] kernel: snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: open stream 4 dir 1 [ 5616.131013] kernel: snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period min 192 max 16384 bytes [ 5616.131016] kernel: snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period count 2 max 16 [ 5616.131018] kernel: snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: buffer max 65536 bytes [ 5616.131069] kernel: snd_sof:sof_pcm_hw_free: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: free stream 3 dir 1 [ 5616.131077] kernel: snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x80]=0x20140000 successful [ 5616.131085] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 2 [ 5616.131089] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000002|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.131610] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5616.131621] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000002|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.131644] kernel: snd_sof:sof_ipc4_route_free: sof-audio-pci-intel-mtl 0000:00:1f.3: unbind modules alh-copier.SDW2-Capture.0:0 -> host-copier.3.capture:0 [ 5616.131649] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x46000004|0x10004: MOD_UNBIND [ 5616.132027] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x66000000|0x10004: MOD_UNBIND [ 5616.132042] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x46000004|0x10004: MOD_UNBIND [ 5616.132049] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 5616.132513] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 5616.132523] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 5616.132529] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.31 freed [ 5616.132532] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget alh-copier.SDW2-Capture.0 freed [ 5616.132537] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 5616.132945] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 5616.132958] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 5616.132963] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.30 freed [ 5616.132965] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget host-copier.3.capture freed [ 5616.135207] kernel: snd_sof:sof_pcm_close: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: close stream 3 dir 1 [ 5616.135257] kernel: snd_sof:sof_ipc4_pcm_dai_link_fixup: sof-audio-pci-intel-mtl 0000:00:1f.3: Set SDW1-Capture to 32 bit format [ 5616.135717] kernel: snd_sof:sof_pcm_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: hw params stream 4 dir 1 [ 5616.135727] kernel: snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x40000 successful [ 5616.135746] kernel: snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x40000 successful [ 5616.135753] kernel: snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: period_bytes:0x4000 [ 5616.135756] kernel: snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: periods:4 [ 5616.135781] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0, type 28 [ 5616.135786] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: Init input audio formats for alh-copier.SDW1-Capture.0 [ 5616.135790] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5616.135797] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0: reference output rate 48000, channels 2 valid_bits 32 [ 5616.135801] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: Output audio format for alh-copier.SDW1-Capture.0 [ 5616.135805] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5616.135817] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0, IPC size is 216 [ 5616.135822] kernel: sof-audio-pci-intel-mtl 0000:00:1f.3: COPIER (UUID: 9BA00C83-CA12-4A83-943C-1FA2E82F9DDA): No CPC value available in the firmware file's manifest (ibs/obs: 384/384) [ 5616.135827] kernel: snd_sof:sof_ipc4_update_resource_usage: sof-audio-pci-intel-mtl 0000:00:1f.3: alh-copier.SDW1-Capture.0: ibs / obs / cpc: 384 / 384 / 0 [ 5616.135849] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture, type 24 [ 5616.135856] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: matched audio format index for 48000Hz, 32bit, 2 channels: 1 [ 5616.135862] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: Init input audio formats for host-copier.4.capture [ 5616.135865] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5616.135870] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture: reference output rate 48000, channels 2 valid_bits 16 [ 5616.135875] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: Output audio format for host-copier.4.capture [ 5616.135879] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 16bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x1002) buffer size 192 [ 5616.135883] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture, IPC size is 84 [ 5616.135888] kernel: sof-audio-pci-intel-mtl 0000:00:1f.3: COPIER (UUID: 9BA00C83-CA12-4A83-943C-1FA2E82F9DDA): No CPC value available in the firmware file's manifest (ibs/obs: 384/192) [ 5616.135893] kernel: snd_sof:sof_ipc4_update_resource_usage: sof-audio-pci-intel-mtl 0000:00:1f.3: host-copier.4.capture: ibs / obs / cpc: 384 / 192 / 0 [ 5616.135897] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: pipeline: 41 memory pages: 2 [ 5616.135902] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget pipeline.41 instance 0 - pipe 41 - core 0 [ 5616.135908] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11000002|0x0: GLB_CREATE_PIPELINE [ 5616.136246] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x0: GLB_CREATE_PIPELINE [ 5616.136258] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11000002|0x0: GLB_CREATE_PIPELINE [ 5616.136265] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.41 setup complete [ 5616.136269] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget alh-copier.SDW1-Capture.0 instance 0 - pipe 41 - core 0 [ 5616.136274] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000004|0x36: MOD_INIT_INSTANCE [data size: 216] [ 5616.136679] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x36: MOD_INIT_INSTANCE [ 5616.136691] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000004|0x36: MOD_INIT_INSTANCE [data size: 216] [ 5616.136696] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget alh-copier.SDW1-Capture.0 setup complete [ 5616.136700] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: pipeline: 40 memory pages: 2 [ 5616.136704] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget pipeline.40 instance 1 - pipe 40 - core 0 [ 5616.136708] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11010002|0x0: GLB_CREATE_PIPELINE [ 5616.137083] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x0: GLB_CREATE_PIPELINE [ 5616.137094] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11010002|0x0: GLB_CREATE_PIPELINE [ 5616.137099] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.40 setup complete [ 5616.137103] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget host-copier.4.capture instance 1 - pipe 40 - core 0 [ 5616.137108] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40010004|0x10015: MOD_INIT_INSTANCE [data size: 84] [ 5616.138246] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x10015: MOD_INIT_INSTANCE [ 5616.138258] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40010004|0x10015: MOD_INIT_INSTANCE [data size: 84] [ 5616.138264] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget host-copier.4.capture setup complete [ 5616.138268] kernel: snd_sof:sof_ipc4_route_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: bind alh-copier.SDW1-Capture.0:0 -> host-copier.4.capture:0 [ 5616.138273] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000004|0x10004: MOD_BIND [ 5616.138579] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x10004: MOD_BIND [ 5616.138591] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000004|0x10004: MOD_BIND [ 5616.140129] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 4 dir 1 cmd 1 [ 5616.140135] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 1 state: 4 [ 5616.140141] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.141497] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5616.141510] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.141516] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000004|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.152200] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5616.152212] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000004|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5616.152734] kernel: snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x2024001e successful [ 5618.585256] kernel: PM: suspend entry (s2idle) [ 5618.590938] kernel: Filesystems sync: 0.005 seconds [ 5618.598967] kernel: Freezing user space processes [ 5618.600929] kernel: Freezing user space processes completed (elapsed 0.001 seconds) [ 5618.600936] kernel: OOM killer disabled. [ 5618.600937] kernel: Freezing remaining freezable tasks [ 5618.602350] kernel: Freezing remaining freezable tasks completed (elapsed 0.001 seconds) [ 5618.602354] kernel: printk: Suspending console(s) (use no_console_suspend to debug) [ 5618.628259] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 4 dir 1 cmd 5 [ 5618.628267] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 5 state: 3 [ 5618.628276] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5618.638729] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5618.638744] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5618.639568] kernel: soundwire_intel:intel_link_power_down: soundwire_intel soundwire_intel.link.1: powering down all links [ 5618.639587] kernel: soundwire_intel:intel_suspend: soundwire_intel soundwire_intel.link.0: pm_runtime status: suspended [ 5618.639880] kernel: asix 3-5.1:1.0 enx000ec63abe21: Link is Down [ 5618.641842] kernel: snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x20240000 successful [ 5618.641849] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 2 [ 5618.641854] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000002|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5618.642332] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5618.642418] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000002|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5618.642448] kernel: snd_sof:sof_ipc4_route_free: sof-audio-pci-intel-mtl 0000:00:1f.3: unbind modules alh-copier.SDW1-Capture.0:0 -> host-copier.4.capture:0 [ 5618.642452] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x46000004|0x10004: MOD_UNBIND [ 5618.643663] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x66000000|0x10004: MOD_UNBIND [ 5618.643778] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x46000004|0x10004: MOD_UNBIND [ 5618.643792] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 5618.644163] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 5618.644258] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 5618.644265] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.41 freed [ 5618.644268] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget alh-copier.SDW1-Capture.0 freed [ 5618.644274] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 5618.644663] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 5618.644745] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 5618.644752] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.40 freed [ 5618.644754] kernel: snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget host-copier.4.capture freed [ 5618.644764] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x44000000|0x3060004c: MOD_LARGE_CONFIG_SET [data size: 76] [ 5618.645106] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x3060004c: MOD_LARGE_CONFIG_SET [ 5618.645117] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x44000000|0x3060004c: MOD_LARGE_CONFIG_SET [data size: 76] [ 5618.645122] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x47000000|0x0: MOD_SET_DX [data size: 8] [ 5618.730475] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x67000000|0x0: MOD_SET_DX [ 5618.730555] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x47000000|0x0: MOD_SET_DX [data size: 8] [ 5618.730569] kernel: snd_sof_intel_hda_common:mtl_enable_sdw_irq: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x114c]=0x0 successful [ 5618.730579] kernel: snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1800]=0x0 successful [ 5618.730586] kernel: snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1140]=0x0 successful [ 5618.731703] kernel: snd_sof_intel_hda_common:mtl_dsp_core_power_down: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x178d04]=0x2000000 successful [ 5618.732737] kernel: snd_sof_intel_hda_common:mtl_power_down_dsp: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1000]=0x0 successful [ 5618.732783] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000044 [ 5618.732788] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIW: 00000010 at 00000044 [ 5618.733820] kernel: snd_sof_intel_hda_common:hda_dsp_state_log: sof-audio-pci-intel-mtl 0000:00:1f.3: Current DSP power state: D3 [ 5618.733824] kernel: snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 7 -> 0 [ 5618.804723] kernel: ACPI: EC: interrupt blocked [ 5624.130426] kernel: ACPI: EC: interrupt unblocked [ 5624.163766] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000044 [ 5624.163781] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000048 [ 5624.167060] kernel: snd_sof_intel_hda:hda_codec_detect_mask: sof-audio-pci-intel-mtl 0000:00:1f.3: codec_mask = 0x0 [ 5624.167092] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000048 [ 5624.167097] kernel: snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIW: 00000040 at 00000048 [ 5624.167105] kernel: snd_sof_intel_hda_common:hda_dsp_state_log: sof-audio-pci-intel-mtl 0000:00:1f.3: Current DSP power state: D0I0 [ 5624.167109] kernel: snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 0 -> 2 [ 5624.167112] kernel: snd_sof:snd_sof_load_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: loading firmware [ 5624.167114] kernel: snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 2 -> 3 [ 5624.168150] kernel: snd_sof_intel_hda_common:mtl_dsp_pre_fw_run: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1000]=0x1010000 successful [ 5624.169179] kernel: snd_sof_intel_hda_common:mtl_dsp_pre_fw_run: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1d1c]=0x8151 successful [ 5624.169187] kernel: snd_sof:snd_sof_run_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: booting DSP firmware [ 5624.169192] kernel: snd_sof_intel_hda_common:hda_dsp_cl_boot_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: IMR restore supported, booting from IMR directly [ 5624.170225] kernel: snd_sof_intel_hda_common:mtl_dsp_core_power_up: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x178d04]=0x2000101 successful [ 5624.170230] kernel: snd_sof_intel_hda_common:mtl_dsp_cl_init: sof-audio-pci-intel-mtl 0000:00:1f.3: Primary core power up successful [ 5624.170237] kernel: snd_sof_intel_hda_common:mtl_dsp_cl_init: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x73214]=0x80000000 successful [ 5624.170246] kernel: snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1800]=0x41 successful [ 5624.170253] kernel: snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1140]=0x1 successful [ 5624.178304] kernel: nvme nvme0: Shutdown timeout set to 10 seconds [ 5624.184927] kernel: nvme nvme0: 22/0/0 default/read/poll queues [ 5624.274918] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc rx : 0x1b080000|0x0: GLB_NOTIFICATION|FW_READY [ 5624.274929] kernel: snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 3 -> 6 [ 5624.274939] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc rx done : 0x1b080000|0x0: GLB_NOTIFICATION|FW_READY [ 5624.275043] kernel: snd_sof:snd_sof_run_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: firmware boot complete [ 5624.275052] kernel: snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 6 -> 7 [ 5624.275067] kernel: snd_sof_intel_hda_common:mtl_enable_sdw_irq: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x114c]=0xf successful [ 5624.275079] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x44000000|0x31400008: MOD_LARGE_CONFIG_SET [data size: 8] [ 5624.275390] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x31400008: MOD_LARGE_CONFIG_SET [ 5624.275411] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x44000000|0x31400008: MOD_LARGE_CONFIG_SET [data size: 8] [ 5624.275419] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x44000000|0x3060004c: MOD_LARGE_CONFIG_SET [data size: 76] [ 5624.275736] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x3060004c: MOD_LARGE_CONFIG_SET [ 5624.275758] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x44000000|0x3060004c: MOD_LARGE_CONFIG_SET [data size: 76] [ 5624.275874] kernel: soundwire_intel:intel_link_power_up: soundwire_intel soundwire_intel.link.0: powering up all links [ 5624.275881] kernel: soundwire_intel:intel_link_power_up: soundwire_intel soundwire_intel.link.0: first link up, programming SYNCPRD [ 5624.276197] kernel: soundwire_bus:sdw_modify_slave_status: rt711-sdca sdw:0:025d:0711:01: initializing enumeration and init completion for Slave 7 [ 5624.277642] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.0: Slave status change: 0x2 [ 5624.277684] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-0: Slave attached, programming device number [ 5624.277886] kernel: soundwire_bus:sdw_modify_slave_status: rt715-sdca sdw:1:025d:0714:01: initializing enumeration and init completion for Slave 6 [ 5624.277954] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-0: SDW Slave Addr: 30025d071101 [ 5624.277959] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-0: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x0711, unique_id 0x0, version 0x3 [ 5624.277963] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-0: Slave already registered, reusing dev_num:7 [ 5624.278192] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.0: Msg ignored for Slave 0 [ 5624.278194] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-0: No more devices to enumerate [ 5624.278235] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.0: Slave status change: 0x20000001 [ 5624.278259] kernel: soundwire_bus:sdw_modify_slave_status: rt711-sdca sdw:0:025d:0711:01: signaling enumeration completion for Slave 7 [ 5624.278436] kernel: soundwire_bus:sdw_slave_set_frequency: rt711-sdca sdw:0:025d:0711:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5624.279574] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.1: Slave status change: 0x2 [ 5624.279606] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-1: Slave attached, programming device number [ 5624.279777] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-1: SDW Slave Addr: 30025d071401 [ 5624.279779] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-1: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x0714, unique_id 0x0, version 0x3 [ 5624.279782] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-1: Slave already registered, reusing dev_num:6 [ 5624.280025] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.1: Msg ignored for Slave 0 [ 5624.280027] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-1: No more devices to enumerate [ 5624.280070] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.1: Slave status change: 0x2000001 [ 5624.280121] kernel: soundwire_bus:sdw_modify_slave_status: rt715-sdca sdw:1:025d:0714:01: signaling enumeration completion for Slave 6 [ 5624.280649] kernel: soundwire_bus:sdw_slave_set_frequency: rt715-sdca sdw:1:025d:0714:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5624.281539] kernel: soundwire_bus:sdw_handle_slave_status: rt715-sdca sdw:1:025d:0714:01: signaling initialization completion for Slave 6 [ 5624.291100] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5624.292573] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Slave status change: 0x2 [ 5624.292612] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5624.292771] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5624.292773] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5624.292775] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5624.293000] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5624.293002] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5624.293045] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Slave status change: 0x21 [ 5624.293067] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5624.293250] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5624.301956] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5624.301958] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5624.308279] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:3:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5624.309814] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.3: Slave status change: 0x2 [ 5624.309845] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-3: Slave attached, programming device number [ 5624.310021] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-3: SDW Slave Addr: 32025d131601 [ 5624.310023] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-3: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x2, version 0x3 [ 5624.310025] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-3: Slave already registered, reusing dev_num:1 [ 5624.310255] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.3: Msg ignored for Slave 0 [ 5624.310257] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-3: No more devices to enumerate [ 5624.310292] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.3: Slave status change: 0x21 [ 5624.310314] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:3:025d:1316:01: signaling enumeration completion for Slave 1 [ 5624.310500] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:3:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5624.319168] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:3:025d:1316:01: rt1316_io_init hw_init complete [ 5624.319170] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:3:025d:1316:01: signaling initialization completion for Slave 1 [ 5624.470164] kernel: snd_soc_rt711_sdca:rt711_sdca_calibration: rt711-sdca sdw:0:025d:0711:01: rt711_sdca_calibration calibration complete, ret=0 [ 5624.475169] kernel: snd_soc_rt711_sdca:rt711_sdca_jack_init: rt711-sdca sdw:0:025d:0711:01: in rt711_sdca_jack_init enable [ 5624.475174] kernel: snd_soc_rt711_sdca:rt711_sdca_io_init: rt711-sdca sdw:0:025d:0711:01: rt711_sdca_io_init hw_init complete [ 5624.475177] kernel: soundwire_bus:sdw_handle_slave_status: rt711-sdca sdw:0:025d:0711:01: signaling initialization completion for Slave 7 [ 5624.655893] kernel: asix 3-5.1:1.0 enx000ec63abe21: configuring for phy/internal link mode [ 5624.662054] kernel: OOM killer enabled. [ 5624.662058] kernel: Restarting tasks ... done. [ 5624.665220] kernel: random: crng reseeded on system resumption [ 5624.666746] kernel: snd_sof:sof_pcm_prepare: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: prepare stream 4 dir 1 [ 5624.666755] kernel: snd_sof:sof_pcm_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: hw params stream 4 dir 1 [ 5624.666765] kernel: snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x40000 successful [ 5624.666783] kernel: snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x40000 successful [ 5624.666790] kernel: snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: period_bytes:0x4000 [ 5624.666795] kernel: snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: periods:4 [ 5624.666819] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0, type 28 [ 5624.666825] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: Init input audio formats for alh-copier.SDW1-Capture.0 [ 5624.666830] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5624.666839] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0: reference output rate 48000, channels 2 valid_bits 32 [ 5624.666846] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: Output audio format for alh-copier.SDW1-Capture.0 [ 5624.666850] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5624.666863] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier alh-copier.SDW1-Capture.0, IPC size is 216 [ 5624.666869] kernel: sof-audio-pci-intel-mtl 0000:00:1f.3: COPIER (UUID: 9BA00C83-CA12-4A83-943C-1FA2E82F9DDA): No CPC value available in the firmware file's manifest (ibs/obs: 384/384) [ 5624.666877] kernel: snd_sof:sof_ipc4_update_resource_usage: sof-audio-pci-intel-mtl 0000:00:1f.3: alh-copier.SDW1-Capture.0: ibs / obs / cpc: 384 / 384 / 0 [ 5624.666883] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture, type 24 [ 5624.666887] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: matched audio format index for 48000Hz, 32bit, 2 channels: 1 [ 5624.666892] kernel: snd_sof:sof_ipc4_init_input_audio_fmt: sof-audio-pci-intel-mtl 0000:00:1f.3: Init input audio formats for host-copier.4.capture [ 5624.666896] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 32bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x2002) buffer size 384 [ 5624.666901] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture: reference output rate 48000, channels 2 valid_bits 16 [ 5624.666906] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: Output audio format for host-copier.4.capture [ 5624.666908] kernel: snd_sof:sof_ipc4_dbg_audio_format: sof-audio-pci-intel-mtl 0000:00:1f.3: Pin index #0: 48000Hz, 16bit (ch_map 0xffffff10 ch_cfg 1 interleaving_style 0 fmt_cfg 0x1002) buffer size 192 [ 5624.666914] kernel: snd_sof:sof_ipc4_prepare_copier_module: sof-audio-pci-intel-mtl 0000:00:1f.3: copier host-copier.4.capture, IPC size is 84 [ 5624.666919] kernel: sof-audio-pci-intel-mtl 0000:00:1f.3: COPIER (UUID: 9BA00C83-CA12-4A83-943C-1FA2E82F9DDA): No CPC value available in the firmware file's manifest (ibs/obs: 384/192) [ 5624.666924] kernel: snd_sof:sof_ipc4_update_resource_usage: sof-audio-pci-intel-mtl 0000:00:1f.3: host-copier.4.capture: ibs / obs / cpc: 384 / 192 / 0 [ 5624.666930] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: pipeline: 41 memory pages: 2 [ 5624.666937] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget pipeline.41 instance 0 - pipe 41 - core 0 [ 5624.666945] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11000002|0x0: GLB_CREATE_PIPELINE [ 5624.667306] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x0: GLB_CREATE_PIPELINE [ 5624.667322] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11000002|0x0: GLB_CREATE_PIPELINE [ 5624.667331] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.41 setup complete [ 5624.667337] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget alh-copier.SDW1-Capture.0 instance 0 - pipe 41 - core 0 [ 5624.667345] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000004|0x36: MOD_INIT_INSTANCE [data size: 216] [ 5624.668475] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x36: MOD_INIT_INSTANCE [ 5624.668508] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000004|0x36: MOD_INIT_INSTANCE [data size: 216] [ 5624.668514] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget alh-copier.SDW1-Capture.0 setup complete [ 5624.668517] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: pipeline: 40 memory pages: 2 [ 5624.668520] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget pipeline.40 instance 1 - pipe 40 - core 0 [ 5624.668523] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11010002|0x0: GLB_CREATE_PIPELINE [ 5624.668889] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x0: GLB_CREATE_PIPELINE [ 5624.668926] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11010002|0x0: GLB_CREATE_PIPELINE [ 5624.668932] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.40 setup complete [ 5624.668936] kernel: snd_sof:sof_ipc4_widget_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: Create widget host-copier.4.capture instance 1 - pipe 40 - core 0 [ 5624.668941] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40010004|0x10015: MOD_INIT_INSTANCE [data size: 84] [ 5624.669300] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x10015: MOD_INIT_INSTANCE [ 5624.669314] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40010004|0x10015: MOD_INIT_INSTANCE [data size: 84] [ 5624.669320] kernel: snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget host-copier.4.capture setup complete [ 5624.669327] kernel: snd_sof:sof_ipc4_route_setup: sof-audio-pci-intel-mtl 0000:00:1f.3: bind alh-copier.SDW1-Capture.0:0 -> host-copier.4.capture:0 [ 5624.669333] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000004|0x10004: MOD_BIND [ 5624.670968] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x10004: MOD_BIND [ 5624.670984] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000004|0x10004: MOD_BIND [ 5624.671024] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 4 dir 1 cmd 1 [ 5624.671028] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 1 state: 4 [ 5624.671033] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5624.671383] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5624.671395] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5624.671401] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x13000004|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5624.678462] kernel: PM: suspend exit [ 5624.683701] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 5624.683714] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x13000004|0x1: GLB_SET_PIPELINE_STATE [data size: 12] [ 5624.684233] kernel: snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0xa0]=0x2024001e successful [ 5625.032025] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Slave status change: 0x10 [ 5625.032070] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5625.032076] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5625.032179] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Slave status change: 0x2 [ 5625.032219] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5625.032412] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5625.032416] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5625.032421] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5625.032657] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5625.032661] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5625.032720] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5625.032917] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5625.041646] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5625.041650] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5626.468124] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5626.468134] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5626.468441] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5626.468609] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5626.468613] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5626.468616] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5626.468859] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5626.468863] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5626.468941] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5626.469127] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5626.469190] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 1 [ 5626.469194] kernel: rt1316-sdca sdw:2:025d:1316:01: SDW_SCP_INT1 (BUS_CLASH) read failed:-61 [ 5626.469230] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 initialization failed: -61 [ 5626.469357] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5626.469384] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5626.469498] kernel: soundwire_cadence:cdns_program_scp_addr: soundwire_intel soundwire_intel.link.2: SCP_addrpage ignored for Slave 1 [ 5626.469501] kernel: soundwire sdw-master-2: trf on Slave 1 failed:-5 write addr c000 count 0 [ 5626.469604] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5626.469631] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5626.469659] kernel: soundwire_cadence:cdns_program_scp_addr: soundwire_intel soundwire_intel.link.2: SCP_addrpage ignored for Slave 1 [ 5626.469661] kernel: soundwire sdw-master-2: trf on Slave 1 failed:-5 write addr c710 count 0 [ 5626.469693] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5626.469697] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5626.469719] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Device0 detected after clearing status, iteration 1 [ 5626.469753] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5626.469756] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5626.469761] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5626.469924] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5626.469928] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5626.469932] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5626.470174] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5626.470178] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5626.470270] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5626.470457] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5626.479153] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5626.479158] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5626.733546] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5626.733559] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5626.733712] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5626.733891] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5626.733896] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5626.733901] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5626.734140] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5626.734145] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5626.734211] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5626.734403] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5626.743177] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5626.743184] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5626.747173] kernel: asix 3-5.1:1.0 enx000ec63abe21: Link is Up - 100Mbps/Full - flow control off [ 5627.471155] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5627.471168] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5627.471401] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5627.471578] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5627.471582] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5627.471588] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5627.471856] kernel: soundwire_cadence:cdns_fill_msg_resp: soundwire_intel soundwire_intel.link.2: Msg ignored for Slave 0 [ 5627.471861] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5627.471930] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5627.472005] kernel: rt1316-sdca sdw:2:025d:1316:01: SDW_SCP_BUS_CLOCK_BASE write failed:-61 [ 5627.472045] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 initialization failed: -61 [ 5627.472169] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5627.472199] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5627.472228] kernel: soundwire_cadence:cdns_program_scp_addr: soundwire_intel soundwire_intel.link.2: SCP_addrpage ignored for Slave 1 [ 5627.472232] kernel: soundwire sdw-master-2: trf on Slave 1 failed:-5 write addr c000 count 0 [ 5627.472355] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5627.472387] kernel: soundwire_intel soundwire_intel.link.2: Program SCP Ack not received [ 5627.472417] kernel: soundwire_cadence:cdns_program_scp_addr: soundwire_intel soundwire_intel.link.2: SCP_addrpage ignored for Slave 1 [ 5627.472420] kernel: soundwire sdw-master-2: trf on Slave 1 failed:-5 write addr c710 count 0 [ 5627.472457] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5627.472460] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5627.472469] kernel: soundwire_cadence:cdns_update_slave_status_work: soundwire_intel soundwire_intel.link.2: Device0 detected after clearing status, iteration 1 [ 5627.472504] kernel: rt1316-sdca sdw:2:025d:1316:01: Slave 1 state check1: UNATTACHED, status was 1 [ 5627.472507] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: initializing enumeration and init completion for Slave 1 [ 5627.472512] kernel: soundwire_bus:sdw_handle_slave_status: soundwire sdw-master-2: Slave attached, programming device number [ 5627.472691] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave Addr: 33025d131601 [ 5627.472694] kernel: soundwire_bus:sdw_extract_slave_id: soundwire sdw-master-2: SDW Slave class_id 0x01, mfg_id 0x025d, part_id 0x1316, unique_id 0x3, version 0x3 [ 5627.472698] kernel: soundwire_bus:sdw_assign_device_num: soundwire sdw-master-2: Slave already registered, reusing dev_num:1 [ 5627.472946] kernel: soundwire_bus:sdw_program_device_num: soundwire sdw-master-2: No more devices to enumerate [ 5627.473020] kernel: soundwire_bus:sdw_modify_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling enumeration completion for Slave 1 [ 5627.473212] kernel: soundwire_bus:sdw_slave_set_frequency: rt1316-sdca sdw:2:025d:1316:01: Configured bus base 1, scale 3, mclk 19200000, curr_freq 4800000 [ 5627.481877] kernel: snd_soc_rt1316_sdw:rt1316_io_init: rt1316-sdca sdw:2:025d:1316:01: rt1316_io_init hw_init complete [ 5627.481880] kernel: soundwire_bus:sdw_handle_slave_status: rt1316-sdca sdw:2:025d:1316:01: signaling initialization completion for Slave 1 [ 5627.872523] kernel: soundwire_bus:sdw_bus_wait_for_clk_prep_deprep: soundwire sdw-master-0: clock stop prep/de-prep done slave:15 [ 5627.872546] kernel: soundwire_bus:sdw_bus_wait_for_clk_prep_deprep: soundwire sdw-master-3: clock stop prep/de-prep done slave:15 [ 5630.853327] kernel: soundwire_bus:sdw_bus_wait_for_clk_prep_deprep: soundwire sdw-master-2: clock stop prep/de-prep done slave:15