Skip to content

[BUG] WoV: DSP panic after dmic(pcm8) recording is waked up #1414

New issue
New issue
Closed
Closed
[BUG] WoV: DSP panic after dmic(pcm8) recording is waked up#1414
Assignees
dabekjakub
Labels
bugSomething isn't working as expected

Description

@keqiaozhang
keqiaozhang
opened on May 13, 2019

Describe the bug
This issue happens after waking up the dmic recording via the "keyword"(Clap hard), then dmic recording will stop there(need ctl+c to kill it), the dmesg shows that DSP is crashed.
I can only reproduce this issue with test recipe 1 and cannot reproduce this issue with test recipe 2.

To Reproduce

  1. arecord -Dhw:0,8 -M -N -r 16000 -f s16_le -c 2 wov.wav -vvv
  2. clap hard to wake up the recording
  3. you will see dmic recording wake up and stop there.

Expected behavior
no panic after waking up..

Impact
DSP crash and firmware oops.

test recipe 1
kernel: cros-sof-v4.14-rebase /dc349dd
firmware: master/3f1b92 + PR #1365
tplg: sof-glk-da7219-kwd.tplg.
platform: GLK chromebook chrome OS R73-11559.0.0
Reproducibility Rate. 100%.

test recipe 2
kernel: sof-dev /35d775
firmware: master/3f1b92 + PR #1365
tplg: sof-glk-da7219-kwd.tplg.
platform: GLK ubuntu 18.04
Reproducibility Rate. 0%.

Screenshots or console output

Recording WAVE 'wov.wav' : Signed 16 bit Little Endian, Rate 16000 Hz, Stereo
Hardware PCM card 0 'sof-glkda7219max' device 8 subdevice 0
Its setup is:
  stream       : CAPTURE
  access       : MMAP_INTERLEAVED
  format       : S16_LE
  subformat    : STD
  channels     : 2
  rate         : 16000
  exact rate   : 16000 (16000/1)
  msbits       : 16
  buffer_size  : 8016
  period_size  : 2016
  period_time  : 126000
  tstamp_mode  : NONE
  tstamp_type  : MONOTONIC
  period_step  : 1
  avail_min    : 2016
  period_event : 0
  start_threshold  : 1
  stop_threshold   : 8016
  silence_threshold: 0
  silence_size : 0
  boundary     : 9025213653250473984
  appl_ptr     : 0
  hw_ptr       : 0
mmap_area[0] = 0x78215f6a8000,0,32 (16)
mmap_area[1] = 0x78215f6a8000,16,32 (16)
Max peak (4032 samples): 0x00000084 #                    0%
Max peak (4032 samples): 0x0000005a #                    0%
overrun!!! (at least 0.041 ms long)
Status:
  state       : XRUN
  trigger_time: 87.121772
  tstamp      : 0.000000
  delay       : 0
  avail       : 9728
  avail_max   : 9728
Max peak (4032 samples): 0x0000055e #                    4%
Max peak (4032 samples): 0x0000055e #                    4%
Max peak (4032 samples): 0x0000055e #                    4%
Max peak (672 samples): 0x0000055e #                    4%
^CAborted by signal Interrupt...

dmesg

[   81.376171] sof-audio-pci 0000:00:0e.0: firmware boot complete
[   81.418164] kauditd_printk_skb: 1823 callbacks suppressed
[   81.418166] audit: type=1400 audit(1557735445.452:18710): avc:  granted  { associate } for  pid=2698 comm="arecord" name="wov.wav" scontext=u:object_r:rootfs:s0 tcontext=u:object_r:labeledfs:s0 tclass=filesystem
[   88.074316] sof-audio-pci 0000:00:0e.0: error : DSP panic!
[   88.074343] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   88.074534] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   88.074537] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   88.074540] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   88.074542] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   88.074545] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   88.074548] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   88.074551] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   88.074554] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   88.074556] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   88.074559] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   88.074584] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   88.074587] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   88.074590] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   88.074592] sof-audio-pci 0000:00:0e.0: 0x0000000c: cf115828 ffff916d 00000000 00000000
[   88.074595] sof-audio-pci 0000:00:0e.0: 0x00000010: 0dead000 00000000 8163fe80 ffff9855
[   88.074598] sof-audio-pci 0000:00:0e.0: 0x00000014: 8163fea8 ffff9855 b533517d ffffffff
[   88.074600] sof-audio-pci 0000:00:0e.0: 0x00000018: 00000000 00000000 b53351a2 ffffffff
[   88.074603] sof-audio-pci 0000:00:0e.0: 0x0000001c: 8163ff48 ffff9855 b52fcb71 ffffffff
[   88.074606] sof-audio-pci 0000:00:0e.0: error: waking up any trace sleepers
[   92.926698] sof-audio-pci 0000:00:0e.0: error: ipc timed out for 0x60050000 size 12
[   92.926723] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   92.926883] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   92.926886] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   92.926890] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   92.926894] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   92.926898] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   92.926902] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   92.926905] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   92.926909] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   92.926913] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   92.926916] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   92.926922] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   92.926926] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   92.926930] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   92.926934] sof-audio-pci 0000:00:0e.0: 0x0000000c: 00000000 00000000 cf115828 ffff916d
[   92.926938] sof-audio-pci 0000:00:0e.0: 0x00000010: 81233c38 ffff9855 cf115828 ffff916d
[   92.926942] sof-audio-pci 0000:00:0e.0: 0x00000014: 7f7fda00 ad202a99 0000000c 00000000
[   92.926946] sof-audio-pci 0000:00:0e.0: 0x00000018: 81233c38 ffff9855 81233c48 ffff9855
[   92.926966] sof-audio-pci 0000:00:0e.0: 0x0000001c: c06423ab ffffffff c5048b40 ffffdca3
[   92.926982] sof-audio-pci 0000:00:0e.0: error: host status 0x00000000 dsp status 0x00000000 mask 0x00000003
[   92.926985] sof-audio-pci 0000:00:0e.0: error: waking up any trace sleepers
[   92.926990]  DMIC16k: ASoC: trigger FE failed -110
[   93.231601] sof-audio-pci 0000:00:0e.0: error: ipc timed out for 0x60030000 size 12
[   93.231633] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   93.231800] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   93.231806] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   93.231812] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   93.231818] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   93.231825] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   93.231831] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   93.231838] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   93.231844] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   93.231850] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   93.231856] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   93.231864] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   93.231872] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   93.231879] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   93.231885] sof-audio-pci 0000:00:0e.0: 0x0000000c: c064a4cd ffffffff 00000000 00000000
[   93.231892] sof-audio-pci 0000:00:0e.0: 0x00000010: 81233c90 ffff9855 81233c80 ffff9855
[   93.231899] sof-audio-pci 0000:00:0e.0: 0x00000014: 81233be8 ffff9855 7f7fda00 ad202a99
[   93.231905] sof-audio-pci 0000:00:0e.0: 0x00000018: c06406c1 ffffffff 81233c80 ffff9855
[   93.231912] sof-audio-pci 0000:00:0e.0: 0x0000001c: 81233cc0 ffff9855 c064212d ffffffff
[   93.231933] sof-audio-pci 0000:00:0e.0: error: host status 0x00000000 dsp status 0x00000000 mask 0x00000003
[   93.231953] sof-audio-pci 0000:00:0e.0: error: waking up any trace sleepers
[   93.550401] sof-audio-pci 0000:00:0e.0: error: ipc timed out for 0x60050000 size 12
[   93.550433] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   93.550602] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   93.550608] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   93.550614] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   93.550620] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   93.550627] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   93.550634] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   93.550640] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   93.550646] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   93.550652] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   93.550658] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   93.550667] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   93.550675] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   93.550681] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   93.550688] sof-audio-pci 0000:00:0e.0: 0x0000000c: 00000000 00000000 cf115828 ffff916d
[   93.550695] sof-audio-pci 0000:00:0e.0: 0x00000010: 81233a08 ffff9855 cf115828 ffff916d
[   93.550701] sof-audio-pci 0000:00:0e.0: 0x00000014: 7f7fda00 ad202a99 0000000c 00000000
[   93.550708] sof-audio-pci 0000:00:0e.0: 0x00000018: 81233a08 ffff9855 81233a18 ffff9855
[   93.550714] sof-audio-pci 0000:00:0e.0: 0x0000001c: c0646574 ffffffff 00000000 ad202a99
[   93.550761] sof-audio-pci 0000:00:0e.0: error: host status 0x00000000 dsp status 0x00000000 mask 0x00000003
[   93.550764] sof-audio-pci 0000:00:0e.0: error: waking up any trace sleepers
[   93.550769] sof-audio-pci 0000:00:0e.0: error: failed to trigger DETECT9.0
[   93.550771] sof-audio-pci 0000:00:0e.0: error: failed to trigger widget DETECT9.0
[   93.854238] sof-audio-pci 0000:00:0e.0: error: ipc timed out for 0x60030000 size 12
[   93.854269] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   93.854440] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   93.854446] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   93.854452] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   93.854458] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   93.854465] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   93.854471] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   93.854477] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   93.854484] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   93.854490] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   93.854496] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   93.854504] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   93.854512] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   93.854519] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   93.854525] sof-audio-pci 0000:00:0e.0: 0x0000000c: 00000000 00000000 cf115828 ffff916d
[   93.854532] sof-audio-pci 0000:00:0e.0: 0x00000010: 81233a08 ffff9855 cf115828 ffff916d
[   93.854539] sof-audio-pci 0000:00:0e.0: 0x00000014: 7f7fda00 ad202a99 0000000c 00000000
[   93.854545] sof-audio-pci 0000:00:0e.0: 0x00000018: 81233a08 ffff9855 81233a18 ffff9855
[   93.854552] sof-audio-pci 0000:00:0e.0: 0x0000001c: c0646574 ffffffff ffff0a10 00000000
[   93.854572] sof-audio-pci 0000:00:0e.0: error: host status 0x00000000 dsp status 0x00000000 mask 0x00000003
[   93.854597] sof-audio-pci 0000:00:0e.0: error: waking up any trace sleepers
[   93.854602] sof-audio-pci 0000:00:0e.0: error: failed to trigger DETECT9.0
[   93.854604] sof-audio-pci 0000:00:0e.0: error: failed to trigger widget DETECT9.0
[   93.854608] sof-audio-pci 0000:00:0e.0: ASoC: POST_PMD: DETECT9.0 event failed: -110
[   96.165150] sof-audio-pci 0000:00:0e.0: error: ipc timed out for 0x40010000 size 76
[   96.165180] sof-audio-pci 0000:00:0e.0: status: fw entered - code 00000005
[   96.165352] sof-audio-pci 0000:00:0e.0: error: runtime exception
[   96.165356] sof-audio-pci 0000:00:0e.0: error: trace point 00004000
[   96.165361] sof-audio-pci 0000:00:0e.0: error: panic at :-1106772768
[   96.165366] sof-audio-pci 0000:00:0e.0: error: DSP Firmware Oops
[   96.165371] sof-audio-pci 0000:00:0e.0: EXCCAUSE 0x00000180 EXCVADDR 0xc3f3fbfe PS       0x1544813c SAR     0x00060f20
[   96.165376] sof-audio-pci 0000:00:0e.0: EPC1     0x00000040 EPC2     0x0000017c EPC3     0xbe07fd10 EPC4    0x0000000d
[   96.165381] sof-audio-pci 0000:00:0e.0: EPC5     0x00000000 EPC6     0x00060025 EPC7     0xbe02a03c DEPC    0x00060f20
[   96.165386] sof-audio-pci 0000:00:0e.0: EPS2     0xbe01c04d EPS3     0xbe02d18b EPS4     0x00000000 EPS5    0xbe02d18b
[   96.165391] sof-audio-pci 0000:00:0e.0: EPS6     0x00000000 EPS7     0x00000000 INTENABL 0x00060f20 INTERRU 0x00000000
[   96.165396] sof-audio-pci 0000:00:0e.0: stack dump from 0x00000000
[   96.165403] sof-audio-pci 0000:00:0e.0: 0x00000000: be00a81c 00060025 be00a828 00be07fd
[   96.165408] sof-audio-pci 0000:00:0e.0: 0x00000004: be00a9ac be07fff8 00000000 be00ac94
[   96.165413] sof-audio-pci 0000:00:0e.0: 0x00000008: 00000000 00000000 00000000 00000222
[   96.165418] sof-audio-pci 0000:00:0e.0: 0x0000000c: 00000000 00000000 cf115828 ffff916d
[   96.165424] sof-audio-pci 0000:00:0e.0: 0x00000010: 80337c98 ffff9855 cf115828 ffff916d
[   96.165429] sof-audio-pci 0000:00:0e.0: 0x00000014: bbeda900 ac7536c4 0000004c 00000000
[   96.165434] sof-audio-pci 0000:00:0e.0: 0x00000018: 80337c98 ffff9855 80337ca8 ffff9855
[   96.165439] sof-audio-pci 0000:00:0e.0: 0x0000001c: c0642652 ffffffff 00000000 00000000
[   96.165459] sof-audio-pci 0000:00:0e.0: error: host status 0x00000000 dsp status 0x00000000 mask 0x00000003
[   96.165464] sof-audio-pci 0000:00:0e.0: error: ctx_save ipc error during suspend -110
[   96.165493] sof-audio-pci 0000:00:0e.0: can't suspend (snd_sof_runtime_suspend [snd_sof] returned -110)

logger

    0      1         PIPE 8.55      6718430.833333         6.614583 src/audio/pipeline.c:843    pipeline_xrun_recover()
    0      1          KPB           6738476.041667     20045.208984      src/audio/kpb.c:499    kpb_copy() error: sink component buffer has not enough free bytes for copy
    0      1         PIPE           6738525.572917        49.531250 src/audio/pipeline.c:732    pipeline_copy() error: ret = -5, start->comp.id = 54, dir = 0
    0      1         PIPE 8.55      6738532.500000         6.927083 src/audio/pipeline.c:843    pipeline_xrun_recover()
    0      2       BUFFER           6718368.333333              nan   src/audio/buffer.c:118    comp_update_buffer_produce(), no bytes to produce
    0      1          KPB           6718374.166667         5.833333      src/audio/kpb.c:499    kpb_copy() error: sink component buffer has not enough free bytes for copy
    0      2         COMP           6718379.635417         5.468750 of/audio/component.h:724    comp_overrun(), ((dev->comp.id << 16) | sink->free) = 3342336, ((min_bytes << 16) | copy_bytes) = 0
    0      2         PIPE 8.55      6718383.645833         4.010417 src/audio/pipeline.c:579    pipeline_trigger()
    0      2          DAI 8.54      6718387.916667         4.270833      src/audio/dai.c:508    dai_comp_trigger(), command = 8
    0      2          DAI 8.54      6718391.875000         3.958333      src/audio/dai.c:566    dai_comp_trigger(), XRUN
    0      2          DAI 8.54      6718395.312500         3.437500      src/audio/dai.c:572    dai_comp_trigger(), PAUSE/STOP
    0      2          DMA           6718398.906250         3.593750 src/drivers/dw/dma.c:460    dw_dma_stop(): dma 0 channel 4 stop
    0      2         DMIC           6718407.343750         8.437500 rs/intel/cavs/dmic.c:1448   dmic_trigger()
    0      2         DMIC           6718411.041667         3.697917 rs/intel/cavs/dmic.c:1380   dmic_stop()
    0      2         DMIC           6718415.468750         4.427083 rs/intel/cavs/dmic.c:1400   dmic_stop(), dmic_active_fifos = 1
    0      1         PIPE           6718424.218750         8.750000 src/audio/pipeline.c:732    pipeline_copy() error: ret = -5, start->comp.id = 54, dir = 0
    0      1         PIPE 8.55      6718430.833333         6.614583 src/audio/pipeline.c:843    pipeline_xrun_recover()
    0      2         PIPE 8.55      6718436.093750         5.260417 src/audio/pipeline.c:352    pipeline_prepare()
    0      2          DAI 8.54      6718440.104167         4.010417      src/audio/dai.c:445    dai_prepare()
    0      2         PIPE 8.55      6718444.895833         4.791667 src/audio/pipeline.c:579    pipeline_trigger()
    0      2          DAI 8.54      6718448.645833         3.750000      src/audio/dai.c:508    dai_comp_trigger(), command = 1
    0      2          DAI 8.54      6718452.343750         3.697917      src/audio/dai.c:519    dai_comp_trigger(), START
    0      2         DMIC           6718463.333333        10.989583 rs/intel/cavs/dmic.c:1448   dmic_trigger()
    0      2         DMIC           6718467.343750         4.010417 rs/intel/cavs/dmic.c:1280   dmic_start()
    0      2         DMIC           6718470.833333         3.489583 rs/intel/cavs/dmic.c:1296   dmic_start(), dmic->fifo_b
    0      2         DMIC           6718474.791667         3.958333 rs/intel/cavs/dmic.c:1323   dmic_start(), mic_a = 1, mic_b = 1, fir_a = 1, fir_b = 1
    0      2         DMIC           6718479.270833         4.479167 rs/intel/cavs/dmic.c:1323   dmic_start(), mic_a = 0, mic_b = 0, fir_a = 0, fir_b = 0
    0      2         DMIC           6718484.114583         4.843750 rs/intel/cavs/dmic.c:1359   dmic_start(), dmic_active_fifos = 1
    0      2         DMIC           6718488.854167         4.739583 rs/intel/cavs/dmic.c:1371   dmic_start(), done
    0      2       BUFFER           6738470.729167     19981.875000   src/audio/buffer.c:118    comp_update_buffer_produce(), no bytes to produce
    0      1          KPB           6738476.041667         5.312500      src/audio/kpb.c:499    kpb_copy() error: sink component buffer has not enough free bytes for copy
    0      2         COMP           6738481.145833         5.104167 of/audio/component.h:724    comp_overrun(), ((dev->comp.id << 16) | sink->free) = 3342336, ((min_bytes << 16) | copy_bytes) = 0
    0      2         PIPE 8.55      6738485.156250         4.010417 src/audio/pipeline.c:579    pipeline_trigger()
    0      2          DAI 8.54      6738489.479167         4.322917      src/audio/dai.c:508    dai_comp_trigger(), command = 8
    0      2          DAI 8.54      6738493.489583         4.010417      src/audio/dai.c:566    dai_comp_trigger(), XRUN
    0      2          DAI 8.54      6738496.770833         3.281250      src/audio/dai.c:572    dai_comp_trigger(), PAUSE/STOP
    0      2          DMA           6738500.364583         3.593750 src/drivers/dw/dma.c:460    dw_dma_stop(): dma 0 channel 4 stop
    0      2         DMIC           6738508.906250         8.541667 rs/intel/cavs/dmic.c:1448   dmic_trigger()
    0      2         DMIC           6738512.656250         3.750000 rs/intel/cavs/dmic.c:1380   dmic_stop()
    0      2         DMIC           6738516.822917         4.166667 rs/intel/cavs/dmic.c:1400   dmic_stop(), dmic_active_fifos = 1
    0      1         PIPE           6738525.572917         8.750000 src/audio/pipeline.c:732    pipeline_copy() error: ret = -5, start->comp.id = 54, dir = 0
    0      1         PIPE 8.55      6738532.500000         6.927083 src/audio/pipeline.c:843    pipeline_xrun_recover()
    0      2         PIPE 8.55      6738537.447917         4.947917 src/audio/pipeline.c:352    pipeline_prepare()
    0      2          DAI 8.54      6738541.562500         4.114583      src/audio/dai.c:445    dai_prepare()
    0      2         PIPE 8.55      6738546.458333         4.895833 src/audio/pipeline.c:579    pipeline_trigger()
    0      2          DAI 8.54      6738550.208333         3.750000      src/audio/dai.c:508    dai_comp_trigger(), command = 1
    0      2          DAI 8.54      6738553.750000         3.541667      src/audio/dai.c:519    dai_comp_trigger(), START
    0      2         DMIC           6738564.531250        10.781250 rs/intel/cavs/dmic.c:1448   dmic_trigger()
    0      2         DMIC           6738568.593750         4.062500 rs/intel/cavs/dmic.c:1280   dmic_start()
    0      2         DMIC           6738572.083333         3.489583 rs/intel/cavs/dmic.c:1296   dmic_start(), dmic->fifo_b
    0      2         DMIC           6738576.041667         3.958333 rs/intel/cavs/dmic.c:1323   dmic_start(), mic_a = 1, mic_b = 1, fir_a = 1, fir_b = 1
    0      2         DMIC           6738580.572917         4.531250 rs/intel/cavs/dmic.c:1323   dmic_start(), mic_a = 0, mic_b = 0, fir_a = 0, fir_b = 0
    0      2         DMIC           6738585.260417         4.687500 rs/intel/cavs/dmic.c:1359   dmic_start(), dmic_active_fifos = 1
    0      2         DMIC           6738590.000000         4.739583 rs/intel/cavs/dmic.c:1371   dmic_start(), done
    0      2           SA           6750178.958333     11588.958008      src/lib/agent.c:74     validate(), idle longer than timeout, delta = 19065543

dmesg.log
logger.log
logger-t.log

Activity

  1. keqiaozhang
    added
    bugSomething isn't working as expected
    on May 13, 2019
  2. mengdonglin
    assigned
    dabekjakub
    on May 14, 2019

  3. keyonjie commented on May 14, 2019

    @keyonjie
    keyonjie
    on May 14, 2019
    Contributor

    Tomek's sof PR#1415 should be helpful for this?

  4. keqiaozhang commented on May 14, 2019

    @keqiaozhang
    keqiaozhang
    on May 14, 2019
    CollaboratorAuthor

    Some updates about this issue:

    1. No DSP panic after reverting PR kpb: stop key phrase detection during draining #1363.
      Test recipe:
      kernel: cros-sof-v4.14-rebase /dc349dd
      firmware: master/b73b9a6 + reverting PR kpb: stop key phrase detection during draining #1363

    2. Tested with sof-dev branch, no DSP panic issue, but I got the ipc error in kmsg:

    [   41.407845] sof-audio-pci 0000:00:0e.0: received event 4 for widget DETECT9.0
[   41.407847] sof-audio-pci 0000:00:0e.0: received event 8 for widget DETECT9.0
[   41.407849] sof-audio-pci 0000:00:0e.0: ipc tx: 0x60050000: GLB_STREAM_MSG: TRIG_STOP
[   41.407947] sof-audio-pci 0000:00:0e.0: error: ipc error for 0x60050000 size 12
[   41.407951] sof-audio-pci 0000:00:0e.0: error: failed to trigger DETECT9.0
[   41.407953] sof-audio-pci 0000:00:0e.0: error: failed to trigger widget DETECT9.0
[   41.407955] sof-audio-pci 0000:00:0e.0: ipc tx: 0x60030000: GLB_STREAM_MSG: PCM_FREE
[   41.408308] sof-audio-pci 0000:00:0e.0: ipc tx succeeded: 0x60030000: GLB_STREAM_MSG: PCM_FREE

    Test recipe:
    kernel: sof-dev/35d775
    firmware: master/b73b9a6

  5. keqiaozhang commented on May 14, 2019

    @keqiaozhang
    keqiaozhang
    on May 14, 2019
    CollaboratorAuthor

    Sorry for my mistake.
    I found this issue with a workaround patch, but this workaround has some conflicts with PR #1363. but I didn't release it. So after removing the workaround and keep PR #1363 , there's also no DSP panic. The results of sof-dev and cros-sof-v4.14-rebase are same now.
    So let's close this issue.
    The workaround is from Keyon, I pasted it as below for your reference.

    diff --git a/src/audio/detect_test.c b/src/audio/detect_test.c
index 8fb1a5536177..fda4c4a2909f 100644
--- a/src/audio/detect_test.c
+++ b/src/audio/detect_test.c
@@ -299,6 +299,8 @@ static int test_keyword_set_config(struct comp_dev *dev,
        struct sof_detect_test_config *cfg;
        size_t bs;

+       return 0;
+
        /* Copy new config, find size from header */
        cfg = (struct sof_detect_test_config *)cdata->data->data;
        bs = cfg->size;
  6. keqiaozhang
    closed this as completedon May 14, 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment

Metadata

Metadata

Assignees

Labels

bugSomething isn't working as expected

Type

No type

Projects

No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions