Bug 202585 - ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV]
Summary: ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV]
Status: CLOSED WILL_NOT_FIX
Alias: None
Product: ACPI
Classification: Unclassified
Component: BIOS (show other bugs)
Hardware: All Linux
: P1 normal
Assignee: Mario Limonciello
URL:
Keywords:
Depends on:
Blocks: 178231
  Show dependency tree
 
Reported: 2019-02-15 00:06 UTC by Todd Brandt
Modified: 2020-05-13 18:28 UTC (History)
2 users (show)

See Also:
Kernel Version: 5.0.0-rc5
Tree: Mainline
Regression: No


Attachments
otcpl-dell-p5510-xeon-1_mem.html (723.66 KB, text/html)
2019-02-15 00:07 UTC, Todd Brandt
Details
otcpl-dell-p5510-xeon-2_mem.html (854.12 KB, text/html)
2019-02-15 00:08 UTC, Todd Brandt
Details
dell-precision-5510-xeon-1-acpidump.out (938.84 KB, text/plain)
2019-02-19 22:42 UTC, Todd Brandt
Details
dell-precision-5510-xeon-2-acpidump.out (938.80 KB, text/plain)
2019-02-19 22:43 UTC, Todd Brandt
Details
otcpl-dell-p5510-xeon-1_bootdmesg.log (98.11 KB, text/plain)
2019-02-20 20:00 UTC, Todd Brandt
Details
otcpl-dell-p5510-xeon-2_bootdmesg.log (78.76 KB, text/plain)
2019-02-20 20:00 UTC, Todd Brandt
Details
issue.def (376 bytes, text/plain)
2020-05-13 18:28 UTC, Todd Brandt
Details

Description Todd Brandt 2019-02-15 00:06:53 UTC
We do 48+ hour stress testing each week on various machines with the latest upstream kernel. Our two Dell Precision 5510 machines have this issue approximately 5 times out of every 2000 tests (0.4% fail rate). It only occurs in S3 suspend/resume.

Here is the dmesg log snippet where the error occurs:

[95583.861796] PM: resume of devices complete after 1022.883 msecs
[95583.864827] acpi LNXPOWER:1b: Turning OFF
[95583.877239] ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV], AE_NOT_FOUND (20181213/psargs-330)
[95583.877270] 
[95583.877273]   Local0: 00000000677be56b <Obj>           Integer 0000000000000001
[95583.877286]   Local1: 000000002e7bf245 <Obj>           Integer 0000000000000001
[95583.877294]   Local2: 000000006f034898 <Obj>           Integer 0000000000000001
[95583.877303]   Local3: 00000000fdde280a <Obj>           Integer 0000000000000001
[95583.877311]   Local4: 000000001c00f842 <Obj>           Integer 0000000000000000
[95583.877319]   Local5: 00000000f8575737 <Obj>           Integer 0000000000000000
[95583.877327]   Local6: 000000004a7ca0c2 <Obj>           Integer 0000000000000000
[95583.877337] No Arguments are initialized for method [FNCL]
[95583.877342] ACPI Error: Method parse/execution failed \_TZ.FNCL, AE_NOT_FOUND (20181213/psparse-531)
[95583.877363] ACPI Error: Method parse/execution failed \_TZ.FN04._OFF, AE_NOT_FOUND (20181213/psparse-531)
[95583.877485] acpi LNXPOWER:1a: Turning OFF
[95583.889232] ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV], AE_NOT_FOUND (20181213/psargs-330)
[95583.889263] 
[95583.889266]   Local0: 00000000f8575737 <Obj>           Integer 0000000000000001
[95583.889279]   Local1: 0000000093d19097 <Obj>           Integer 0000000000000001
[95583.889287]   Local2: 000000006f034898 <Obj>           Integer 0000000000000001
[95583.889295]   Local3: 00000000fdde280a <Obj>           Integer 0000000000000000
[95583.889303]   Local4: 00000000677be56b <Obj>           Integer 0000000000000000
[95583.889311]   Local5: 000000004bc152cc <Obj>           Integer 0000000000000000
[95583.889319]   Local6: 000000004a7ca0c2 <Obj>           Integer 0000000000000000
[95583.889330] No Arguments are initialized for method [FNCL]
[95583.889335] ACPI Error: Method parse/execution failed \_TZ.FNCL, AE_NOT_FOUND (20181213/psparse-531)
[95583.889356] ACPI Error: Method parse/execution failed \_TZ.FN03._OFF, AE_NOT_FOUND (20181213/psparse-531)
[95583.889476] acpi LNXPOWER:19: Turning OFF
[95583.901232] ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV], AE_NOT_FOUND (20181213/psargs-330)
[95583.901263] 
[95583.901265]   Local0: 000000004bc152cc <Obj>           Integer 0000000000000001
[95583.901278]   Local1: 00000000ad5243df <Obj>           Integer 0000000000000001
[95583.901287]   Local2: 000000006f034898 <Obj>           Integer 0000000000000000
[95583.901295]   Local3: 00000000fdde280a <Obj>           Integer 0000000000000000
[95583.901303]   Local4: 00000000f8575737 <Obj>           Integer 0000000000000000
[95583.901311]   Local5: 000000004c0e10cd <Obj>           Integer 0000000000000000
[95583.901319]   Local6: 000000004a7ca0c2 <Obj>           Integer 0000000000000000
[95583.901329] No Arguments are initialized for method [FNCL]
[95583.901335] ACPI Error: Method parse/execution failed \_TZ.FNCL, AE_NOT_FOUND (20181213/psparse-531)
[95583.901356] ACPI Error: Method parse/execution failed \_TZ.FN02._OFF, AE_NOT_FOUND (20181213/psparse-531)
[95583.901476] acpi LNXPOWER:18: Turning OFF
[95583.913281] ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV], AE_NOT_FOUND (20181213/psargs-330)
[95583.913312] 
[95583.913315]   Local0: 000000004c0e10cd <Obj>           Integer 0000000000000001
[95583.913327]   Local1: 000000002e7bf245 <Obj>           Integer 0000000000000000
[95583.913335]   Local2: 000000006f034898 <Obj>           Integer 0000000000000000
[95583.913344]   Local3: 00000000fdde280a <Obj>           Integer 0000000000000000
[95583.913352]   Local4: 000000004bc152cc <Obj>           Integer 0000000000000000
[95583.913360]   Local5: 000000005b1d7087 <Obj>           Integer 0000000000000000
[95583.913368]   Local6: 000000004a7ca0c2 <Obj>           Integer 0000000000000000
[95583.913378] No Arguments are initialized for method [FNCL]
[95583.913383] ACPI Error: Method parse/execution failed \_TZ.FNCL, AE_NOT_FOUND (20181213/psparse-531)
[95583.913404] ACPI Error: Method parse/execution failed \_TZ.FN01._OFF, AE_NOT_FOUND (20181213/psparse-531)
[95583.913525] acpi LNXPOWER:17: Turning OFF
[95583.925258] ACPI BIOS Error (bug): Could not resolve [\_SB.PCI0.LPCB.HEC.ECAV], AE_NOT_FOUND (20181213/psargs-330)
[95583.925290] 
[95583.925293]   Local0: 000000005b1d7087 <Obj>           Integer 0000000000000000
[95583.925305]   Local1: 0000000093d19097 <Obj>           Integer 0000000000000000
[95583.925313]   Local2: 000000006f034898 <Obj>           Integer 0000000000000000
[95583.925322]   Local3: 00000000fdde280a <Obj>           Integer 0000000000000000
[95583.925330]   Local4: 000000004c0e10cd <Obj>           Integer 0000000000000000
[95583.925338]   Local5: 00000000282fe88a <Obj>           Integer 0000000000000000
[95583.925346]   Local6: 000000004a7ca0c2 <Obj>           Integer 0000000000000000
[95583.925356] No Arguments are initialized for method [FNCL]
[95583.925361] ACPI Error: Method parse/execution failed \_TZ.FNCL, AE_NOT_FOUND (20181213/psparse-531)
[95583.925382] ACPI Error: Method parse/execution failed \_TZ.FN00._OFF, AE_NOT_FOUND (20181213/psparse-531)
[95583.927984] PM: Finishing wakeup.
Comment 1 Todd Brandt 2019-02-15 00:07:41 UTC
Created attachment 281155 [details]
otcpl-dell-p5510-xeon-1_mem.html
Comment 2 Todd Brandt 2019-02-15 00:08:01 UTC
Created attachment 281157 [details]
otcpl-dell-p5510-xeon-2_mem.html
Comment 3 Todd Brandt 2019-02-19 22:42:53 UTC
Created attachment 281219 [details]
dell-precision-5510-xeon-1-acpidump.out
Comment 4 Todd Brandt 2019-02-19 22:43:11 UTC
Created attachment 281221 [details]
dell-precision-5510-xeon-2-acpidump.out
Comment 5 Todd Brandt 2019-02-20 19:45:53 UTC
P.S. the dmesg logs are embedded in the html timelines attached. Open them in a browser and click the "dmesg" button in the upper right hand corner.
Comment 6 Todd Brandt 2019-02-20 20:00:27 UTC
Created attachment 281237 [details]
otcpl-dell-p5510-xeon-1_bootdmesg.log
Comment 7 Todd Brandt 2019-02-20 20:00:56 UTC
Created attachment 281239 [details]
otcpl-dell-p5510-xeon-2_bootdmesg.log
Comment 8 Mario Limonciello 2019-03-07 17:03:56 UTC
Like 202583 please try to go into BIOS setup and turn off C-states and repeat this test run.  See if it happens again.
Comment 9 Todd Brandt 2019-04-01 18:28:44 UTC
I tried disabling cstate switching from the kernel command line and via sysfs. These are the changes I tried with a rerun of the stress test:

1) processor.max_cstate=0
2) intel_idle.max_cstate=0
3) processor.max_cstate=0 intel_idle.max_cstate=0
4) disable all but state0 via /sys/devices/system/cpu/cpuN/cpuidle/stateN/disable

No change.
Comment 10 Zhang Rui 2019-04-02 01:43:56 UTC
This is a BIOS bug.
$ grep ECAV *.dsl
ssdt6.dsl:    External (_SB_.PCI0.LPCB.H_EC.ECAV, IntObj)
ssdt6.dsl:            If ((\_SB.PCI0.LPCB.H_EC.ECAV && ETMD))
ssdt6.dsl:                If (\_SB.PCI0.LPCB.H_EC.ECAV)
ssdt6.dsl:                If (\_SB.PCI0.LPCB.H_EC.ECAV)
ssdt8.dsl:    External (_SB_.PCI0.LPCB.H_EC.ECAV, UnknownObj)
ssdt8.dsl:                        If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                        If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                        If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                        If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))
ssdt8.dsl:                If ((\_SB.PCI0.LPCB.H_EC.ECAV == One))

There is no definition of ECAV in any AML tables, thus we will get the ACPI warnings every time when \_TZ.FNCL is invoked (ACPI Fan is turned on).

The reason why this issue is seen 5 times out of every 2000 tests is because we turn on the ACPI Fan device only if the temperature is high after resume.
And apparently, the system does not overheat after resume most of the times.

I think we can close this bug report as it is a BIOS issue.
Mario, can you please raise this to BIOS team to get this fixed?
Comment 11 Todd Brandt 2020-05-13 18:28:35 UTC
Created attachment 289125 [details]
issue.def

Note You need to log in before you can comment on or make changes to this bug.