2012-10-31 01:44:31

by Greg Kroah-Hartman

[permalink] [raw]
Subject: ACPI errors with 3.7-rc3

Hi Len and Rafael,

With 3.7-rc3, I'm seeing a constant stream of these errors in the kernel
log for my MacBook Pro:

[30443.430133] ACPI: EC: input buffer is not empty, aborting transaction
[30443.430145] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
[30443.430162] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
[30443.430179] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
[30443.430188] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
[30443.430202] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)

They never showed up before in 3.7-rc2.

Anything I should try out to resolve this?

thanks,

greg k-h


2012-10-31 09:07:24

by Rafael J. Wysocki

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

Hi Greg,

On Tuesday, October 30, 2012 06:45:27 PM Greg KH wrote:
> Hi Len and Rafael,
>
> With 3.7-rc3, I'm seeing a constant stream of these errors in the kernel
> log for my MacBook Pro:
>
> [30443.430133] ACPI: EC: input buffer is not empty, aborting transaction
> [30443.430145] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> [30443.430162] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> [30443.430179] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> [30443.430188] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> [30443.430202] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
>
> They never showed up before in 3.7-rc2.
>
> Anything I should try out to resolve this?

Well, there are the following two post-3.6 EC-related commits:

commit 67bfa9b60bd689601554526d144b21d529f78a09
Author: Feng Tang <[email protected]>
Date: Fri Sep 28 15:22:01 2012 +0800

ACPI: EC: Add a quirk for CLEVO M720T/M730T laptop

commit a520d52e99b14ba7db135e916348f12f2a6e09be
Author: Feng Tang <[email protected]>
Date: Fri Sep 28 15:22:00 2012 +0800

ACPI: EC: Make the GPE storm threshold a module parameter

Can you please check if reverting the second one helps?

Rafael


--
I speak only for myself.
Rafael J. Wysocki, Intel Open Source Technology Center.

2012-10-31 17:33:44

by Greg Kroah-Hartman

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Wed, Oct 31, 2012 at 10:11:21AM +0100, Rafael J. Wysocki wrote:
> Hi Greg,
>
> On Tuesday, October 30, 2012 06:45:27 PM Greg KH wrote:
> > Hi Len and Rafael,
> >
> > With 3.7-rc3, I'm seeing a constant stream of these errors in the kernel
> > log for my MacBook Pro:
> >
> > [30443.430133] ACPI: EC: input buffer is not empty, aborting transaction
> > [30443.430145] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> > [30443.430162] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> > [30443.430179] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> > [30443.430188] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> > [30443.430202] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> >
> > They never showed up before in 3.7-rc2.
> >
> > Anything I should try out to resolve this?
>
> Well, there are the following two post-3.6 EC-related commits:
>
> commit 67bfa9b60bd689601554526d144b21d529f78a09
> Author: Feng Tang <[email protected]>
> Date: Fri Sep 28 15:22:01 2012 +0800
>
> ACPI: EC: Add a quirk for CLEVO M720T/M730T laptop
>
> commit a520d52e99b14ba7db135e916348f12f2a6e09be
> Author: Feng Tang <[email protected]>
> Date: Fri Sep 28 15:22:00 2012 +0800
>
> ACPI: EC: Make the GPE storm threshold a module parameter
>
> Can you please check if reverting the second one helps?

That last one seems like it would be it, if the module parameter got
changed. And now I can't duplicate it at all, 3.7-rc3 works fine. Ick,
sorry for the noise, I don't know what happened. If I see the above
errors again, I'll let you know, and I'll also check the ec module
parameter first to ensure it didn't change from the default of 8.

thanks,

greg k-h

2012-11-06 12:42:28

by Azat Khuzhin

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

I'v also have such errors on my macbook pro.

$ dmesg | tail
[17056.008564] ACPI Error: Method parse/execution failed
[\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
(20120711/psparse-536)
[17056.011194] ACPI Error: Method parse/execution failed
[\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
(20120711/psparse-536)
[17056.013793] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
[17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
[17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
[EmbeddedControl] (20120711/evregion-501)
[17056.515256] ACPI Error: Method parse/execution failed
[\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
(20120711/psparse-536)
[17056.517886] ACPI Error: Method parse/execution failed
[\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
(20120711/psparse-536)
[17056.520479] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)

And also loadavg is too high ~ 10
While there is no process that load CPU up to 100% or like that.
I think that this because of processes that is done in kernel space.
(basically that one who write such errors)

$ uname -a
Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
12:39:03 UTC 2012 x86_64 GNU/Linux

On Wed, Oct 31, 2012 at 9:33 PM, Greg KH <[email protected]> wrote:
> On Wed, Oct 31, 2012 at 10:11:21AM +0100, Rafael J. Wysocki wrote:
>> Hi Greg,
>>
>> On Tuesday, October 30, 2012 06:45:27 PM Greg KH wrote:
>> > Hi Len and Rafael,
>> >
>> > With 3.7-rc3, I'm seeing a constant stream of these errors in the kernel
>> > log for my MacBook Pro:
>> >
>> > [30443.430133] ACPI: EC: input buffer is not empty, aborting transaction
>> > [30443.430145] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
>> > [30443.430162] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
>> > [30443.430179] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
>> > [30443.430188] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
>> > [30443.430202] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
>> >
>> > They never showed up before in 3.7-rc2.
>> >
>> > Anything I should try out to resolve this?
>>
>> Well, there are the following two post-3.6 EC-related commits:
>>
>> commit 67bfa9b60bd689601554526d144b21d529f78a09
>> Author: Feng Tang <[email protected]>
>> Date: Fri Sep 28 15:22:01 2012 +0800
>>
>> ACPI: EC: Add a quirk for CLEVO M720T/M730T laptop
>>
>> commit a520d52e99b14ba7db135e916348f12f2a6e09be
>> Author: Feng Tang <[email protected]>
>> Date: Fri Sep 28 15:22:00 2012 +0800
>>
>> ACPI: EC: Make the GPE storm threshold a module parameter
>>
>> Can you please check if reverting the second one helps?
>
> That last one seems like it would be it, if the module parameter got
> changed. And now I can't duplicate it at all, 3.7-rc3 works fine. Ick,
> sorry for the noise, I don't know what happened. If I see the above
> errors again, I'll let you know, and I'll also check the ec module
> parameter first to ensure it didn't change from the default of 8.
>
> thanks,
>
> greg k-h
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to [email protected]
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/



--
Azat Khuzhin

2012-11-06 12:48:21

by Greg Kroah-Hartman

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> I'v also have such errors on my macbook pro.
>
> $ dmesg | tail
> [17056.008564] ACPI Error: Method parse/execution failed
> [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> (20120711/psparse-536)
> [17056.011194] ACPI Error: Method parse/execution failed
> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> (20120711/psparse-536)
> [17056.013793] ACPI Error: Method parse/execution failed
> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> (20120711/psparse-536)
> [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
> [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
> [EmbeddedControl] (20120711/evregion-501)
> [17056.515256] ACPI Error: Method parse/execution failed
> [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> (20120711/psparse-536)
> [17056.517886] ACPI Error: Method parse/execution failed
> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> (20120711/psparse-536)
> [17056.520479] ACPI Error: Method parse/execution failed
> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> (20120711/psparse-536)
> [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)

I'm seeing this again right now. I'm wondering if it's because I'm
running on battery power at the moment:

[41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
[41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
[41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
[41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
[41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
[41694.809093] ACPI: EC: input buffer is not empty, aborting transaction

ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
not the issue here.

> And also loadavg is too high ~ 10
> While there is no process that load CPU up to 100% or like that.
> I think that this because of processes that is done in kernel space.
> (basically that one who write such errors)
>
> $ uname -a
> Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> 12:39:03 UTC 2012 x86_64 GNU/Linux

Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
worked properly for this hardware :)

So it's not a regression, just an ACPI issue, any ACPI developer have an idea
about this?

thanks,

greg k-h

2012-11-06 13:04:28

by Azat Khuzhin

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

When this messages appears, I was running from AC, not from battery.

On Tue, Nov 6, 2012 at 4:48 PM, Greg KH <[email protected]> wrote:
> On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
>> I'v also have such errors on my macbook pro.
>>
>> $ dmesg | tail
>> [17056.008564] ACPI Error: Method parse/execution failed
>> [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
>> (20120711/psparse-536)
>> [17056.011194] ACPI Error: Method parse/execution failed
>> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> (20120711/psparse-536)
>> [17056.013793] ACPI Error: Method parse/execution failed
>> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> (20120711/psparse-536)
>> [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
>> [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
>> [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
>> [EmbeddedControl] (20120711/evregion-501)
>> [17056.515256] ACPI Error: Method parse/execution failed
>> [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
>> (20120711/psparse-536)
>> [17056.517886] ACPI Error: Method parse/execution failed
>> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> (20120711/psparse-536)
>> [17056.520479] ACPI Error: Method parse/execution failed
>> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> (20120711/psparse-536)
>> [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
>
> I'm seeing this again right now. I'm wondering if it's because I'm
> running on battery power at the moment:
>
> [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
>
> ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
> not the issue here.
>
>> And also loadavg is too high ~ 10
>> While there is no process that load CPU up to 100% or like that.
>> I think that this because of processes that is done in kernel space.
>> (basically that one who write such errors)
>>
>> $ uname -a
>> Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
>> 12:39:03 UTC 2012 x86_64 GNU/Linux
>
> Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
> worked properly for this hardware :)
>
> So it's not a regression, just an ACPI issue, any ACPI developer have an idea
> about this?
>
> thanks,
>
> greg k-h



--
Azat Khuzhin

2012-11-07 21:45:40

by Rafael J. Wysocki

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > I'v also have such errors on my macbook pro.
> >
> > $ dmesg | tail
> > [17056.008564] ACPI Error: Method parse/execution failed
> > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > (20120711/psparse-536)
> > [17056.011194] ACPI Error: Method parse/execution failed
> > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > (20120711/psparse-536)
> > [17056.013793] ACPI Error: Method parse/execution failed
> > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > (20120711/psparse-536)
> > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> > [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
> > [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
> > [EmbeddedControl] (20120711/evregion-501)
> > [17056.515256] ACPI Error: Method parse/execution failed
> > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > (20120711/psparse-536)
> > [17056.517886] ACPI Error: Method parse/execution failed
> > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > (20120711/psparse-536)
> > [17056.520479] ACPI Error: Method parse/execution failed
> > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > (20120711/psparse-536)
> > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
>
> I'm seeing this again right now. I'm wondering if it's because I'm
> running on battery power at the moment:
>
> [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
>
> ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
> not the issue here.
>
> > And also loadavg is too high ~ 10
> > While there is no process that load CPU up to 100% or like that.
> > I think that this because of processes that is done in kernel space.
> > (basically that one who write such errors)
> >
> > $ uname -a
> > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > 12:39:03 UTC 2012 x86_64 GNU/Linux
>
> Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
> worked properly for this hardware :)
>
> So it's not a regression, just an ACPI issue, any ACPI developer have an idea
> about this?

Can you please send the output of acpidump from the affected machine(s)?

Rafael


--
I speak only for myself.
Rafael J. Wysocki, Intel Open Source Technology Center.

2012-11-08 04:47:03

by Greg Kroah-Hartman

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Wed, Nov 07, 2012 at 10:49:40PM +0100, Rafael J. Wysocki wrote:
> On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > I'v also have such errors on my macbook pro.
> > >
> > > $ dmesg | tail
> > > [17056.008564] ACPI Error: Method parse/execution failed
> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.011194] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.013793] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> > > [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
> > > [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
> > > [EmbeddedControl] (20120711/evregion-501)
> > > [17056.515256] ACPI Error: Method parse/execution failed
> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.517886] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.520479] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> >
> > I'm seeing this again right now. I'm wondering if it's because I'm
> > running on battery power at the moment:
> >
> > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> > [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> > [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> > [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
> >
> > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
> > not the issue here.
> >
> > > And also loadavg is too high ~ 10
> > > While there is no process that load CPU up to 100% or like that.
> > > I think that this because of processes that is done in kernel space.
> > > (basically that one who write such errors)
> > >
> > > $ uname -a
> > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> >
> > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
> > worked properly for this hardware :)
> >
> > So it's not a regression, just an ACPI issue, any ACPI developer have an idea
> > about this?
>
> Can you please send the output of acpidump from the affected machine(s)?

# ./acpidump
ACPI tables were not found. If you know location of RSD PTR table (from dmesg, etc), supply it with either --addr or -a option

What am I doing wrong here?

Is there a newer version of pmtools than the one labled pmtools-20071116
that I should be using? A link to download it would be appreciated.

thanks,

greg k-h

2012-11-08 09:15:22

by Azat Khuzhin

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

Here is mine - https://gist.github.com/4037687

To Greg:
acpidump 20100513-3.1
And I don't have pmtools installed

On Thu, Nov 8, 2012 at 8:47 AM, Greg KH <[email protected]> wrote:
> On Wed, Nov 07, 2012 at 10:49:40PM +0100, Rafael J. Wysocki wrote:
>> On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
>> > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
>> > > I'v also have such errors on my macbook pro.
>> > >
>> > > $ dmesg | tail
>> > > [17056.008564] ACPI Error: Method parse/execution failed
>> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.011194] ACPI Error: Method parse/execution failed
>> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.013793] ACPI Error: Method parse/execution failed
>> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
>> > > [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
>> > > [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
>> > > [EmbeddedControl] (20120711/evregion-501)
>> > > [17056.515256] ACPI Error: Method parse/execution failed
>> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.517886] ACPI Error: Method parse/execution failed
>> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.520479] ACPI Error: Method parse/execution failed
>> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> > > (20120711/psparse-536)
>> > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
>> >
>> > I'm seeing this again right now. I'm wondering if it's because I'm
>> > running on battery power at the moment:
>> >
>> > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
>> > [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
>> > [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
>> > [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
>> > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
>> > [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
>> >
>> > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
>> > not the issue here.
>> >
>> > > And also loadavg is too high ~ 10
>> > > While there is no process that load CPU up to 100% or like that.
>> > > I think that this because of processes that is done in kernel space.
>> > > (basically that one who write such errors)
>> > >
>> > > $ uname -a
>> > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
>> > > 12:39:03 UTC 2012 x86_64 GNU/Linux
>> >
>> > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
>> > worked properly for this hardware :)
>> >
>> > So it's not a regression, just an ACPI issue, any ACPI developer have an idea
>> > about this?
>>
>> Can you please send the output of acpidump from the affected machine(s)?
>
> # ./acpidump
> ACPI tables were not found. If you know location of RSD PTR table (from dmesg, etc), supply it with either --addr or -a option
>
> What am I doing wrong here?
>
> Is there a newer version of pmtools than the one labled pmtools-20071116
> that I should be using? A link to download it would be appreciated.
>
> thanks,
>
> greg k-h



--
Azat Khuzhin

2012-11-08 09:23:40

by Rafael J. Wysocki

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Thursday, November 08, 2012 05:47:15 AM Greg KH wrote:
> On Wed, Nov 07, 2012 at 10:49:40PM +0100, Rafael J. Wysocki wrote:
> > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > > I'v also have such errors on my macbook pro.
> > > >
> > > > $ dmesg | tail
> > > > [17056.008564] ACPI Error: Method parse/execution failed
> > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.011194] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.013793] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> > > > [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
> > > > [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
> > > > [EmbeddedControl] (20120711/evregion-501)
> > > > [17056.515256] ACPI Error: Method parse/execution failed
> > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.517886] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.520479] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> > >
> > > I'm seeing this again right now. I'm wondering if it's because I'm
> > > running on battery power at the moment:
> > >
> > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> > > [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> > > [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> > > [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> > > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > > [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
> > >
> > > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
> > > not the issue here.
> > >
> > > > And also loadavg is too high ~ 10
> > > > While there is no process that load CPU up to 100% or like that.
> > > > I think that this because of processes that is done in kernel space.
> > > > (basically that one who write such errors)
> > > >
> > > > $ uname -a
> > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> > >
> > > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
> > > worked properly for this hardware :)
> > >
> > > So it's not a regression, just an ACPI issue, any ACPI developer have an idea
> > > about this?
> >
> > Can you please send the output of acpidump from the affected machine(s)?
>
> # ./acpidump
> ACPI tables were not found. If you know location of RSD PTR table (from dmesg, etc), supply it with either --addr or -a option
>
> What am I doing wrong here?
>
> Is there a newer version of pmtools than the one labled pmtools-20071116
> that I should be using? A link to download it would be appreciated.

On my system, which is a reasonably current Tumbleweed, acpidump is in the
acpica-20120518-7.1.2.x86_64 package.

Thanks,
Rafael


--
I speak only for myself.
Rafael J. Wysocki, Intel Open Source Technology Center.

2012-11-09 09:29:27

by Feng Tang

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
> On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > I'v also have such errors on my macbook pro.
> > >
> > > $ dmesg | tail
> > > [17056.008564] ACPI Error: Method parse/execution failed
> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.011194] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.013793] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> > > [17056.511373] ACPI: EC: input buffer is not empty, aborting transaction
> > > [17056.512672] ACPI Exception: AE_TIME, Returned by Handler for
> > > [EmbeddedControl] (20120711/evregion-501)
> > > [17056.515256] ACPI Error: Method parse/execution failed
> > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.517886] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.520479] ACPI Error: Method parse/execution failed
> > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > (20120711/psparse-536)
> > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
> >
> > I'm seeing this again right now. I'm wondering if it's because I'm
> > running on battery power at the moment:
> >
> > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120913/evregion-501)
> > [41694.309282] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> > [41694.309300] ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME (20120913/psparse-536)
> > [41694.309310] ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > [41694.809093] ACPI: EC: input buffer is not empty, aborting transaction
> >
> > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/ so that's
> > not the issue here.
> >
> > > And also loadavg is too high ~ 10
> > > While there is no process that load CPU up to 100% or like that.
> > > I think that this because of processes that is done in kernel space.
> > > (basically that one who write such errors)
> > >
> > > $ uname -a
> > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> >
> > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's just never
> > worked properly for this hardware :)
> >
> > So it's not a regression, just an ACPI issue, any ACPI developer have an idea
> > about this?
>
> Can you please send the output of acpidump from the affected machine(s)?

I doubt this problem is sometimes inevitable for some machines, because
AFAIK most modern machines have the race problem for EC HW controller,
as both OS side and the BIOS may access the EC HW at the same time
without any race control.

For this case, usually the battery and thermal modules (which may be
controlled through EC) are always monitored by BIOS, when OS also
frequently visit them too, the EC's own state machine may be broken
and not responsive due to the race, then cause the timeout error.
And how severe the problem will be depends on the EC HW, the quality
of BIOS code and OS/driver code.

Myself have seen the similar "ACPI: EC: input buffer is not empty,
aborting transaction" error message on one laptop when its EC is
busy visited by OS.

btw, in EC driver I see a "ec->global_lock", don't know if it was
designed to control the race between OS and BIOS.

Thanks,
Feng

2012-11-09 14:31:01

by Moore, Robert

[permalink] [raw]
Subject: RE: ACPI errors with 3.7-rc3

The ACPI Global Lock is in fact intended to provide exclusion between the BIOS and the OS.
Bob


> -----Original Message-----
> From: Tang, Feng
> Sent: Friday, November 09, 2012 1:29 AM
> To: Rafael J. Wysocki
> Cc: Greg KH; Azat Khuzhin; [email protected]; Linux Kernel
> Mailing List; Zheng, Lv; Len Brown; Moore, Robert
> Subject: Re: ACPI errors with 3.7-rc3
>
> On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
> > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > > I'v also have such errors on my macbook pro.
> > > >
> > > > $ dmesg | tail
> > > > [17056.008564] ACPI Error: Method parse/execution failed
> > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.011194] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.013793] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
> > > > (20120711/battery-464) [17056.511373] ACPI: EC: input buffer is
> > > > not empty, aborting transaction [17056.512672] ACPI Exception:
> > > > AE_TIME, Returned by Handler for [EmbeddedControl]
> > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
> > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
> > > > ffff88026547ea10), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.517886] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.520479] ACPI Error: Method parse/execution failed
> > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > (20120711/psparse-536)
> > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
> > > > (20120711/battery-464)
> > >
> > > I'm seeing this again right now. I'm wondering if it's because I'm
> > > running on battery power at the moment:
> > >
> > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for
> > > [EmbeddedControl] (20120913/evregion-501) [41694.309282] ACPI Error:
> > > Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
> > > ffff88045cc64618), AE_TIME (20120913/psparse-536) [41694.309300]
> > > ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node
> > > ffff88045cc64988), AE_TIME (20120913/psparse-536) [41694.309310]
> > > ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node
> > > ffff88045cc648c0), AE_TIME (20120913/psparse-536) [41694.309324]
> > > ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > > [41694.809093] ACPI: EC: input buffer is not empty, aborting
> > > transaction
> > >
> > > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/
> > > so that's not the issue here.
> > >
> > > > And also loadavg is too high ~ 10
> > > > While there is no process that load CPU up to 100% or like that.
> > > > I think that this because of processes that is done in kernel space.
> > > > (basically that one who write such errors)
> > > >
> > > > $ uname -a
> > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> > >
> > > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's
> > > just never worked properly for this hardware :)
> > >
> > > So it's not a regression, just an ACPI issue, any ACPI developer
> > > have an idea about this?
> >
> > Can you please send the output of acpidump from the affected machine(s)?
>
> I doubt this problem is sometimes inevitable for some machines, because
> AFAIK most modern machines have the race problem for EC HW controller, as
> both OS side and the BIOS may access the EC HW at the same time
> without any race control.
>
> For this case, usually the battery and thermal modules (which may be
> controlled through EC) are always monitored by BIOS, when OS also
> frequently visit them too, the EC's own state machine may be broken and
> not responsive due to the race, then cause the timeout error.
> And how severe the problem will be depends on the EC HW, the quality of
> BIOS code and OS/driver code.
>
> Myself have seen the similar "ACPI: EC: input buffer is not empty,
> aborting transaction" error message on one laptop when its EC is busy
> visited by OS.
>
> btw, in EC driver I see a "ec->global_lock", don't know if it was designed
> to control the race between OS and BIOS.
>
> Thanks,
> Feng

2012-11-09 16:37:26

by Feng Tang

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
> The ACPI Global Lock is in fact intended to provide exclusion between the BIOS and the OS.
> Bob

Thanks for the info.

And per my check, most of ACPI FW don't implement this lock, say
after driver probe, the ec->global_lock will be 0.

- Feng

>
>
> > -----Original Message-----
> > From: Tang, Feng
> > Sent: Friday, November 09, 2012 1:29 AM
> > To: Rafael J. Wysocki
> > Cc: Greg KH; Azat Khuzhin; [email protected]; Linux Kernel
> > Mailing List; Zheng, Lv; Len Brown; Moore, Robert
> > Subject: Re: ACPI errors with 3.7-rc3
> >
> > On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
> > > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > > > I'v also have such errors on my macbook pro.
> > > > >
> > > > > $ dmesg | tail
> > > > > [17056.008564] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.011194] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.013793] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
> > > > > (20120711/battery-464) [17056.511373] ACPI: EC: input buffer is
> > > > > not empty, aborting transaction [17056.512672] ACPI Exception:
> > > > > AE_TIME, Returned by Handler for [EmbeddedControl]
> > > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
> > > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
> > > > > ffff88026547ea10), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.517886] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.520479] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > > (20120711/psparse-536)
> > > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
> > > > > (20120711/battery-464)
> > > >
> > > > I'm seeing this again right now. I'm wondering if it's because I'm
> > > > running on battery power at the moment:
> > > >
> > > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for
> > > > [EmbeddedControl] (20120913/evregion-501) [41694.309282] ACPI Error:
> > > > Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
> > > > ffff88045cc64618), AE_TIME (20120913/psparse-536) [41694.309300]
> > > > ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node
> > > > ffff88045cc64988), AE_TIME (20120913/psparse-536) [41694.309310]
> > > > ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node
> > > > ffff88045cc648c0), AE_TIME (20120913/psparse-536) [41694.309324]
> > > > ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > > > [41694.809093] ACPI: EC: input buffer is not empty, aborting
> > > > transaction
> > > >
> > > > ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/
> > > > so that's not the issue here.
> > > >
> > > > > And also loadavg is too high ~ 10
> > > > > While there is no process that load CPU up to 100% or like that.
> > > > > I think that this because of processes that is done in kernel space.
> > > > > (basically that one who write such errors)
> > > > >
> > > > > $ uname -a
> > > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
> > > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> > > >
> > > > Ah, ok, that means it's not something new in 3.7-rc, so maybe it's
> > > > just never worked properly for this hardware :)
> > > >
> > > > So it's not a regression, just an ACPI issue, any ACPI developer
> > > > have an idea about this?
> > >
> > > Can you please send the output of acpidump from the affected machine(s)?
> >
> > I doubt this problem is sometimes inevitable for some machines, because
> > AFAIK most modern machines have the race problem for EC HW controller, as
> > both OS side and the BIOS may access the EC HW at the same time
> > without any race control.
> >
> > For this case, usually the battery and thermal modules (which may be
> > controlled through EC) are always monitored by BIOS, when OS also
> > frequently visit them too, the EC's own state machine may be broken and
> > not responsive due to the race, then cause the timeout error.
> > And how severe the problem will be depends on the EC HW, the quality of
> > BIOS code and OS/driver code.
> >
> > Myself have seen the similar "ACPI: EC: input buffer is not empty,
> > aborting transaction" error message on one laptop when its EC is busy
> > visited by OS.
> >
> > btw, in EC driver I see a "ec->global_lock", don't know if it was designed
> > to control the race between OS and BIOS.
> >
> > Thanks,
> > Feng

2012-11-09 16:46:05

by Moore, Robert

[permalink] [raw]
Subject: RE: ACPI errors with 3.7-rc3

> And per my check, most of ACPI FW don't implement this lock, say after
> driver probe, the ec->global_lock will be 0

Take a look at the FACS table, it contains the address of the global lock.

I believe that the ACPI specification requires that the global lock be present.



> -----Original Message-----
> From: Tang, Feng
> Sent: Friday, November 09, 2012 8:36 AM
> To: Moore, Robert
> Cc: Rafael J. Wysocki; Greg KH; Azat Khuzhin; [email protected];
> Linux Kernel Mailing List; Zheng, Lv; Len Brown
> Subject: Re: ACPI errors with 3.7-rc3
>
> On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
> > The ACPI Global Lock is in fact intended to provide exclusion between
> the BIOS and the OS.
> > Bob
>
> Thanks for the info.
>
> And per my check, most of ACPI FW don't implement this lock, say after
> driver probe, the ec->global_lock will be 0.
>
> - Feng
>
> >
> >
> > > -----Original Message-----
> > > From: Tang, Feng
> > > Sent: Friday, November 09, 2012 1:29 AM
> > > To: Rafael J. Wysocki
> > > Cc: Greg KH; Azat Khuzhin; [email protected]; Linux Kernel
> > > Mailing List; Zheng, Lv; Len Brown; Moore, Robert
> > > Subject: Re: ACPI errors with 3.7-rc3
> > >
> > > On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
> > > > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> > > > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> > > > > > I'v also have such errors on my macbook pro.
> > > > > >
> > > > > > $ dmesg | tail
> > > > > > [17056.008564] ACPI Error: Method parse/execution failed
> > > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10),
> > > > > > AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.011194] ACPI Error: Method parse/execution failed
> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.013793] ACPI Error: Method parse/execution failed
> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
> > > > > > (20120711/battery-464) [17056.511373] ACPI: EC: input buffer
> > > > > > is not empty, aborting transaction [17056.512672] ACPI
> Exception:
> > > > > > AE_TIME, Returned by Handler for [EmbeddedControl]
> > > > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
> > > > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
> > > > > > ffff88026547ea10), AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.517886] ACPI Error: Method parse/execution failed
> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.520479] ACPI Error: Method parse/execution failed
> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> > > > > > (20120711/psparse-536)
> > > > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
> > > > > > (20120711/battery-464)
> > > > >
> > > > > I'm seeing this again right now. I'm wondering if it's because
> > > > > I'm running on battery power at the moment:
> > > > >
> > > > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for
> > > > > [EmbeddedControl] (20120913/evregion-501) [41694.309282] ACPI
> Error:
> > > > > Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW]
> > > > > (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
> > > > > [41694.309300] ACPI Error: Method parse/execution failed
> > > > > [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME
> > > > > (20120913/psparse-536) [41694.309310] ACPI Error: Method
> > > > > parse/execution failed [\_SB_.BAT0._BST] (Node
> > > > > ffff88045cc648c0), AE_TIME (20120913/psparse-536) [41694.309324]
> > > > > ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
> > > > > [41694.809093] ACPI: EC: input buffer is not empty, aborting
> > > > > transaction
> > > > >
> > > > > ec_storm_threshold is still set to 8 in
> > > > > /sys/module/acpi/parameters/ so that's not the issue here.
> > > > >
> > > > > > And also loadavg is too high ~ 10 While there is no process
> > > > > > that load CPU up to 100% or like that.
> > > > > > I think that this because of processes that is done in kernel
> space.
> > > > > > (basically that one who write such errors)
> > > > > >
> > > > > > $ uname -a
> > > > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun
> > > > > > Nov 4
> > > > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> > > > >
> > > > > Ah, ok, that means it's not something new in 3.7-rc, so maybe
> > > > > it's just never worked properly for this hardware :)
> > > > >
> > > > > So it's not a regression, just an ACPI issue, any ACPI developer
> > > > > have an idea about this?
> > > >
> > > > Can you please send the output of acpidump from the affected
> machine(s)?
> > >
> > > I doubt this problem is sometimes inevitable for some machines,
> > > because AFAIK most modern machines have the race problem for EC HW
> > > controller, as both OS side and the BIOS may access the EC HW at the
> > > same time without any race control.
> > >
> > > For this case, usually the battery and thermal modules (which may be
> > > controlled through EC) are always monitored by BIOS, when OS also
> > > frequently visit them too, the EC's own state machine may be broken
> > > and not responsive due to the race, then cause the timeout error.
> > > And how severe the problem will be depends on the EC HW, the quality
> > > of BIOS code and OS/driver code.
> > >
> > > Myself have seen the similar "ACPI: EC: input buffer is not empty,
> > > aborting transaction" error message on one laptop when its EC is
> > > busy visited by OS.
> > >
> > > btw, in EC driver I see a "ec->global_lock", don't know if it was
> > > designed to control the race between OS and BIOS.
> > >
> > > Thanks,
> > > Feng

2012-11-11 10:00:57

by Azat Khuzhin

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

Robert,

You say that FACS table contains the address of the global lock.
But in my case https://gist.github.com/4037687 it seems to be empty,
so this means that my laptop don't have global lock?

On Fri, Nov 9, 2012 at 8:45 PM, Moore, Robert <[email protected]> wrote:
>> And per my check, most of ACPI FW don't implement this lock, say after
>> driver probe, the ec->global_lock will be 0
>
> Take a look at the FACS table, it contains the address of the global lock.
>
> I believe that the ACPI specification requires that the global lock be present.
>
>
>
>> -----Original Message-----
>> From: Tang, Feng
>> Sent: Friday, November 09, 2012 8:36 AM
>> To: Moore, Robert
>> Cc: Rafael J. Wysocki; Greg KH; Azat Khuzhin; [email protected];
>> Linux Kernel Mailing List; Zheng, Lv; Len Brown
>> Subject: Re: ACPI errors with 3.7-rc3
>>
>> On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
>> > The ACPI Global Lock is in fact intended to provide exclusion between
>> the BIOS and the OS.
>> > Bob
>>
>> Thanks for the info.
>>
>> And per my check, most of ACPI FW don't implement this lock, say after
>> driver probe, the ec->global_lock will be 0.
>>
>> - Feng
>>
>> >
>> >
>> > > -----Original Message-----
>> > > From: Tang, Feng
>> > > Sent: Friday, November 09, 2012 1:29 AM
>> > > To: Rafael J. Wysocki
>> > > Cc: Greg KH; Azat Khuzhin; [email protected]; Linux Kernel
>> > > Mailing List; Zheng, Lv; Len Brown; Moore, Robert
>> > > Subject: Re: ACPI errors with 3.7-rc3
>> > >
>> > > On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
>> > > > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
>> > > > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
>> > > > > > I'v also have such errors on my macbook pro.
>> > > > > >
>> > > > > > $ dmesg | tail
>> > > > > > [17056.008564] ACPI Error: Method parse/execution failed
>> > > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10),
>> > > > > > AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.011194] ACPI Error: Method parse/execution failed
>> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.013793] ACPI Error: Method parse/execution failed
>> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
>> > > > > > (20120711/battery-464) [17056.511373] ACPI: EC: input buffer
>> > > > > > is not empty, aborting transaction [17056.512672] ACPI
>> Exception:
>> > > > > > AE_TIME, Returned by Handler for [EmbeddedControl]
>> > > > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
>> > > > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
>> > > > > > ffff88026547ea10), AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.517886] ACPI Error: Method parse/execution failed
>> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.520479] ACPI Error: Method parse/execution failed
>> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> > > > > > (20120711/psparse-536)
>> > > > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
>> > > > > > (20120711/battery-464)
>> > > > >
>> > > > > I'm seeing this again right now. I'm wondering if it's because
>> > > > > I'm running on battery power at the moment:
>> > > > >
>> > > > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for
>> > > > > [EmbeddedControl] (20120913/evregion-501) [41694.309282] ACPI
>> Error:
>> > > > > Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW]
>> > > > > (Node ffff88045cc64618), AE_TIME (20120913/psparse-536)
>> > > > > [41694.309300] ACPI Error: Method parse/execution failed
>> > > > > [\_SB_.BAT0.UBST] (Node ffff88045cc64988), AE_TIME
>> > > > > (20120913/psparse-536) [41694.309310] ACPI Error: Method
>> > > > > parse/execution failed [\_SB_.BAT0._BST] (Node
>> > > > > ffff88045cc648c0), AE_TIME (20120913/psparse-536) [41694.309324]
>> > > > > ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
>> > > > > [41694.809093] ACPI: EC: input buffer is not empty, aborting
>> > > > > transaction
>> > > > >
>> > > > > ec_storm_threshold is still set to 8 in
>> > > > > /sys/module/acpi/parameters/ so that's not the issue here.
>> > > > >
>> > > > > > And also loadavg is too high ~ 10 While there is no process
>> > > > > > that load CPU up to 100% or like that.
>> > > > > > I think that this because of processes that is done in kernel
>> space.
>> > > > > > (basically that one who write such errors)
>> > > > > >
>> > > > > > $ uname -a
>> > > > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun
>> > > > > > Nov 4
>> > > > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
>> > > > >
>> > > > > Ah, ok, that means it's not something new in 3.7-rc, so maybe
>> > > > > it's just never worked properly for this hardware :)
>> > > > >
>> > > > > So it's not a regression, just an ACPI issue, any ACPI developer
>> > > > > have an idea about this?
>> > > >
>> > > > Can you please send the output of acpidump from the affected
>> machine(s)?
>> > >
>> > > I doubt this problem is sometimes inevitable for some machines,
>> > > because AFAIK most modern machines have the race problem for EC HW
>> > > controller, as both OS side and the BIOS may access the EC HW at the
>> > > same time without any race control.
>> > >
>> > > For this case, usually the battery and thermal modules (which may be
>> > > controlled through EC) are always monitored by BIOS, when OS also
>> > > frequently visit them too, the EC's own state machine may be broken
>> > > and not responsive due to the race, then cause the timeout error.
>> > > And how severe the problem will be depends on the EC HW, the quality
>> > > of BIOS code and OS/driver code.
>> > >
>> > > Myself have seen the similar "ACPI: EC: input buffer is not empty,
>> > > aborting transaction" error message on one laptop when its EC is
>> > > busy visited by OS.
>> > >
>> > > btw, in EC driver I see a "ec->global_lock", don't know if it was
>> > > designed to control the race between OS and BIOS.
>> > >
>> > > Thanks,
>> > > Feng



--
Azat Khuzhin

2012-11-13 00:41:24

by Moore, Robert

[permalink] [raw]
Subject: RE: ACPI errors with 3.7-rc3

Actually, it is not the address of the global lock, the FACS contains the actual global lock:

>From acpi5.0 spec:

ROM BIOS. The Global Lock is a 32-bit (DWORD) value in read/write memory located within the FACS and is accessed and updated by both the OS environment and the SMI environment in a defined manner to provide an exclusive lock. Note: this is not a pointer to the Global Lock, it is the actual memory location of the lock. The FACS and Global Lock may be located anywhere in physical memory.




> -----Original Message-----
> From: [email protected] [mailto:[email protected]] On Behalf Of Azat
> Khuzhin
> Sent: Sunday, November 11, 2012 2:01 AM
> To: Moore, Robert
> Cc: Tang, Feng; Rafael J. Wysocki; Greg KH; [email protected];
> Linux Kernel Mailing List; Zheng, Lv; Len Brown
> Subject: Re: ACPI errors with 3.7-rc3
>
> Robert,
>
> You say that FACS table contains the address of the global lock.
> But in my case https://gist.github.com/4037687 it seems to be empty, so
> this means that my laptop don't have global lock?
>
> On Fri, Nov 9, 2012 at 8:45 PM, Moore, Robert <[email protected]>
> wrote:
> >> And per my check, most of ACPI FW don't implement this lock, say
> >> after driver probe, the ec->global_lock will be 0
> >
> > Take a look at the FACS table, it contains the address of the global
> lock.
> >
> > I believe that the ACPI specification requires that the global lock be
> present.
> >
> >
> >
> >> -----Original Message-----
> >> From: Tang, Feng
> >> Sent: Friday, November 09, 2012 8:36 AM
> >> To: Moore, Robert
> >> Cc: Rafael J. Wysocki; Greg KH; Azat Khuzhin;
> >> [email protected]; Linux Kernel Mailing List; Zheng, Lv; Len
> >> Brown
> >> Subject: Re: ACPI errors with 3.7-rc3
> >>
> >> On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
> >> > The ACPI Global Lock is in fact intended to provide exclusion
> >> > between
> >> the BIOS and the OS.
> >> > Bob
> >>
> >> Thanks for the info.
> >>
> >> And per my check, most of ACPI FW don't implement this lock, say
> >> after driver probe, the ec->global_lock will be 0.
> >>
> >> - Feng
> >>
> >> >
> >> >
> >> > > -----Original Message-----
> >> > > From: Tang, Feng
> >> > > Sent: Friday, November 09, 2012 1:29 AM
> >> > > To: Rafael J. Wysocki
> >> > > Cc: Greg KH; Azat Khuzhin; [email protected]; Linux
> >> > > Kernel Mailing List; Zheng, Lv; Len Brown; Moore, Robert
> >> > > Subject: Re: ACPI errors with 3.7-rc3
> >> > >
> >> > > On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
> >> > > > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
> >> > > > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
> >> > > > > > I'v also have such errors on my macbook pro.
> >> > > > > >
> >> > > > > > $ dmesg | tail
> >> > > > > > [17056.008564] ACPI Error: Method parse/execution failed
> >> > > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10),
> >> > > > > > AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.011194] ACPI Error: Method parse/execution failed
> >> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.013793] ACPI Error: Method parse/execution failed
> >> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
> >> > > > > > (20120711/battery-464) [17056.511373] ACPI: EC: input
> >> > > > > > buffer is not empty, aborting transaction [17056.512672]
> >> > > > > > ACPI
> >> Exception:
> >> > > > > > AE_TIME, Returned by Handler for [EmbeddedControl]
> >> > > > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
> >> > > > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW]
> >> > > > > > (Node ffff88026547ea10), AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.517886] ACPI Error: Method parse/execution failed
> >> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.520479] ACPI Error: Method parse/execution failed
> >> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
> >> > > > > > (20120711/psparse-536)
> >> > > > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
> >> > > > > > (20120711/battery-464)
> >> > > > >
> >> > > > > I'm seeing this again right now. I'm wondering if it's
> >> > > > > because I'm running on battery power at the moment:
> >> > > > >
> >> > > > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler
> >> > > > > for [EmbeddedControl] (20120913/evregion-501) [41694.309282]
> >> > > > > ACPI
> >> Error:
> >> > > > > Method parse/execution failed
> >> > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618),
> >> > > > > AE_TIME (20120913/psparse-536) [41694.309300] ACPI Error:
> >> > > > > Method parse/execution failed [\_SB_.BAT0.UBST] (Node
> >> > > > > ffff88045cc64988), AE_TIME
> >> > > > > (20120913/psparse-536) [41694.309310] ACPI Error: Method
> >> > > > > parse/execution failed [\_SB_.BAT0._BST] (Node
> >> > > > > ffff88045cc648c0), AE_TIME (20120913/psparse-536)
> >> > > > > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST
> >> > > > > (20120913/battery-464) [41694.809093] ACPI: EC: input buffer
> >> > > > > is not empty, aborting transaction
> >> > > > >
> >> > > > > ec_storm_threshold is still set to 8 in
> >> > > > > /sys/module/acpi/parameters/ so that's not the issue here.
> >> > > > >
> >> > > > > > And also loadavg is too high ~ 10 While there is no process
> >> > > > > > that load CPU up to 100% or like that.
> >> > > > > > I think that this because of processes that is done in
> >> > > > > > kernel
> >> space.
> >> > > > > > (basically that one who write such errors)
> >> > > > > >
> >> > > > > > $ uname -a
> >> > > > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP
> >> > > > > > Sun Nov 4
> >> > > > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
> >> > > > >
> >> > > > > Ah, ok, that means it's not something new in 3.7-rc, so maybe
> >> > > > > it's just never worked properly for this hardware :)
> >> > > > >
> >> > > > > So it's not a regression, just an ACPI issue, any ACPI
> >> > > > > developer have an idea about this?
> >> > > >
> >> > > > Can you please send the output of acpidump from the affected
> >> machine(s)?
> >> > >
> >> > > I doubt this problem is sometimes inevitable for some machines,
> >> > > because AFAIK most modern machines have the race problem for EC
> >> > > HW controller, as both OS side and the BIOS may access the EC HW
> >> > > at the same time without any race control.
> >> > >
> >> > > For this case, usually the battery and thermal modules (which may
> >> > > be controlled through EC) are always monitored by BIOS, when OS
> >> > > also frequently visit them too, the EC's own state machine may be
> >> > > broken and not responsive due to the race, then cause the timeout
> error.
> >> > > And how severe the problem will be depends on the EC HW, the
> >> > > quality of BIOS code and OS/driver code.
> >> > >
> >> > > Myself have seen the similar "ACPI: EC: input buffer is not
> >> > > empty, aborting transaction" error message on one laptop when its
> >> > > EC is busy visited by OS.
> >> > >
> >> > > btw, in EC driver I see a "ec->global_lock", don't know if it was
> >> > > designed to control the race between OS and BIOS.
> >> > >
> >> > > Thanks,
> >> > > Feng
>
>
>
> --
> Azat Khuzhin
????{.n?+???????+%?????ݶ??w??{.n?+????{??G?????{ay?ʇڙ?,j??f???h?????????z_??(?階?ݢj"???m??????G????????????&???~???iO???z??v?^?m???? ????????I?

2012-11-14 17:33:27

by Azat Khuzhin

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

Robert, thanks.

I have such message again, and load avg up to 30, and the increase up
to 40, after to 50.

I found this https://bugzilla.kernel.org/show_bug.cgi?id=14733
and I after I compile kernel with this patch write message about results.

Also I want to note that after I suspend laptop to ~20-15 minutes and
resume, it works fine.
And no such spam in log.

But after this hack if open lid, laptop not exit from suspend mode,
for exit from it, I must manually press key on keyboard.
I try to restart acpid, laptop-mode but nothing of this helped me.

$ dmesg | tail -n20
[122582.074256] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[122582.076668] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
[122582.572501] ACPI: EC: input buffer is not empty, aborting transaction
[122582.573710] ACPI Exception: AE_TIME, Returned by Handler for
[EmbeddedControl] (20120711/evregion-501)
[122582.576121] ACPI Error: Method parse/execution failed
[\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
(20120711/psparse-536)
[122582.578548] ACPI Error: Method parse/execution failed
[\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
(20120711/psparse-536)
[122582.580964] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[122582.583378] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
[122583.079191] ACPI: EC: input buffer is not empty, aborting transaction
[122583.080488] ACPI Exception: AE_TIME, Returned by Handler for
[EmbeddedControl] (20120711/evregion-501)
[122583.083073] ACPI Error: Method parse/execution failed
[\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
(20120711/psparse-536)
[122583.085671] ACPI Error: Method parse/execution failed
[\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
(20120711/psparse-536)
[122583.088264] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[122583.090893] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)
[122583.585891] ACPI: EC: input buffer is not empty, aborting transaction
[122583.587100] ACPI Exception: AE_TIME, Returned by Handler for
[EmbeddedControl] (20120711/evregion-501)
[122583.589578] ACPI Error: Method parse/execution failed
[\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
(20120711/psparse-536)
[122583.592003] ACPI Error: Method parse/execution failed
[\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
(20120711/psparse-536)
[122583.594419] ACPI Error: Method parse/execution failed
[\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
(20120711/psparse-536)
[122583.596859] ACPI Exception: AE_TIME, Evaluating _BST (20120711/battery-464)

On Tue, Nov 13, 2012 at 4:41 AM, Moore, Robert <[email protected]> wrote:
> Actually, it is not the address of the global lock, the FACS contains the actual global lock:
>
> From acpi5.0 spec:
>
> ROM BIOS. The Global Lock is a 32-bit (DWORD) value in read/write memory located within the FACS and is accessed and updated by both the OS environment and the SMI environment in a defined manner to provide an exclusive lock. Note: this is not a pointer to the Global Lock, it is the actual memory location of the lock. The FACS and Global Lock may be located anywhere in physical memory.
>
>
>
>
>> -----Original Message-----
>> From: [email protected] [mailto:[email protected]] On Behalf Of Azat
>> Khuzhin
>> Sent: Sunday, November 11, 2012 2:01 AM
>> To: Moore, Robert
>> Cc: Tang, Feng; Rafael J. Wysocki; Greg KH; [email protected];
>> Linux Kernel Mailing List; Zheng, Lv; Len Brown
>> Subject: Re: ACPI errors with 3.7-rc3
>>
>> Robert,
>>
>> You say that FACS table contains the address of the global lock.
>> But in my case https://gist.github.com/4037687 it seems to be empty, so
>> this means that my laptop don't have global lock?
>>
>> On Fri, Nov 9, 2012 at 8:45 PM, Moore, Robert <[email protected]>
>> wrote:
>> >> And per my check, most of ACPI FW don't implement this lock, say
>> >> after driver probe, the ec->global_lock will be 0
>> >
>> > Take a look at the FACS table, it contains the address of the global
>> lock.
>> >
>> > I believe that the ACPI specification requires that the global lock be
>> present.
>> >
>> >
>> >
>> >> -----Original Message-----
>> >> From: Tang, Feng
>> >> Sent: Friday, November 09, 2012 8:36 AM
>> >> To: Moore, Robert
>> >> Cc: Rafael J. Wysocki; Greg KH; Azat Khuzhin;
>> >> [email protected]; Linux Kernel Mailing List; Zheng, Lv; Len
>> >> Brown
>> >> Subject: Re: ACPI errors with 3.7-rc3
>> >>
>> >> On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
>> >> > The ACPI Global Lock is in fact intended to provide exclusion
>> >> > between
>> >> the BIOS and the OS.
>> >> > Bob
>> >>
>> >> Thanks for the info.
>> >>
>> >> And per my check, most of ACPI FW don't implement this lock, say
>> >> after driver probe, the ec->global_lock will be 0.
>> >>
>> >> - Feng
>> >>
>> >> >
>> >> >
>> >> > > -----Original Message-----
>> >> > > From: Tang, Feng
>> >> > > Sent: Friday, November 09, 2012 1:29 AM
>> >> > > To: Rafael J. Wysocki
>> >> > > Cc: Greg KH; Azat Khuzhin; [email protected]; Linux
>> >> > > Kernel Mailing List; Zheng, Lv; Len Brown; Moore, Robert
>> >> > > Subject: Re: ACPI errors with 3.7-rc3
>> >> > >
>> >> > > On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
>> >> > > > On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
>> >> > > > > On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
>> >> > > > > > I'v also have such errors on my macbook pro.
>> >> > > > > >
>> >> > > > > > $ dmesg | tail
>> >> > > > > > [17056.008564] ACPI Error: Method parse/execution failed
>> >> > > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10),
>> >> > > > > > AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.011194] ACPI Error: Method parse/execution failed
>> >> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.013793] ACPI Error: Method parse/execution failed
>> >> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
>> >> > > > > > (20120711/battery-464) [17056.511373] ACPI: EC: input
>> >> > > > > > buffer is not empty, aborting transaction [17056.512672]
>> >> > > > > > ACPI
>> >> Exception:
>> >> > > > > > AE_TIME, Returned by Handler for [EmbeddedControl]
>> >> > > > > > (20120711/evregion-501) [17056.515256] ACPI Error: Method
>> >> > > > > > parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW]
>> >> > > > > > (Node ffff88026547ea10), AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.517886] ACPI Error: Method parse/execution failed
>> >> > > > > > [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.520479] ACPI Error: Method parse/execution failed
>> >> > > > > > [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>> >> > > > > > (20120711/psparse-536)
>> >> > > > > > [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
>> >> > > > > > (20120711/battery-464)
>> >> > > > >
>> >> > > > > I'm seeing this again right now. I'm wondering if it's
>> >> > > > > because I'm running on battery power at the moment:
>> >> > > > >
>> >> > > > > [41694.309264] ACPI Exception: AE_TIME, Returned by Handler
>> >> > > > > for [EmbeddedControl] (20120913/evregion-501) [41694.309282]
>> >> > > > > ACPI
>> >> Error:
>> >> > > > > Method parse/execution failed
>> >> > > > > [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88045cc64618),
>> >> > > > > AE_TIME (20120913/psparse-536) [41694.309300] ACPI Error:
>> >> > > > > Method parse/execution failed [\_SB_.BAT0.UBST] (Node
>> >> > > > > ffff88045cc64988), AE_TIME
>> >> > > > > (20120913/psparse-536) [41694.309310] ACPI Error: Method
>> >> > > > > parse/execution failed [\_SB_.BAT0._BST] (Node
>> >> > > > > ffff88045cc648c0), AE_TIME (20120913/psparse-536)
>> >> > > > > [41694.309324] ACPI Exception: AE_TIME, Evaluating _BST
>> >> > > > > (20120913/battery-464) [41694.809093] ACPI: EC: input buffer
>> >> > > > > is not empty, aborting transaction
>> >> > > > >
>> >> > > > > ec_storm_threshold is still set to 8 in
>> >> > > > > /sys/module/acpi/parameters/ so that's not the issue here.
>> >> > > > >
>> >> > > > > > And also loadavg is too high ~ 10 While there is no process
>> >> > > > > > that load CPU up to 100% or like that.
>> >> > > > > > I think that this because of processes that is done in
>> >> > > > > > kernel
>> >> space.
>> >> > > > > > (basically that one who write such errors)
>> >> > > > > >
>> >> > > > > > $ uname -a
>> >> > > > > > Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP
>> >> > > > > > Sun Nov 4
>> >> > > > > > 12:39:03 UTC 2012 x86_64 GNU/Linux
>> >> > > > >
>> >> > > > > Ah, ok, that means it's not something new in 3.7-rc, so maybe
>> >> > > > > it's just never worked properly for this hardware :)
>> >> > > > >
>> >> > > > > So it's not a regression, just an ACPI issue, any ACPI
>> >> > > > > developer have an idea about this?
>> >> > > >
>> >> > > > Can you please send the output of acpidump from the affected
>> >> machine(s)?
>> >> > >
>> >> > > I doubt this problem is sometimes inevitable for some machines,
>> >> > > because AFAIK most modern machines have the race problem for EC
>> >> > > HW controller, as both OS side and the BIOS may access the EC HW
>> >> > > at the same time without any race control.
>> >> > >
>> >> > > For this case, usually the battery and thermal modules (which may
>> >> > > be controlled through EC) are always monitored by BIOS, when OS
>> >> > > also frequently visit them too, the EC's own state machine may be
>> >> > > broken and not responsive due to the race, then cause the timeout
>> error.
>> >> > > And how severe the problem will be depends on the EC HW, the
>> >> > > quality of BIOS code and OS/driver code.
>> >> > >
>> >> > > Myself have seen the similar "ACPI: EC: input buffer is not
>> >> > > empty, aborting transaction" error message on one laptop when its
>> >> > > EC is busy visited by OS.
>> >> > >
>> >> > > btw, in EC driver I see a "ec->global_lock", don't know if it was
>> >> > > designed to control the race between OS and BIOS.
>> >> > >
>> >> > > Thanks,
>> >> > > Feng
>>
>>
>>
>> --
>> Azat Khuzhin



--
Azat Khuzhin

2012-11-17 05:40:34

by Robert Hancock

[permalink] [raw]
Subject: Re: ACPI errors with 3.7-rc3

On 11/09/2012 10:36 AM, Feng Tang wrote:
> On Fri, Nov 09, 2012 at 10:30:43PM +0800, Moore, Robert wrote:
>> The ACPI Global Lock is in fact intended to provide exclusion between the BIOS and the OS.
>> Bob
>
> Thanks for the info.
>
> And per my check, most of ACPI FW don't implement this lock, say
> after driver probe, the ec->global_lock will be 0.

The DSDT is supposed to define the _GLK control method on the EC if the
BIOS needs to perform its own access which may conflict with the OS
usage. If it doesn't, then it should be the case that either the BIOS
doesn't touch the EC itself or it uses a separate interface that doesn't
cause conflicts with what the OS is doing.

>
> - Feng
>
>>
>>
>>> -----Original Message-----
>>> From: Tang, Feng
>>> Sent: Friday, November 09, 2012 1:29 AM
>>> To: Rafael J. Wysocki
>>> Cc: Greg KH; Azat Khuzhin; [email protected]; Linux Kernel
>>> Mailing List; Zheng, Lv; Len Brown; Moore, Robert
>>> Subject: Re: ACPI errors with 3.7-rc3
>>>
>>> On Thu, Nov 08, 2012 at 05:49:40AM +0800, Rafael J. Wysocki wrote:
>>>> On Tuesday, November 06, 2012 01:48:26 PM Greg KH wrote:
>>>>> On Tue, Nov 06, 2012 at 04:42:24PM +0400, Azat Khuzhin wrote:
>>>>>> I'v also have such errors on my macbook pro.
>>>>>>
>>>>>> $ dmesg | tail
>>>>>> [17056.008564] ACPI Error: Method parse/execution failed
>>>>>> [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node ffff88026547ea10), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.011194] ACPI Error: Method parse/execution failed
>>>>>> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.013793] ACPI Error: Method parse/execution failed
>>>>>> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.016383] ACPI Exception: AE_TIME, Evaluating _BST
>>>>>> (20120711/battery-464) [17056.511373] ACPI: EC: input buffer is
>>>>>> not empty, aborting transaction [17056.512672] ACPI Exception:
>>>>>> AE_TIME, Returned by Handler for [EmbeddedControl]
>>>>>> (20120711/evregion-501) [17056.515256] ACPI Error: Method
>>>>>> parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
>>>>>> ffff88026547ea10), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.517886] ACPI Error: Method parse/execution failed
>>>>>> [\_SB_.BAT0.UBST] (Node ffff88026547e678), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.520479] ACPI Error: Method parse/execution failed
>>>>>> [\_SB_.BAT0._BST] (Node ffff88026547e740), AE_TIME
>>>>>> (20120711/psparse-536)
>>>>>> [17056.523070] ACPI Exception: AE_TIME, Evaluating _BST
>>>>>> (20120711/battery-464)
>>>>>
>>>>> I'm seeing this again right now. I'm wondering if it's because I'm
>>>>> running on battery power at the moment:
>>>>>
>>>>> [41694.309264] ACPI Exception: AE_TIME, Returned by Handler for
>>>>> [EmbeddedControl] (20120913/evregion-501) [41694.309282] ACPI Error:
>>>>> Method parse/execution failed [\_SB_.PCI0.LPCB.EC__.SMB0.SBRW] (Node
>>>>> ffff88045cc64618), AE_TIME (20120913/psparse-536) [41694.309300]
>>>>> ACPI Error: Method parse/execution failed [\_SB_.BAT0.UBST] (Node
>>>>> ffff88045cc64988), AE_TIME (20120913/psparse-536) [41694.309310]
>>>>> ACPI Error: Method parse/execution failed [\_SB_.BAT0._BST] (Node
>>>>> ffff88045cc648c0), AE_TIME (20120913/psparse-536) [41694.309324]
>>>>> ACPI Exception: AE_TIME, Evaluating _BST (20120913/battery-464)
>>>>> [41694.809093] ACPI: EC: input buffer is not empty, aborting
>>>>> transaction
>>>>>
>>>>> ec_storm_threshold is still set to 8 in /sys/module/acpi/parameters/
>>>>> so that's not the issue here.
>>>>>
>>>>>> And also loadavg is too high ~ 10
>>>>>> While there is no process that load CPU up to 100% or like that.
>>>>>> I think that this because of processes that is done in kernel space.
>>>>>> (basically that one who write such errors)
>>>>>>
>>>>>> $ uname -a
>>>>>> Linux macbook-pro-sq 3.6.5macbook-pro-custom-v0.1 #4 SMP Sun Nov 4
>>>>>> 12:39:03 UTC 2012 x86_64 GNU/Linux
>>>>>
>>>>> Ah, ok, that means it's not something new in 3.7-rc, so maybe it's
>>>>> just never worked properly for this hardware :)
>>>>>
>>>>> So it's not a regression, just an ACPI issue, any ACPI developer
>>>>> have an idea about this?
>>>>
>>>> Can you please send the output of acpidump from the affected machine(s)?
>>>
>>> I doubt this problem is sometimes inevitable for some machines, because
>>> AFAIK most modern machines have the race problem for EC HW controller, as
>>> both OS side and the BIOS may access the EC HW at the same time
>>> without any race control.
>>>
>>> For this case, usually the battery and thermal modules (which may be
>>> controlled through EC) are always monitored by BIOS, when OS also
>>> frequently visit them too, the EC's own state machine may be broken and
>>> not responsive due to the race, then cause the timeout error.
>>> And how severe the problem will be depends on the EC HW, the quality of
>>> BIOS code and OS/driver code.
>>>
>>> Myself have seen the similar "ACPI: EC: input buffer is not empty,
>>> aborting transaction" error message on one laptop when its EC is busy
>>> visited by OS.
>>>
>>> btw, in EC driver I see a "ec->global_lock", don't know if it was designed
>>> to control the race between OS and BIOS.
>>>
>>> Thanks,
>>> Feng
> --
> To unsubscribe from this list: send the line "unsubscribe linux-acpi" in
> the body of a message to [email protected]
> More majordomo info at http://vger.kernel.org/majordomo-info.html
>