[ 110.098145] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000044 [ 110.098157] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000048 [ 110.098887] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000048 [ 110.098895] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIW: 00000040 at 00000048 [ 110.098905] snd_sof_intel_hda_common:hda_dsp_state_log: sof-audio-pci-intel-mtl 0000:00:1f.3: Current DSP power state: D0I0 [ 110.098911] snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 0 -> 2 [ 110.098916] snd_sof:snd_sof_load_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: loading firmware [ 110.098919] snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 2 -> 3 [ 110.099964] 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 [ 110.101003] 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 [ 110.101017] snd_sof:snd_sof_run_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: booting DSP firmware [ 110.101021] 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 [ 110.102061] 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 [ 110.102069] snd_sof_intel_hda_common:mtl_dsp_cl_init: sof-audio-pci-intel-mtl 0000:00:1f.3: Primary core power up successful [ 110.102076] 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 [ 110.102102] snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1800]=0x41 successful [ 110.102125] snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1140]=0x1 successful [ 110.224282] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc rx : 0x1b080000|0x0: GLB_NOTIFICATION|FW_READY [ 110.224310] snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 3 -> 6 [ 110.224321] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc rx done : 0x1b080000|0x0: GLB_NOTIFICATION|FW_READY [ 110.224502] snd_sof:snd_sof_run_firmware: sof-audio-pci-intel-mtl 0000:00:1f.3: firmware boot complete [ 110.224510] snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 6 -> 7 [ 110.224527] 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] [ 110.224901] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x31400008: MOD_LARGE_CONFIG_SET [ 110.224929] 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] [ 110.224942] Message payload: 00000000: 0684c95b ffedca2c [ 110.224949] 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] [ 110.225336] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x3060004c: MOD_LARGE_CONFIG_SET [ 110.225364] 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] [ 110.225373] Message payload: 00000000: 00000100 00001000 00000001 000001ef [ 110.225377] Message payload: 00000010: 00000000 00000000 00000000 00000000 [ 110.225381] Message payload: 00000020: 00000000 00000000 00000000 00000000 [ 110.225385] Message payload: 00000030: 00000000 00000000 00000000 00000000 [ 110.225388] Message payload: 00000040: 00000000 00000000 00000000 [ 110.225411] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: open stream 1 dir 0 [ 110.225417] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period min 192 max 16384 bytes [ 110.225421] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period count 2 max 16 [ 110.225425] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: buffer max 65536 bytes [ 110.237990] snd_sof:sof_pcm_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: hw params stream 1 dir 0 [ 110.238004] snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x40000 successful [ 110.238026] snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x40000 successful [ 110.238036] snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: period_bytes:0x4000 [ 110.238038] snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: periods:4 [ 110.238065] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: Looking for configuration: [ 110.238067] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0, dev_type=0 [ 110.238070] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: ch=2 fmt=32/32 rate=48000 [ 110.238074] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint count=8 [ 110.238076] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=2 dir=1 dev_type = 0 [ 110.238079] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=1 link_type=2 dir=1 dev_type = 0 [ 110.238082] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=3 dir=0 dev_type = 0 [ 110.238084] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=3 dir=1 dev_type = 0 [ 110.238087] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=1 link_type=3 dir=0 dev_type = 0 [ 110.238089] snd_intel_dspcfg:nhlt_get_specific_cfg: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint format count=1 [ 110.238091] snd_intel_dspcfg:nhlt_get_specific_cfg: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint format: ch=2 fmt=32/32 rate=48000 [ 110.238098] 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] [ 110.238943] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x67000000|0x0: MOD_SET_DX [ 110.239051] 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] [ 110.239064] Message payload: 00000000: 00000002 00000002 [ 110.239069] snd_sof:snd_sof_dsp_core_get: sof-audio-pci-intel-mtl 0000:00:1f.3: Core 1 powered up [ 110.239074] snd_sof:snd_sof_dsp_core_get: sof-audio-pci-intel-mtl 0000:00:1f.3: Core ref 1 [ 110.239157] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11000005|0x100000: GLB_CREATE_PIPELINE [ 110.239554] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x100000: GLB_CREATE_PIPELINE [ 110.239596] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11000005|0x100000: GLB_CREATE_PIPELINE [ 110.239616] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.3 setup complete [ 110.239699] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000004|0x1000015: MOD_INIT_INSTANCE [data size: 84] [ 110.240312] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x1000015: MOD_INIT_INSTANCE [ 110.240506] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000004|0x1000015: MOD_INIT_INSTANCE [data size: 84] [ 110.240516] Message payload: 00000000: 0000066f 000000c0 00000180 00000001 [ 110.240520] Message payload: 00000010: 0000bb80 00000010 ffffff10 00000001 [ 110.240523] Message payload: 00000020: 00000000 00001002 0000bb80 00000020 [ 110.240525] Message payload: 00000030: ffffff10 00000001 00000000 00002002 [ 110.240528] Message payload: 00000040: 00000000 00000000 00000180 00000001 [ 110.240530] Message payload: 00000050: 00000000 [ 110.240533] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget copier.host.3.1 setup complete [ 110.240540] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000006|0x1000010: MOD_INIT_INSTANCE [data size: 64] [ 110.241116] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x1000010: MOD_INIT_INSTANCE [ 110.241292] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000006|0x1000010: MOD_INIT_INSTANCE [data size: 64] [ 110.241301] Message payload: 00000000: 00000000 00000180 00000180 00000000 [ 110.241305] Message payload: 00000010: 0000bb80 00000020 ffffff10 00000001 [ 110.241307] Message payload: 00000020: 00000000 00002002 ffffffff 7fffffff [ 110.241309] Message payload: 00000030: 00000001 00000000 0000000a 00000000 [ 110.241324] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x44000006|0x30000018: MOD_LARGE_CONFIG_SET [data size: 24] [ 110.241727] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x30000018: MOD_LARGE_CONFIG_SET [ 110.241764] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x44000006|0x30000018: MOD_LARGE_CONFIG_SET [data size: 24] [ 110.241781] Message payload: 00000000: ffffffff 7fffffff 00000001 b4bc3e24 [ 110.241792] Message payload: 00000010: 0000000a 00000000 [ 110.241812] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget gain.3.1 setup complete [ 110.241820] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000002|0x100000a: MOD_INIT_INSTANCE [data size: 40] [ 110.242327] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x100000a: MOD_INIT_INSTANCE [ 110.242500] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000002|0x100000a: MOD_INIT_INSTANCE [data size: 40] [ 110.242509] Message payload: 00000000: 0000038e 00000180 00000180 00000000 [ 110.242513] Message payload: 00000010: 0000bb80 00000020 ffffff10 00000001 [ 110.242515] Message payload: 00000020: 00000000 00002002 [ 110.242518] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget mixin.3.1 setup complete [ 110.242525] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11010006|0x100000: GLB_CREATE_PIPELINE [ 110.242859] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x31000000|0x100000: GLB_CREATE_PIPELINE [ 110.243081] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x11010006|0x100000: GLB_CREATE_PIPELINE [ 110.243089] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.4 setup complete [ 110.243095] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40000003|0x101000a: MOD_INIT_INSTANCE [data size: 40] [ 110.243448] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x101000a: MOD_INIT_INSTANCE [ 110.243508] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40000003|0x101000a: MOD_INIT_INSTANCE [data size: 40] [ 110.243529] Message payload: 00000000: 00001388 00000180 00000180 00000000 [ 110.243543] Message payload: 00000010: 0000bb80 00000020 ffffff10 00000001 [ 110.243553] Message payload: 00000020: 00000000 00002002 [ 110.243556] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget mixout.4.1 setup complete [ 110.243561] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40010006|0x1010010: MOD_INIT_INSTANCE [data size: 64] [ 110.244111] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x1010010: MOD_INIT_INSTANCE [ 110.244288] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40010006|0x1010010: MOD_INIT_INSTANCE [data size: 64] [ 110.244297] Message payload: 00000000: 00000000 00000180 00000180 00000000 [ 110.244301] Message payload: 00000010: 0000bb80 00000020 ffffff10 00000001 [ 110.244303] Message payload: 00000020: 00000000 00002002 ffffffff 7fffffff [ 110.244305] Message payload: 00000030: 00000001 00000000 0000000a 00000000 [ 110.244313] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x44010006|0x30000018: MOD_LARGE_CONFIG_SET [data size: 24] [ 110.244722] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x64000000|0x30000018: MOD_LARGE_CONFIG_SET [ 110.244750] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x44010006|0x30000018: MOD_LARGE_CONFIG_SET [data size: 24] [ 110.244759] Message payload: 00000000: ffffffff 7fffffff 00000001 b4bc3e24 [ 110.244763] Message payload: 00000010: 0000000a 00000000 [ 110.244767] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget gain.4.1 setup complete [ 110.244774] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x40010004|0x1010029: MOD_INIT_INSTANCE [data size: 164] [ 110.246657] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x60000000|0x1010029: MOD_INIT_INSTANCE [ 110.246691] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x40010004|0x1010029: MOD_INIT_INSTANCE [data size: 164] [ 110.246711] Message payload: 00000000: 0000066f 00000180 00000180 00000001 [ 110.246720] Message payload: 00000010: 0000bb80 00000020 ffffff10 00000001 [ 110.246722] Message payload: 00000020: 00000000 00002002 0000bb80 00000020 [ 110.246724] Message payload: 00000030: ffffff10 00000001 00000000 00002002 [ 110.246726] Message payload: 00000040: 00000000 00000c10 00000300 00000015 [ 110.246728] Message payload: 00000050: 00000000 ffffff10 ffffff10 ffffff10 [ 110.246731] Message payload: 00000060: ffffff10 ffffff10 ffffff10 ffffff10 [ 110.246733] Message payload: 00000070: ffffff10 c1d0077f d0700004 00000000 [ 110.246735] Message payload: 00000080: 02200000 00000003 00000003 00004002 [ 110.246737] Message payload: 00000090: 00000000 07070000 00000020 00110001 [ 110.246739] Message payload: 000000a0: 00000fff [ 110.246741] snd_sof:sof_widget_setup_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget copier.SSP.4.1 setup complete [ 110.246785] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000004|0x6: MOD_BIND [ 110.247353] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x6: MOD_BIND [ 110.247391] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000004|0x6: MOD_BIND [ 110.247409] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000006|0x2: MOD_BIND [ 110.247906] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x2: MOD_BIND [ 110.247937] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000006|0x2: MOD_BIND [ 110.247969] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000002|0x3: MOD_BIND [ 110.248408] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x3: MOD_BIND [ 110.248448] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000002|0x3: MOD_BIND [ 110.248464] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45000003|0x10006: MOD_BIND [ 110.248879] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x10006: MOD_BIND [ 110.248902] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45000003|0x10006: MOD_BIND [ 110.248920] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x45010006|0x10004: MOD_BIND [ 110.249297] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x65000000|0x10004: MOD_BIND [ 110.249526] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x45010006|0x10004: MOD_BIND [ 110.249871] snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 1 dir 0 cmd 1 [ 110.250406] snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x14001e successful [ 110.250426] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 1 state: 4 [ 110.250467] 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] [ 110.250770] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 110.250830] 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] [ 110.250845] Message payload: 00000000: 00000002 00000001 00000000 [ 110.250860] 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] [ 110.252145] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 110.252338] 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] [ 110.252351] Message payload: 00000000: 00000002 00000001 00000000 [ 113.670535] snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 1 dir 0 cmd 0 [ 113.670549] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 3 [ 113.670562] 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] [ 113.671409] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 113.671433] 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] [ 113.671441] Message payload: 00000000: 00000002 00000000 00000001 [ 113.671451] snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x140000 successful [ 113.671460] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 2 [ 113.671466] 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] [ 113.672421] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x33000000|0x1: GLB_SET_PIPELINE_STATE [ 113.672454] 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] [ 113.672463] Message payload: 00000000: 00000002 00000001 00000000 [ 113.672674] snd_sof:sof_pcm_hw_free: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: free stream 1 dir 0 [ 113.672709] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget copier.host.3.1 freed [ 113.672716] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget gain.3.1 freed [ 113.672722] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x46000002|0x3: MOD_UNBIND [ 113.673217] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x66000000|0x3: MOD_UNBIND [ 113.673250] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x46000002|0x3: MOD_UNBIND [ 113.673269] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 113.674339] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 113.674369] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12000000|0x0: GLB_DELETE_PIPELINE [ 113.674379] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.3 freed [ 113.674385] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget mixin.3.1 freed [ 113.674399] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget mixout.4.1 freed [ 113.674405] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget gain.4.1 freed [ 113.674412] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 113.675109] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x32000000|0x0: GLB_DELETE_PIPELINE [ 113.675139] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx done : 0x12010000|0x0: GLB_DELETE_PIPELINE [ 113.675147] 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] [ 113.675767] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x67000000|0x0: MOD_SET_DX [ 113.675836] 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] [ 113.675842] Message payload: 00000000: 00000002 00000000 [ 113.675847] snd_sof:snd_sof_dsp_core_put: sof-audio-pci-intel-mtl 0000:00:1f.3: Core 1 powered down [ 113.675850] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget pipeline.4 freed [ 113.675854] snd_sof:sof_widget_free_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: widget copier.SSP.4.1 freed [ 113.675974] snd_sof:sof_pcm_close: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: close stream 1 dir 0 [ 113.676923] aplay (7210) used greatest stack depth: 11912 bytes left [ 114.688313] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: open stream 1 dir 0 [ 114.688325] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period min 192 max 16384 bytes [ 114.688329] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: period count 2 max 16 [ 114.688332] snd_sof:sof_pcm_open: sof-audio-pci-intel-mtl 0000:00:1f.3: buffer max 65536 bytes [ 114.688587] snd_sof:sof_pcm_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: hw params stream 1 dir 0 [ 114.688599] snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x40000 successful [ 114.688626] snd_sof_intel_hda_common:hda_dsp_stream_hw_params: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x40000 successful [ 114.688635] snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: period_bytes:0x4000 [ 114.688639] snd_sof_intel_hda_common:hda_dsp_stream_setup_bdl: sof-audio-pci-intel-mtl 0000:00:1f.3: periods:4 [ 114.688661] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: Looking for configuration: [ 114.688664] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0, dev_type=0 [ 114.688668] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: ch=2 fmt=32/32 rate=48000 [ 114.688672] snd_intel_dspcfg:intel_nhlt_get_endpoint_blob: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint count=8 [ 114.688675] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=2 dir=1 dev_type = 0 [ 114.688679] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=1 link_type=2 dir=1 dev_type = 0 [ 114.688682] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=3 dir=0 dev_type = 0 [ 114.688685] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=0 link_type=3 dir=1 dev_type = 0 [ 114.688688] snd_intel_dspcfg:nhlt_check_ep_match: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint: vbus_id=1 link_type=3 dir=0 dev_type = 0 [ 114.688691] snd_intel_dspcfg:nhlt_get_specific_cfg: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint format count=1 [ 114.688694] snd_intel_dspcfg:nhlt_get_specific_cfg: sof-audio-pci-intel-mtl 0000:00:1f.3: Endpoint format: ch=2 fmt=32/32 rate=48000 [ 114.688703] 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] [ 114.689537] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx reply: 0x67000000|0x0: MOD_SET_DX [ 114.689610] 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] [ 114.689628] Message payload: 00000000: 00000002 00000002 [ 114.689632] snd_sof:snd_sof_dsp_core_get: sof-audio-pci-intel-mtl 0000:00:1f.3: Core 1 powered up [ 114.689635] snd_sof:snd_sof_dsp_core_get: sof-audio-pci-intel-mtl 0000:00:1f.3: Core ref 1 [ 114.689642] snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-mtl 0000:00:1f.3: ipc tx : 0x11000005|0x100000: GLB_CREATE_PIPELINE [ 115.196835] sof-audio-pci-intel-mtl 0000:00:1f.3: ipc timed out for 0x11000005|0x100000 [ 115.196894] sof-audio-pci-intel-mtl 0000:00:1f.3: ------------[ IPC dump start ]------------ [ 115.196920] sof-audio-pci-intel-mtl 0000:00:1f.3: Host IPC initiator: 0x91000005|0x100000|0x0, target: 0x1b060000|0x0|0x0, ctl: 0x3 [ 115.196940] sof-audio-pci-intel-mtl 0000:00:1f.3: ------------[ IPC dump end ]------------ [ 115.196955] sof-audio-pci-intel-mtl 0000:00:1f.3: ------------[ DSP dump start ]------------ [ 115.196956] sof-audio-pci-intel-mtl 0000:00:1f.3: IPC timeout [ 115.196958] sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state: SOF_FW_BOOT_COMPLETE (7) [ 115.196967] sof-audio-pci-intel-mtl 0000:00:1f.3: ROM status: 0x5, ROM error: 0x0 [ 115.197005] sof-audio-pci-intel-mtl 0000:00:1f.3: ROM debug status: 0x50000005, ROM debug error: 0x0 [ 115.197011] sof-audio-pci-intel-mtl 0000:00:1f.3: ROM feature bit enabled [ 115.197032] sof-audio-pci-intel-mtl 0000:00:1f.3: ------------[ DSP dump end ]------------ [ 115.197047] sof-audio-pci-intel-mtl 0000:00:1f.3: failed to create module pipeline.3 [ 115.197066] 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] [ 115.700974] sof-audio-pci-intel-mtl 0000:00:1f.3: ipc timed out for 0x47000000|0x0 [ 115.701000] sof-audio-pci-intel-mtl 0000:00:1f.3: IPC timeout [ 115.701013] Message payload: 00000000: 00000002 00000000 [ 115.701018] sof-audio-pci-intel-mtl 0000:00:1f.3: Failed to set up connected widgets [ 115.701354] sof-audio-pci-intel-mtl 0000:00:1f.3: no llp found, fall back to default HDA path [ 115.701517] snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 1 dir 0 cmd 1 [ 115.702018] snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x14001e successful [ 115.702039] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 1 state: 4 [ 116.205050] snd_sof:sof_pcm_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: trigger stream 1 dir 0 cmd 0 [ 116.205061] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 3 [ 116.205070] snd_sof_intel_hda_common:hda_dsp_stream_trigger: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1c0]=0x140000 successful [ 116.205076] snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-mtl 0000:00:1f.3: trigger cmd: 0 state: 2 [ 116.205144] snd_sof:sof_pcm_hw_free: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: free stream 1 dir 0 [ 116.205242] snd_sof:sof_pcm_close: sof-audio-pci-intel-mtl 0000:00:1f.3: pcm: close stream 1 dir 0 [ 118.705895] 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] [ 119.213796] sof-audio-pci-intel-mtl 0000:00:1f.3: ipc timed out for 0x44000000|0x3060004c [ 119.213832] sof-audio-pci-intel-mtl 0000:00:1f.3: IPC timeout [ 119.213844] sof-audio-pci-intel-mtl 0000:00:1f.3: sof_ipc4_set_get_data: large config set failed at offset 0: -110 [ 119.213879] 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] [ 119.717811] sof-audio-pci-intel-mtl 0000:00:1f.3: ipc timed out for 0x47000000|0x0 [ 119.717837] sof-audio-pci-intel-mtl 0000:00:1f.3: IPC timeout [ 119.717850] Message payload: 00000000: 00000001 00000000 [ 119.717854] sof-audio-pci-intel-mtl 0000:00:1f.3: ctx_save IPC error: -110, proceeding with suspend [ 119.717873] 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 [ 119.717898] snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1800]=0x0 successful [ 119.717911] snd_sof_intel_hda_common:mtl_enable_interrupts: sof-audio-pci-intel-mtl 0000:00:1f.3: FW Poll Status: reg[0x1140]=0x0 successful [ 119.720953] 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 [ 119.722020] 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 [ 119.722096] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIR: 00000000 at 00000044 [ 119.722103] snd_sof:snd_sof_pci_update_bits_unlocked: sof-audio-pci-intel-mtl 0000:00:1f.3: Debug PCIW: 00000010 at 00000044 [ 119.722814] snd_sof_intel_hda_common:hda_dsp_state_log: sof-audio-pci-intel-mtl 0000:00:1f.3: Current DSP power state: D3 [ 119.722827] snd_sof:sof_set_fw_state: sof-audio-pci-intel-mtl 0000:00:1f.3: fw_state change: 7 -> 0