[CFL][HDA] "load fw failed ret: -110" after arecord several times.

[stevyan]

Summary
'IPC timed out for 0x60010000: GLB_STREAM_MSG: PCM_PARAMS' after attempt to arecord around 10 times.

To reproduce

1. arecord -Dhw:0,0 -f dat /dev/null
2. interrupt capture via 'ctrl + c'
3. repeat 1-2 near than 10 times

Actual Result
aplay: set_params:1363: Unable to install hw params:
Playback/Capture cannot be recovered when error occurred until reboot device.

Test Recipe
date: 2019-05-22
sof (master): 3e423f41
linux (topic/sof-dev): e3ec7cf
topology: sof-hda-generic.tplg

dmesg log

[  101.505674] sof-audio-pci 0000:00:1f.3: DSP core(s) enabled? 1 : core_mask 1
[  101.506529] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x80000000 successful
[  101.506541] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf010e0e successful
[  101.506551] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000021 successful
[  101.506649] sof-audio-pci 0000:00:1f.3: error: no reply expected, received 0x0
[  104.507030] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x5000001 timedout
[  104.507043] sof-audio-pci 0000:00:1f.3: error: load fw failed ret: -110
[  104.507073] sof-audio-pci 0000:00:1f.3: unknown ROM status value 05000001
[  104.507081] sof-audio-pci 0000:00:1f.3: error: status = 0x00000000 panic = 0x00000000
[  104.507088] sof-audio-pci 0000:00:1f.3: unknown ROM status value 05000001
[  104.507093] sof-audio-pci 0000:00:1f.3: error: failed to reset DSP
[  104.507097] sof-audio-pci 0000:00:1f.3: error: failed to boot DSP firmware after resume -110
[  104.507117] sof-audio-pci 0000:00:1f.3: pcm: open stream 0 dir 1
[  104.507121] sof-audio-pci 0000:00:1f.3: period min 192 max 16384 bytes
[  104.507124] sof-audio-pci 0000:00:1f.3: period count 2 max 16
[  104.507126] sof-audio-pci 0000:00:1f.3: buffer max 65536 bytes
[  104.507517] sof-audio-pci 0000:00:1f.3: format_val=49, rate=48000, ch=2, format=10
[  104.507530] sof-audio-pci 0000:00:1f.3: pcm: hw params stream 0 dir 1
[  104.507535] sof-audio-pci 0000:00:1f.3: generating page table for 000000000ab2be2b size 0xffc0 pages 16
[  104.507571] sof-audio-pci 0000:00:1f.3: period_bytes:0x3fc0
[  104.507573] sof-audio-pci 0000:00:1f.3: periods:4
[  104.507598] sof-audio-pci 0000:00:1f.3: stream_tag 1
[  104.507610] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60010000: GLB_STREAM_MSG: PCM_PARAMS
[  104.809219] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60010000 size 108
[  104.809229] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  104.809234] sof-audio-pci 0000:00:1f.3: error: status = 0x001c003c panic = 0x00000001
[  104.809237] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  104.809244] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040000 mask 0x00000000
[  104.809245] sof-audio-pci 0000:00:1f.3: error: hw params ipc failed for stream 1
[  104.809247] sof-audio-pci 0000:00:1f.3: ASoC: 0000:00:1f.3 hw params failed: -110
[  104.809250]  HDA Analog: ASoC: hw_params FE failed -110
[  104.809265] sof-audio-pci 0000:00:1f.3: pcm: free stream 0 dir 1
[  104.809267] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60030000: GLB_STREAM_MSG: PCM_FREE
[  105.113061] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60030000 size 12
[  105.113078] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  105.113088] sof-audio-pci 0000:00:1f.3: error: status = 0x001c003c panic = 0x00000001
[  105.113096] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  105.113106] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040000 mask 0x00000000
[  105.113438] sof-audio-pci 0000:00:1f.3: pcm: close stream 0 dir 1

arecord_failed-dmesg.txt
arecord_failed-slogger.txt

[ClarexZhou]

Error occurred on CML during aplay -d 1 stress tests, error occurred after 148 times.
Environment
Firmware: 5fa2426 https://github.com/thesofproject/sof/tree/master
Kernel: b58f448 https://github.com/thesofproject/linux/tree/release/sof-v5.0
Topology: file: tools/topology/sof-hda-generic.tplg, sof-hda-generic-2ch.tplg same as firmware
Kconfig: https://sof-ci-storage.sh.intel.com/daily/20190521/release/linux/topic/sof-dev/901cd2a5-2/config-daily-hda-20190521.txt

[ 3063.802152] sof-audio-pci 0000:00:1f.3: pcm: open stream 0 dir 0
[ 3063.802159] sof-audio-pci 0000:00:1f.3: period min 192 max 16384 bytes
[ 3063.802163] sof-audio-pci 0000:00:1f.3: period count 2 max 16
[ 3063.802166] sof-audio-pci 0000:00:1f.3: buffer max 65536 bytes
[ 3063.802771] sof-audio-pci 0000:00:1f.3: format_val=49, rate=48000, ch=2, format=10
[ 3063.802785] sof-audio-pci 0000:00:1f.3: pcm: hw params stream 0 dir 0
[ 3063.802792] sof-audio-pci 0000:00:1f.3: generating page table for 0000000079596cf6 size 0xffc0 pages 16
[ 3063.802825] sof-audio-pci 0000:00:1f.3: period_bytes:0x3fc0
[ 3063.802828] sof-audio-pci 0000:00:1f.3: periods:4
[ 3063.802861] sof-audio-pci 0000:00:1f.3: stream_tag 1
[ 3063.802878] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60010000: GLB_STREAM_MSG: PCM_PARAMS
[ 3064.104665] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60010000 size 108
[ 3064.104695] sof-audio-pci 0000:00:1f.3: status: fw entered - code 00000005
[ 3064.105039] sof-audio-pci 0000:00:1f.3: error: unexpected fault 0x00000000 trace 0x00004000
[ 3064.105066] sof-audio-pci 0000:00:1f.3: error: host status 0x80000000 dsp status 0x90020000 mask 0x00000003
[ 3064.105073] sof-audio-pci 0000:00:1f.3: error: waking up any trace sleepers
[ 3064.105081] sof-audio-pci 0000:00:1f.3: error: hw params ipc failed for stream 1
[ 3064.105091] sof-audio-pci 0000:00:1f.3: ASoC: 0000:00:1f.3 hw params failed: -110
[ 3064.105102]  HDA Analog: ASoC: hw_params FE failed -110
[ 3064.105147] sof-audio-pci 0000:00:1f.3: pcm: free stream 0 dir 0
[ 3064.105157] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60030000: GLB_STREAM_MSG: PCM_FREE
[ 3064.408683] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60030000 size 12
[ 3064.408710] sof-audio-pci 0000:00:1f.3: status: fw entered - code 00000005
[ 3064.408956] sof-audio-pci 0000:00:1f.3: error: unexpected fault 0x00000000 trace 0x00004000
[ 3064.408967] sof-audio-pci 0000:00:1f.3: error: host status 0x80000000 dsp status 0x90020000 mask 0x00000003
[ 3064.408971] sof-audio-pci 0000:00:1f.3: error: waking up any trace sleepers
[ 3064.409317] sof-audio-pci 0000:00:1f.3: pcm: close stream 0 dir 0
[ 3066.656843] sof-audio-pci 0000:00:1f.3: ipc rx: 0x90020000: GLB_TRACE_MSG
[ 3066.656898] sof-audio-pci 0000:00:1f.3: ipc rx done: 0x90020000: GLB_TRACE_MSG
[ 3066.656956] sof-audio-pci 0000:00:1f.3: ipc rx: 0x90020000: GLB_TRACE_MSG
[ 3066.657008] sof-audio-pci 0000:00:1f.3: ipc rx done: 0x90020000: GLB_TRACE_MSG
[ 3066.691772] sof-audio-p

aplay_timedout_dmesg.log
aplay_timedout_logger.log

[keyonjie]

@ClarexZhou @stevyan can you try if @ranj063's PR #977 help to fix this issue? I ran aplay -d 1 stress test with that applied on my cml, i passed 1000 iterations.

[stevyan]

This error still can be reproduced after 12 times tries based on CFL RVP HDA.

Test Recipe
date: 2019-05-28
sof (master): 63cb86f1
linux (topic/sof-dev): PR#977
topology: sof-hda-generic.tplg

dmesg log

[  126.675831] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x80000000 successful
[  126.675836] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf010e0e successful
[  126.675852] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000021 successful
[  126.675867] sof-audio-pci 0000:00:1f.3: error: no reply expected, received 0x0
[  129.675926] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x5000001 timedout
[  129.675937] sof-audio-pci 0000:00:1f.3: error: load fw failed ret: -110
[  129.675958] sof-audio-pci 0000:00:1f.3: unknown ROM status value 05000001
[  129.675963] sof-audio-pci 0000:00:1f.3: error: status = 0x00000000 panic = 0x00000000
[  129.675968] sof-audio-pci 0000:00:1f.3: unknown ROM status value 05000001
[  129.675971] sof-audio-pci 0000:00:1f.3: error: failed to reset DSP
[  129.675974] sof-audio-pci 0000:00:1f.3: error: failed to boot DSP firmware after resume -110
[  129.675987] sof-audio-pci 0000:00:1f.3: pcm: open stream 0 dir 1
[  129.675989] sof-audio-pci 0000:00:1f.3: period min 192 max 16384 bytes
[  129.675991] sof-audio-pci 0000:00:1f.3: period count 2 max 16
[  129.675992] sof-audio-pci 0000:00:1f.3: buffer max 65536 bytes
[  129.676247] sof-audio-pci 0000:00:1f.3: format_val=49, rate=48000, ch=2, format=10
[  129.676251] sof-audio-pci 0000:00:1f.3: pcm: hw params stream 0 dir 1
[  129.676254] sof-audio-pci 0000:00:1f.3: generating page table for 00000000fe85ec3c size 0xffc0 pages 16
[  129.676277] sof-audio-pci 0000:00:1f.3: period_bytes:0x3fc0
[  129.676278] sof-audio-pci 0000:00:1f.3: periods:4
[  129.676290] sof-audio-pci 0000:00:1f.3: stream_tag 1
[  129.676297] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60010000: GLB_STREAM_MSG: PCM_PARAMS
[  129.982492] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60010000 size 108
[  129.982502] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  129.982506] sof-audio-pci 0000:00:1f.3: error: status = 0x001c003c panic = 0x00000001
[  129.982510] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  129.982519] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040000 mask 0x00000000
[  129.982523] sof-audio-pci 0000:00:1f.3: error: hw params ipc failed for stream 1
[  129.982526] sof-audio-pci 0000:00:1f.3: ASoC: 0000:00:1f.3 hw params failed: -110
[  129.982532]  HDA Analog: ASoC: hw_params FE failed -110
[  129.982555] sof-audio-pci 0000:00:1f.3: pcm: free stream 0 dir 1
[  129.982560] sof-audio-pci 0000:00:1f.3: ipc tx: 0x60030000: GLB_STREAM_MSG: PCM_FREE
[  130.285406] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x60030000 size 12
[  130.285414] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  130.285418] sof-audio-pci 0000:00:1f.3: error: status = 0x001c003c panic = 0x00000001
[  130.285421] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[  130.285427] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040000 mask 0x00000000
[  130.285549] sof-audio-pci 0000:00:1f.3: pcm: close stream 0 dir 1

[stevyan]

@ClarexZhou @stevyan can you try if @ranj063's PR #977 help to fix this issue? I ran aplay -d 1 stress test with that applied on my cml, i passed 1000 iterations.

@keyonjie aplay can work without this issue based on daily build or PR#977, but arecord will be failed.

[ranj063]

Folks, please do not classify all issues as IPC timeouts by looking at the last error message. The problem here is due to a FW load failure that occurred much earlier than the IPC timeout

[ClarexZhou]

Error occurred during S3 without playback stress test.
Error always occurred when do stress test with USB hub Ethernet network.
Error not occurred when do stress test without network.
FW load failed then CTX_save ipc timed out at 95th time. Can't enter S3 anymore and headset type selection query pops up.

Test Recipe
Kernel :98972d https://github.com/lyakh/linux/commits/cnl-rc1
FW: 47dc14d https://github.com/lyakh/sof/tree/ipc-timeout
Topology: Same with FW.

[ 1008.318983] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf0f0f0f successful
[ 1008.318988] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf0f0f0e successful
[ 1008.318989] sof-audio-pci 0000:00:1f.3: unstall/run core: core_mask = 1
[ 1008.318991] sof-audio-pci 0000:00:1f.3: DSP core(s) enabled? 1 : core_mask 1
[ 1008.319516] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x80000000 successful
[ 1008.319523] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x1010e0e successful
[ 1008.319533] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000021 successful
[ 1008.319680] sof-audio-pci 0000:00:1f.3: error: no reply expected, received 0x0
[ 1011.319881] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000010 timedout
[ 1011.319893] sof-audio-pci 0000:00:1f.3: error: load fw failed ret: -110
[ 1011.319929] sof-audio-pci 0000:00:1f.3: unknown ROM status value 06000010
[ 1011.319935] sof-audio-pci 0000:00:1f.3: error: status = 0x00000000 panic = 0x00000000
[ 1011.319939] sof-audio-pci 0000:00:1f.3: unknown ROM status value 06000010
[ 1011.319944] sof-audio-pci 0000:00:1f.3: error: failed to reset DSP
[ 1011.319948] sof-audio-pci 0000:00:1f.3: error: failed to boot DSP firmware after resume -110
[ 1011.319974] sof-audio-pci 0000:00:1f.3: ipc tx: 0x40010000: GLB_PM_MSG: CTX_SAVE
[ 1011.624128] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x40010000 size 76
[ 1011.624140] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[ 1011.624149] sof-audio-pci 0000:00:1f.3: error: status = 0x001d003c panic = 0x00000000
[ 1011.624155] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[ 1011.624165] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040001 mask 0x00000000
[ 1011.624169] sof-audio-pci 0000:00:1f.3: error: ctx_save ipc error during suspend -110
[ 1011.624186] PM: pci_pm_suspend(): snd_sof_suspend+0x0/0x10 [snd_sof] returns -110
[ 1011.624197] PM: dpm_run_callback(): pci_pm_suspend+0x0/0x120 returns -110
[ 1011.624203] PM: Device 0000:00:1f.3 failed to suspend: error -110
[ 1011.624208] PM: Some devices failed to suspend, or early wake event detected
[ 1011.624368] HDMI HDA Codec ehdaudio0D2: hdac_hdmi_present_sense: disconnect for pin:port 6:0
[ 1011.624389] HDMI HDA Codec ehdaudio0D2: hdac_hdmi_present_sense: disconnect for pin:port 7:0
[ 1011.803119] iwlwifi 0000:00:14.3: Conflict between TLV & NVM regarding enabling LAR (TLV = enabled NVM =disabled)
[ 1014.758481] ax88179_178a 2-1:1.0 enx000ec6a1e569: ax88179 - Link status is: 1
[ 1052.812334] OOM killer enabled.
[ 1052.812336] Restarting tasks ... done.
[ 1052.853482] PM: suspend exit

test_95.log

[ClarexZhou]

Error occurred during S3 without playback stress test.
FW load failed then CTX_save ipc timed out at 109th time. Can't enter S3 anymore and headset type selection query pops up.

Test Recipe
Kernel sof-dev : 96033e6 +PR1003
FW: 47dc14d https://github.com/lyakh/sof/tree/ipc-timeout
Topology: Same with FW.

dmesg:

[ 1673.591070] PM: suspend entry (s2idle)
[ 1673.591564] Filesystems sync: 0.000 seconds
[ 1673.591737] Freezing user space processes ... (elapsed 0.001 seconds) done.
[ 1673.593434] OOM killer disabled.
[ 1673.593434] Freezing remaining freezable tasks ... (elapsed 0.000 seconds) done.
[ 1673.594408] printk: Suspending console(s) (use no_console_suspend to debug)
[ 1673.709537] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000000 at  00000044
[ 1673.709541] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000040 at  00000048
[ 1673.709544] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000000 at  00000048
[ 1673.712449] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000000 at  00000048
[ 1673.712451] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000040 at  00000048
[ 1673.712453] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000040 at  00000048
[ 1673.712454] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000000 at  00000048
[ 1673.712456] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000000 at  00000048
[ 1673.712457] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000040 at  00000048
[ 1673.712509] sof-audio-pci 0000:00:1f.3: loading firmware
[ 1673.712511] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000002 at  00000048
[ 1673.712519] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000000 at  00000048
[ 1673.712522] sof-audio-pci 0000:00:1f.3: Debug PCIR: 00000000 at  00000044
[ 1673.712523] sof-audio-pci 0000:00:1f.3: Debug PCIW: 00000004 at  00000044
[ 1673.712524] sof-audio-pci 0000:00:1f.3: booting DSP firmware
[ 1673.712595] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x40000 successful
[ 1673.712607] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x40000 successful
[ 1673.712609] sof-audio-pci 0000:00:1f.3: period_bytes:0x0
[ 1673.712609] sof-audio-pci 0000:00:1f.3: periods:1
[ 1673.713165] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf0f0f0f successful
[ 1673.713180] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0xf0f0f0e successful
[ 1673.713186] sof-audio-pci 0000:00:1f.3: unstall/run core: core_mask = 1
[ 1673.713194] sof-audio-pci 0000:00:1f.3: DSP core(s) enabled? 1 : core_mask 1
[ 1673.713715] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x80000000 successful
[ 1673.713723] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x1010e0e successful
[ 1673.713732] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000021 successful
[ 1673.713864] sof-audio-pci 0000:00:1f.3: error: no reply expected, received 0x0
[ 1676.713999] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x6000010 timedout
[ 1676.714012] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x140000 successful
[ 1676.714018] sof-audio-pci 0000:00:1f.3: error: load fw failed ret: -110
[ 1676.714050] sof-audio-pci 0000:00:1f.3: unknown ROM status value 06000010
[ 1676.714057] sof-audio-pci 0000:00:1f.3: error: status = 0x00000000 panic = 0x00000000
[ 1676.714061] sof-audio-pci 0000:00:1f.3: unknown ROM status value 06000010
[ 1676.714066] sof-audio-pci 0000:00:1f.3: error: failed to reset DSP
[ 1676.714070] sof-audio-pci 0000:00:1f.3: error: failed to boot DSP firmware after resume -110
[ 1676.714097] sof-audio-pci 0000:00:1f.3: ipc tx: 0x40010000: GLB_PM_MSG: CTX_SAVE
[ 1677.017677] sof-audio-pci 0000:00:1f.3: error: ipc timed out for 0x40010000 size 76
[ 1677.017689] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[ 1677.017698] sof-audio-pci 0000:00:1f.3: error: status = 0x001d003c panic = 0x00000000
[ 1677.017703] sof-audio-pci 0000:00:1f.3: unknown ROM status value 01009701
[ 1677.017723] sof-audio-pci 0000:00:1f.3: error: hda irq intsts 0x00000000 intlctl 0x00000000 rirb 00
[ 1677.017726] sof-audio-pci 0000:00:1f.3: error: dsp irq ppsts 0x00000000 adspis 0x00000000
[ 1677.017738] sof-audio-pci 0000:00:1f.3: error: host status 0x00000000 dsp status 0x00040001 mask 0x00000000
[ 1677.017742] sof-audio-pci 0000:00:1f.3: ctx_save ipc error -110, proceeding with suspend
[ 1677.067910] sof-audio-pci 0000:00:1f.3: FW Poll Status: reg=0x1d003c timedout
[ 1677.067921] sof-audio-pci 0000:00:1f.3: error: reset enter failed: core_mask f adspcs 0x1d003c
[ 1677.067926] sof-audio-pci 0000:00:1f.3: error: dsp core reset failed: core_mask f
[ 1677.067928] sof-audio-pci 0000:00:1f.3: error: failed to power down core during suspend
[ 1677.067932] sof-audio-pci 0000:00:1f.3: error: suspending dsp
[ 1677.067936] sof-audio-pci 0000:00:1f.3: error: failed to power down DSP during suspend -5
[ 1677.067953] PM: pci_pm_suspend(): snd_sof_suspend+0x0/0x10 [snd_sof] returns -5
[ 1677.067965] PM: dpm_run_callback(): pci_pm_suspend+0x0/0x120 returns -5
[ 1677.067972] PM: Device 0000:00:1f.3 failed to suspend: error -5
[ 1677.067978] PM: Some devices failed to suspend, or early wake event detected
[ 1677.068086] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068092] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068096] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068100] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068104] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068108] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068111] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068114] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068118] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068121] sof-audio-pci 0000:00:1f.3: spurious response 0x0:0x0, last cmd=0x170500
[ 1677.068204] HDMI HDA Codec ehdaudio0D2: hdac_hdmi_present_sense: disconnect for pin:port 6:0
[ 1677.068229] HDMI HDA Codec ehdaudio0D2: hdac_hdmi_present_sense: disconnect for pin:port 7:0
[ 1677.250996] iwlwifi 0000:00:14.3: Conflict between TLV & NVM regarding enabling LAR (TLV = enabled NVM =disabled)
[ 1705.214024] OOM killer enabled.
[ 1705.214027] Restarting tasks ... done.
[ 1705.261756] PM: suspend exit

[ClarexZhou]

@lyakh kernel is using latest https://github.com/thesofproject/linux/commits/topic/sof-dev [Top commit: 96033e6 ] + PR1003