[BUG] FATAL EXCEPTION| CPU 0 EXCCAUSE 9 (load/store alignment) #7831
Description
Describe the bug
Observed this issue in CI daily test. This issue happened when testing DMIC capture on TGL-NOCODEC-IPC4 platform.
Hard to reproduce this issue manually and no reproductions so far.
dmesg
[ 2875.268135] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc tx done : 0x13000003|0x1: GLB_SET_PIPELINE_STATE [data size: 16]
[ 2875.268138] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc tx : 0x13000004|0x1: GLB_SET_PIPELINE_STATE [data size: 16]
[ 2875.274793] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc rx : 0x1b0a0000|0x0: GLB_NOTIFICATION|EXCEPTION_CAUGHT
[ 2875.274796] kernel: snd_sof:sof_ipc4_rx_msg: sof-audio-pci-intel-tgl 0000:00:1f.3: Unhandled DSP message: 0x1b0a0000|0x0
[ 2875.274798] kernel: snd_sof:sof_ipc4_log_header: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc rx done : 0x1b0a0000|0x0: GLB_NOTIFICATION|EXCEPTION_CAUGHT
[ 2875.770703] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ipc timed out for 0x13000004|0x1
[ 2875.770719] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: Attempting to prevent DSP from entering D3 state to preserve context
[ 2875.770726] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ IPC dump start ]------------
[ 2875.770757] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: hda irq intsts 0x00000000 intlctl 0xc0000000 rirb 00
[ 2875.770765] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: dsp irq ppsts 0x00000000 adspis 0x00000000
[ 2875.770807] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: Host IPC initiator: 0x93000004|0x1|0x0, target: 0x0|0x0|0x80000000, ctl: 0x3
[ 2875.770815] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ IPC dump end ]------------
[ 2875.770820] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ DSP dump start ]------------
[ 2875.770825] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: IPC timeout
[ 2875.770831] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: fw_state: SOF_FW_BOOT_COMPLETE (7)
[ 2875.770851] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: 0x00000005: module: ROM, state: FW_ENTERED, running
[ 2875.770879] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: extended rom status: 0x5 0x0 0x0 0x0 0x0 0x0 0x0 0x1
[ 2875.770884] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ------------[ DSP dump end ]------------
[ 2875.770937] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: failed to set final state 4 for all pipelines
[ 2875.770957] kernel: sof-audio-pci-intel-tgl 0000:00:1f.3: ASoC: error at soc_component_trigger on 0000:00:1f.3: -110
[ 2875.770974] kernel: DMIC SFX2: ASoC: trigger FE cmd: 1 failed: -110
** mtrace**
[ 57.026686] <inf> dai_intel_dmic: dai_dmic_start: dmic_start(), cic 0x0000c001
[ 57.026696] <inf> dai_intel_dmic: dai_dmic_update_bits: dai_dmic_update_bits base 10000, reg 2000, mask 10000, value 0
[ 57.026706] <inf> dai_intel_dmic: dai_dmic_start: dmic_start(), cic 0x0000c001
[ 57.026720] <err> os: xtensa_excint1_c: ** FATAL EXCEPTION
[ 57.026730] <err> os: xtensa_excint1_c: ** CPU 0 EXCCAUSE 9 (load/store alignment)
[ 57.026740] <err> os: xtensa_excint1_c: ** PC 0xbe01d73f VADDR 0x8000000a
[ 57.026748] <err> os: xtensa_excint1_c: ** PS 0x60520
[ 57.026761] <err> os: xtensa_excint1_c: ** (INTLEVEL:0 EXCM: 0 UM:1 RING:0 WOE:1 OWB:5 CALLINC:2)
[ 57.026773] <err> os: z_xtensa_dump_stack: ** A0 0xbe01a003 SP 0xbe0ac590 A2 0xbe089568 A3 0x80000006
[ 57.026783] <err> os: z_xtensa_dump_stack: ** A4 0xf A5 0x9e09a554 A6 0xbe05bf70 A7 (nil)
[ 57.026793] <err> os: z_xtensa_dump_stack: ** A8 0x1 A9 0x1 A1Terminated
To Reproduce
~/sof-test/test-case/check-capture.sh -d 1 -l 1 -r 50
Reproduction Rate
Hard to reproduce this issue manually and no reproductions so far.
Environment
- Branch name and commit hash of the 2 repositories: sof (firmware/topology) and linux (kernel driver).
- Kernel: {2776754a4cd9}
- SOF: {46e326f23991}
- Name of the topology file
- Topology: {avs-tplg/sof-tgl-nocodec.tplg}
- Name of the platform(s) on which the bug is observed.
- Platform: {TGLU_RVP_NOCODEC_IPC4ZPH}
Screenshots or console output
2023-06-19 22:19:40 UTC [REMOTE_COMMAND] arecord -Dhw:0,28 -r 48000 -c 4 -f S32_LE -d 1 /dev/null -v -q
Hardware PCM card 0 'sof-nocodec' device 28 subdevice 0
Its setup is:
stream : CAPTURE
access : RW_INTERLEAVED
format : S32_LE
subformat : STD
channels : 4
rate : 48000
exact rate : 48000 (48000/1)
msbits : 32
buffer_size : 4096
period_size : 1024
period_time : 21333
tstamp_mode : NONE
tstamp_type : MONOTONIC
period_step : 1
avail_min : 1024
period_event : 0
start_threshold : 1
stop_threshold : 4096
silence_threshold: 0
silence_size : 0
boundary : 4611686018427387904
appl_ptr : 0
hw_ptr : 0
arecord: pcm_read:2221: read error: Connection timed out
lsof: WARNING: can't stat() fuse.gvfsd-fuse file system /run/user/120/gvfs
Output information may be incomplete.