[BUG] ipc timed out for 0x13000003| GLB_SET_PIPELINE_STATE on ADLP-NOCODEC-IPC4 #7149
Description
Describe the bug
A new IPC timed out issue happened on ADLP_RVP_NOCODEC_IPC4ZPH. We have a similar issue #6864 before, Not sure if they are exactly the same, so file a new bug to track.
This issue is not easy to reproduce.
To Reproduce
~/sof-test/test-case/multiple-pipeline.sh -f c -l 50
Reproduction Rate
No reproductions so far, very hard to reproduce it.
dmesg
[ 4781.476102] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc tx : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 12]
[ 4781.963632] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-tgl 0000:00:1f.3: pcm: trigger stream 0 dir 1 cmd 0
[ 4781.963640] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-tgl 0000:00:1f.3: trigger cmd: 0 state: 3
[ 4781.979568] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-tgl 0000:00:1f.3: pcm: trigger stream 12 dir 1 cmd 0
[ 4781.979569] kernel: snd_sof:sof_pcm_trigger: sof-audio-pci-intel-tgl 0000:00:1f.3: pcm: trigger stream 1 dir 1 cmd 0
[ 4781.979574] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-tgl 0000:00:1f.3: trigger cmd: 0 state: 3
[ 4781.979575] kernel: snd_sof:sof_ipc4_trigger_pipelines: sof-audio-pci-intel-tgl 0000:00:1f.3: trigger cmd: 0 state: 3
[ 4781.980525] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc timed out for 0x13000003|0x1
[ 4781.980651] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: preventing DSP entering D3 state to preserve context
[ 4781.980654] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ IPC dump start ]------------
[ 4781.980664] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: hda irq intsts 0x00000000 intlctl 0xc000000f rirb 00
[ 4781.980667] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: dsp irq ppsts 0x00000000 adspis 0x00000000
[ 4781.980676] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: Host IPC initiator: 0x13000003|0x1|0x0, target: 0x0|0x0|0x0, ctl: 0x3
[ 4781.980679] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ IPC dump end ]------------
[ 4781.980681] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ DSP dump start ]------------
[ 4781.980683] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: IPC timeout
[ 4781.980685] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: fw_state: SOF_FW_BOOT_COMPLETE (7)
[ 4781.980694] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: 0x00000005: module: ROM, state: FW_ENTERED, running
[ 4781.980708] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: extended rom status: 0x5 0x0 0x0 0x0 0x0 0x0 0x0 0x1
[ 4781.980710] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ DSP dump end ]------------
[ 4781.980722] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: failed to pause all pipelines
[ 4781.980727] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ASoC: error at soc_component_trigger on 0000:00:1f.3: -110
[ 4781.980731] kernel: Port2: ASoC: trigger FE cmd: 1 failed: -110
mtrace
[ 41.764345] <inf> dai_intel_ssp: dai_ssp_pre_start
[ 41.764363] <inf> dai_intel_ssp: dai_ssp_start
[ 41.764371] <inf> dai_intel_ssp: dai_ssp_update_bits base 77200, reg 34, mask 100, value 100
[ 41.764430] <wrn> dai_comp: comp:3 0x40006 dai_copy(): nothing to copy
[ 41.764910] <inf> ipc: rx : 0x13000003|0x1
[ 41.764943] <wrn> ipc: ipc_pipeline_complete(): no scheduling component specified, use comp 262153
[ 41.765335] <inf> host_comp: comp:4 0x40007 no bytes to copy, 0 avail in buffer, 768 free in DMA
[ 41.765351] <err> os: ** FATAL EXCEPTION
[ 41.765358] <err> os: ** CPU 0 EXCCAUSE 13 (load/store PIF data error)
[ 41.765365] <err> os: ** PC 0xbe0205ff VADDR (nil)
[ 41.765368] <err> os: ** PS 0x60520
[ 41.765380] <err> os: ** (INTLEVEL:0 EXCM: 0 UM:1 RING:0 WOE:1 OWB:5 CALLINC:2)
[ 41.765386] <err> os: ** A0 0xbe01f383 SP 0xbe087010 A2 (nil) A3 0xbe0a1380
[ 41.765395] <err> os: ** A4 0x300 A5 (nil) A6 0x54 A7 (nil)
[ 41.765401] <err> os: ** A8 0xa8 A9 0xbe0a4d40 A10 0xbe0a12c0 A11 0xa8
[ 41.765408] <err> os: ** A12 0xbe0a1680 A13 0x600 A14 0x180 A15 0x600
[ 41.765415] <err> os: ** LBEG 0xbe043dd9 LEND 0xbe043dff LCOUNT 0xffffffff
[ 41.765420] <err> os: ** SAR 0x20
Expected behavior
A clear and concise description of what you expected to happen.
Environment
Daily test run 21263
Kernel Branch: topic/sof-dev
Kernel Commit:
cff45eeb2ecb
SOF Branch: main
SOF Commit:
6b91a553284b
Zephyr Commit:
zephyr-v3.3.0-200-g9af2789cad17