public inbox for linux-acpi@vger.kernel.org
 help / color / mirror / Atom feed
* ILK ACPI boot-up problem on HP 8100 SFF, bisected
@ 2017-01-09 16:01 Tomi Sarvela
  2017-01-09 22:07 ` Rafael J. Wysocki
  0 siblings, 1 reply; 8+ messages in thread
From: Tomi Sarvela @ 2017-01-09 16:01 UTC (permalink / raw)
  To: linux-acpi, lv.zheng, robert.moore; +Cc: intel-gfx-ci

Hello there,

We have couple of Iron Lake machines here, and one started hanging around Christmas in early boot on ACPI initialization. Dmesg below, full dmesgs available on request.

Exact model of the machine is HP Compaq 8100 Elite Small Form Factor PC. BIOS update from 2010 to 2011 (newest) didn't change anything.
HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650) don't have this particular problem.

I've bisected the problem to the following commit:

----
commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
Author: Lv Zheng <lv.zheng@intel.com>
Date:   Wed Dec 14 15:04:25 2016 +0800

    ACPICA: Tables: Back port acpi_get_table_with_size() and early_acpi_os_unmap_memory() from Linux kernel
    
    ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
----

The affected machine is a testhost and readily available for any patches that might help pinpoint this bug.

If you need any more information, you can contact me directly to this address.

Best regards,

Tomi Sarvela

Intel Finland Oy - BIC 0357606-4 - Westendinkatu 7, 02160 Espoo



Bad kernel hard hangs to the point:

[    0.851020] ACPI: Added _OSI(Module Device)
[    0.855257] ACPI: Added _OSI(Processor Device)
[    0.859753] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.864509] ACPI: Added _OSI(Processor Aggregator Device)
[    0.888923] ACPI: Dynamic OEM Table Load:
[    0.893050] ACPI: SSDT 0xFFFF880212313A78 0003BA (v01 COMPAQ CPU_TM2  00000001 MSFT 0100000E)

Good kernel looks like this:

[    0.216085] ACPI: Added _OSI(Module Device)
[    0.216087] ACPI: Added _OSI(Processor Device)
[    0.216088] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.216089] ACPI: Added _OSI(Processor Aggregator Device)
[    0.217988] ACPI: Dynamic OEM Table Load:
[    0.217993] ACPI: SSDT 0xFFFF880211DE2400 0003BA (v01 COMPAQ CPU_TM2  00000001 MSFT 0100000E)
[    0.218238] ACPI: Dynamic OEM Table Load:
[    0.218241] ACPI: SSDT 0xFFFF880211DE2800 0003D8 (v01 COMPAQ CST      00000001 MSFT 0100000E)
[    0.218693] ACPI: Interpreter enabled
[    0.218708] ACPI: (supports S0 S3 S4 S5)
[    0.218709] ACPI: Using IOAPIC for interrupt routing
[    0.218726] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.221751] acpi LNXCPU:00: Invalid PBLK length [7]
[    0.221758] acpi LNXCPU:01: Invalid PBLK length [7]
[    0.221763] acpi LNXCPU:02: Invalid PBLK length [7]
[    0.221768] acpi LNXCPU:03: Invalid PBLK length [7]
[    0.221898] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.221903] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[    0.221906] ACPI BIOS Error (bug): \_SB_.PCI0._OSC: Excess arguments - ASL declared 5, ACPI requires 4 (20150930/nsarguments-189)
[    0.221938] ACPI Error: [CAPD] Namespace lookup failure, AE_ALREADY_EXISTS (20150930/dsfield-211)
[    0.221942] ACPI Error: Method parse/execution failed [\_SB.PCI0._OSC] (Node ffff8802130b1668), AE_ALREADY_EXISTS (20150930/psparse-542)
[    0.221948] acpi PNP0A08:00: _OSC failed (AE_ALREADY_EXISTS); disabling ASPM
[    0.222162] PCI host bridge to bus 0000:00



^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-09 16:01 Tomi Sarvela
@ 2017-01-09 22:07 ` Rafael J. Wysocki
  2017-01-09 22:28   ` Rafael J. Wysocki
  0 siblings, 1 reply; 8+ messages in thread
From: Rafael J. Wysocki @ 2017-01-09 22:07 UTC (permalink / raw)
  To: Tomi Sarvela; +Cc: ACPI Devel Maling List, Lv, Robert Moore, intel-gfx-ci

Hi,

On Mon, Jan 9, 2017 at 5:01 PM, Tomi Sarvela <tomi.p.sarvela@intel.com> wrote:
> Hello there,
>
> We have couple of Iron Lake machines here, and one started hanging around Christmas in early boot on ACPI initialization. Dmesg below, full dmesgs available on request.
>
> Exact model of the machine is HP Compaq 8100 Elite Small Form Factor PC. BIOS update from 2010 to 2011 (newest) didn't change anything.
> HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650) don't have this particular problem.
>
> I've bisected the problem to the following commit:
>
> ----
> commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
> Author: Lv Zheng <lv.zheng@intel.com>
> Date:   Wed Dec 14 15:04:25 2016 +0800
>
>     ACPICA: Tables: Back port acpi_get_table_with_size() and early_acpi_os_unmap_memory() from Linux kernel
>
>     ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
> ----
>
> The affected machine is a testhost and readily available for any patches that might help pinpoint this bug.
>
> If you need any more information, you can contact me directly to this address.

Thanks for the report!

Does this patch make any difference:
https://patchwork.kernel.org/patch/9504277/ ?

Thanks,
Rafael

^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-09 22:07 ` Rafael J. Wysocki
@ 2017-01-09 22:28   ` Rafael J. Wysocki
  2017-01-10  8:46     ` Tomi Sarvela
  0 siblings, 1 reply; 8+ messages in thread
From: Rafael J. Wysocki @ 2017-01-09 22:28 UTC (permalink / raw)
  To: Tomi Sarvela; +Cc: ACPI Devel Maling List, Lv, Robert Moore, Paul McKenney

On Mon, Jan 9, 2017 at 11:07 PM, Rafael J. Wysocki <rafael@kernel.org> wrote:
> Hi,
>
> On Mon, Jan 9, 2017 at 5:01 PM, Tomi Sarvela <tomi.p.sarvela@intel.com> wrote:
>> Hello there,
>>
>> We have couple of Iron Lake machines here, and one started hanging around Christmas in early boot on ACPI initialization. Dmesg below, full dmesgs available on request.
>>
>> Exact model of the machine is HP Compaq 8100 Elite Small Form Factor PC. BIOS update from 2010 to 2011 (newest) didn't change anything.
>> HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650) don't have this particular problem.
>>
>> I've bisected the problem to the following commit:
>>
>> ----
>> commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
>> Author: Lv Zheng <lv.zheng@intel.com>
>> Date:   Wed Dec 14 15:04:25 2016 +0800
>>
>>     ACPICA: Tables: Back port acpi_get_table_with_size() and early_acpi_os_unmap_memory() from Linux kernel
>>
>>     ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
>> ----
>>
>> The affected machine is a testhost and readily available for any patches that might help pinpoint this bug.
>>
>> If you need any more information, you can contact me directly to this address.
>
> Thanks for the report!
>
> Does this patch make any difference:
> https://patchwork.kernel.org/patch/9504277/ ?

Please also check this alternative patch from Paul:

https://patchwork.kernel.org/patch/9506033/

Thanks,
Rafael

^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-09 22:28   ` Rafael J. Wysocki
@ 2017-01-10  8:46     ` Tomi Sarvela
  0 siblings, 0 replies; 8+ messages in thread
From: Tomi Sarvela @ 2017-01-10  8:46 UTC (permalink / raw)
  To: Rafael J. Wysocki; +Cc: ACPI Devel Maling List, Lv, Robert Moore, Paul McKenney

On Monday, 9 January 2017 23:28:32 EET Rafael J. Wysocki wrote:
> On Mon, Jan 9, 2017 at 11:07 PM, Rafael J. Wysocki <rafael@kernel.org> wrote:
> > On Mon, Jan 9, 2017 at 5:01 PM, Tomi Sarvela <tomi.p.sarvela@intel.com> wrote:
> >> We have couple of Iron Lake machines here, and one started
> >> hanging around Christmas in early boot on ACPI initialization.
> >> Dmesg below, full dmesgs available on request.
> >> 
> >> Exact model of the machine is HP Compaq 8100 Elite Small Form
> >> Factor PC. BIOS update from 2010 to 2011 (newest) didn't change
> >> anything. HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650)
> >> don't have this particular problem.
> >> 
> >> I've bisected the problem to the following commit:
> >> 
> >> ----
> >> commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
> >> Author: Lv Zheng <lv.zheng@intel.com>
> >> Date:   Wed Dec 14 15:04:25 2016 +0800
> >> 
> >>     ACPICA: Tables: Back port acpi_get_table_with_size() and
> >>     early_acpi_os_unmap_memory() from Linux kernel
> >>     
> >>     ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
> >> 
> >> ----
> > Thanks for the report!
> > 
> > Does this patch make any difference:
> > https://patchwork.kernel.org/patch/9504277/ ?
> 
> Please also check this alternative patch from Paul:
> 
> https://patchwork.kernel.org/patch/9506033/

I've tested both patches on top of latest kernel head (separate tries, to make it clear).

Neither patch does any difference. In both cases kernel still hangs to the same spot in boot, and 5sec powerbutton or AC reboot is needed.

Best regards,

Tomi Sarvela






^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
@ 2017-01-10 10:07 Tomi Sarvela
  2017-01-11  3:09 ` Rafael J. Wysocki
  0 siblings, 1 reply; 8+ messages in thread
From: Tomi Sarvela @ 2017-01-10 10:07 UTC (permalink / raw)
  Cc: ACPI Devel Maling List

On Tuesday, 10 January 2017 10:46:50 EET Tomi Sarvela wrote:
> On Monday, 9 January 2017 23:28:32 EET Rafael J. Wysocki wrote:
> > On Mon, Jan 9, 2017 at 11:07 PM, Rafael J. Wysocki <rafael@kernel.org> wrote:
> > > On Mon, Jan 9, 2017 at 5:01 PM, Tomi Sarvela <tomi.p.sarvela@intel.com> wrote:
> > >> We have couple of Iron Lake machines here, and one started
> > >> hanging around Christmas in early boot on ACPI initialization.
> > >> Dmesg below, full dmesgs available on request.
> > >> 
> > >> Exact model of the machine is HP Compaq 8100 Elite Small Form
> > >> Factor PC. BIOS update from 2010 to 2011 (newest) didn't change
> > >> anything. HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650)
> > >> don't have this particular problem.
> > >> 
> > >> I've bisected the problem to the following commit:
> > >> 
> > >> ----
> > >> commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
> > >> Author: Lv Zheng <lv.zheng@intel.com>
> > >> Date:   Wed Dec 14 15:04:25 2016 +0800
> > >> 
> > >>     ACPICA: Tables: Back port acpi_get_table_with_size() and
> > >>     early_acpi_os_unmap_memory() from Linux kernel
> > >>     
> > >>     ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
> > >> 
> > >> ----
> > > 
> > > Thanks for the report!
> > > 
> > > Does this patch make any difference:
> > > https://patchwork.kernel.org/patch/9504277/ ?
> > 
> > Please also check this alternative patch from Paul:
> > 
> > https://patchwork.kernel.org/patch/9506033/
> 
> I've tested both patches on top of latest kernel head (separate
> tries, to make it clear).
> 
> Neither patch does any difference. In both cases kernel still hangs
> to the same spot in boot, and 5sec powerbutton or AC reboot is
> needed.

This might help: there is dump after a while. I've been too hasty to reboot the machine to see this before.

Best regards,

Tomi Sarvela

[    0.854462] ACPI: Added _OSI(Module Device)
[    0.858701] ACPI: Added _OSI(Processor Device)
[    0.863197] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.867952] ACPI: Added _OSI(Processor Aggregator Device)
[    0.893684] ACPI: Dynamic OEM Table Load:
[    0.897758] ACPI: SSDT 0xFFFF8802122EBA78 0003BA (v01 COMPAQ CPU_TM2  00000001 MSFT 0100000E)
[  247.066214] INFO: task swapper/0:1 blocked for more than 120 seconds.
[  247.072707]       Not tainted 4.10.0-rc2-gfxbench+ #1
[  247.077809] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  247.085731] swapper/0       D    0     1      0 0x00000000
[  247.091271] Call Trace:
[  247.093774]  ? __schedule+0x2c9/0xa60
[  247.097489]  schedule+0x3b/0x90
[  247.100685]  schedule_timeout+0x25b/0x4c0
[  247.104750]  ? debug_smp_processor_id+0x17/0x20
[  247.109334]  ? set_track+0x88/0x120
[  247.112878]  ? trace_hardirqs_on_caller+0x122/0x1b0
[  247.117808]  __down_timeout+0x81/0xd0
[  247.121523]  down_timeout+0x47/0x50
[  247.125065]  acpi_os_wait_semaphore+0x47/0x62
[  247.129475]  acpi_ut_acquire_mutex+0x43/0x81
[  247.133798]  acpi_get_table+0x2d/0x84
[  247.137513]  acpi_table_attr_init+0xcd/0x100
[  247.141834]  ? acpi_sysfs_table_handler+0x3e/0xb8
[  247.146590]  acpi_sysfs_table_handler+0x5d/0xb8
[  247.151174]  acpi_bus_table_handler+0x23/0x2a
[  247.155583]  acpi_tb_install_standard_table+0xe0/0x213
[  247.160773]  ? down_timeout+0x32/0x50
[  247.164489]  acpi_tb_install_and_load_table+0x3a/0x82
[  247.169592]  acpi_ex_load_op+0x194/0x201
[  247.173568]  ? acpi_ex_resolve_operands+0x207/0x4dc
[  247.178497]  acpi_ex_opcode_1A_1T_0R+0x25/0x46
[  247.182993]  acpi_ds_exec_end_op+0xc8/0x3df
[  247.187229]  acpi_ps_parse_loop+0x50e/0x560
[  247.191465]  acpi_ps_parse_aml+0x93/0x276
[  247.195526]  acpi_ps_execute_method+0x146/0x181
[  247.200108]  acpi_ns_evaluate+0x1bb/0x247
[  247.204170]  acpi_evaluate_object+0x178/0x274
[  247.208581]  ? acpi_processor_set_pdc+0x88/0x17b
[  247.213249]  acpi_processor_set_pdc+0x154/0x17b
[  247.217833]  early_init_pdc+0x9a/0xa3
[  247.221548]  ? up+0x2d/0x50
[  247.224395]  acpi_ns_walk_namespace+0xdc/0x18e
[  247.228891]  ? set_no_mwait+0x23/0x23
[  247.232606]  ? set_no_mwait+0x23/0x23
[  247.236321]  acpi_walk_namespace+0x97/0xcb
[  247.240471]  ? acpi_sleep_proc_init+0x28/0x28
[  247.244880]  ? rest_init+0x130/0x130
[  247.248507]  acpi_early_processor_set_pdc+0x30/0x4a
[  247.253436]  acpi_init+0x19f/0x315
[  247.256891]  do_one_initcall+0x3f/0x170
[  247.260781]  kernel_init_freeable+0x11d/0x1a3
[  247.265191]  ? rest_init+0x130/0x130
[  247.268822]  kernel_init+0x9/0x100
[  247.272276]  ret_from_fork+0x27/0x40
[  247.275904] 
[  247.275904] Showing all locks held in the system:
[  247.282179] 2 locks held by khungtaskd/34:
[  247.286326]  #0:  (rcu_read_lock){......}, at: [<ffffffff811332cc>] watchdog+0x9c/0x600
[  247.294423]  #1:  (tasklist_lock){.+.+..}, at: [<ffffffff810dae1d>] debug_show_all_locks+0x3d/0x1a0
[  247.303562] 
[  247.305105] =============================================
[  247.305105] 


^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-10 10:07 ILK ACPI boot-up problem on HP 8100 SFF, bisected Tomi Sarvela
@ 2017-01-11  3:09 ` Rafael J. Wysocki
  2017-01-18 13:25   ` Tomi Sarvela
  0 siblings, 1 reply; 8+ messages in thread
From: Rafael J. Wysocki @ 2017-01-11  3:09 UTC (permalink / raw)
  To: Tomi Sarvela, Lv Zheng; +Cc: ACPI Devel Maling List

On Tuesday, January 10, 2017 12:07:36 PM Tomi Sarvela wrote:
> On Tuesday, 10 January 2017 10:46:50 EET Tomi Sarvela wrote:
> > On Monday, 9 January 2017 23:28:32 EET Rafael J. Wysocki wrote:
> > > On Mon, Jan 9, 2017 at 11:07 PM, Rafael J. Wysocki <rafael@kernel.org> wrote:
> > > > On Mon, Jan 9, 2017 at 5:01 PM, Tomi Sarvela <tomi.p.sarvela@intel.com> wrote:
> > > >> We have couple of Iron Lake machines here, and one started
> > > >> hanging around Christmas in early boot on ACPI initialization.
> > > >> Dmesg below, full dmesgs available on request.
> > > >> 
> > > >> Exact model of the machine is HP Compaq 8100 Elite Small Form
> > > >> Factor PC. BIOS update from 2010 to 2011 (newest) didn't change
> > > >> anything. HP Elite laptop (ILK m540) or Dell SFF PC (ILK 650)
> > > >> don't have this particular problem.
> > > >> 
> > > >> I've bisected the problem to the following commit:
> > > >> 
> > > >> ----
> > > >> commit 174cc7187e6f088942c8e74daa7baff7b44b33c9
> > > >> Author: Lv Zheng <lv.zheng@intel.com>
> > > >> Date:   Wed Dec 14 15:04:25 2016 +0800
> > > >> 
> > > >>     ACPICA: Tables: Back port acpi_get_table_with_size() and
> > > >>     early_acpi_os_unmap_memory() from Linux kernel
> > > >>     
> > > >>     ACPICA commit cac6790954d4d752a083e6122220b8a22febcd07
> > > >> 
> > > >> ----
> > > > 
> > > > Thanks for the report!
> > > > 
> > > > Does this patch make any difference:
> > > > https://patchwork.kernel.org/patch/9504277/ ?
> > > 
> > > Please also check this alternative patch from Paul:
> > > 
> > > https://patchwork.kernel.org/patch/9506033/
> > 
> > I've tested both patches on top of latest kernel head (separate
> > tries, to make it clear).
> > 
> > Neither patch does any difference. In both cases kernel still hangs
> > to the same spot in boot, and 5sec powerbutton or AC reboot is
> > needed.
> 
> This might help: there is dump after a while. I've been too hasty to reboot the machine to see this before.
> 

Thanks!

> 
> [    0.854462] ACPI: Added _OSI(Module Device)
> [    0.858701] ACPI: Added _OSI(Processor Device)
> [    0.863197] ACPI: Added _OSI(3.0 _SCP Extensions)
> [    0.867952] ACPI: Added _OSI(Processor Aggregator Device)
> [    0.893684] ACPI: Dynamic OEM Table Load:
> [    0.897758] ACPI: SSDT 0xFFFF8802122EBA78 0003BA (v01 COMPAQ CPU_TM2  00000001 MSFT 0100000E)
> [  247.066214] INFO: task swapper/0:1 blocked for more than 120 seconds.
> [  247.072707]       Not tainted 4.10.0-rc2-gfxbench+ #1
> [  247.077809] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
> [  247.085731] swapper/0       D    0     1      0 0x00000000
> [  247.091271] Call Trace:
> [  247.093774]  ? __schedule+0x2c9/0xa60
> [  247.097489]  schedule+0x3b/0x90
> [  247.100685]  schedule_timeout+0x25b/0x4c0
> [  247.104750]  ? debug_smp_processor_id+0x17/0x20
> [  247.109334]  ? set_track+0x88/0x120
> [  247.112878]  ? trace_hardirqs_on_caller+0x122/0x1b0
> [  247.117808]  __down_timeout+0x81/0xd0
> [  247.121523]  down_timeout+0x47/0x50
> [  247.125065]  acpi_os_wait_semaphore+0x47/0x62
> [  247.129475]  acpi_ut_acquire_mutex+0x43/0x81
> [  247.133798]  acpi_get_table+0x2d/0x84
> [  247.137513]  acpi_table_attr_init+0xcd/0x100
> [  247.141834]  ? acpi_sysfs_table_handler+0x3e/0xb8
> [  247.146590]  acpi_sysfs_table_handler+0x5d/0xb8
> [  247.151174]  acpi_bus_table_handler+0x23/0x2a
> [  247.155583]  acpi_tb_install_standard_table+0xe0/0x213
> [  247.160773]  ? down_timeout+0x32/0x50
> [  247.164489]  acpi_tb_install_and_load_table+0x3a/0x82
> [  247.169592]  acpi_ex_load_op+0x194/0x201
> [  247.173568]  ? acpi_ex_resolve_operands+0x207/0x4dc
> [  247.178497]  acpi_ex_opcode_1A_1T_0R+0x25/0x46
> [  247.182993]  acpi_ds_exec_end_op+0xc8/0x3df
> [  247.187229]  acpi_ps_parse_loop+0x50e/0x560
> [  247.191465]  acpi_ps_parse_aml+0x93/0x276
> [  247.195526]  acpi_ps_execute_method+0x146/0x181
> [  247.200108]  acpi_ns_evaluate+0x1bb/0x247
> [  247.204170]  acpi_evaluate_object+0x178/0x274
> [  247.208581]  ? acpi_processor_set_pdc+0x88/0x17b
> [  247.213249]  acpi_processor_set_pdc+0x154/0x17b
> [  247.217833]  early_init_pdc+0x9a/0xa3
> [  247.221548]  ? up+0x2d/0x50
> [  247.224395]  acpi_ns_walk_namespace+0xdc/0x18e
> [  247.228891]  ? set_no_mwait+0x23/0x23
> [  247.232606]  ? set_no_mwait+0x23/0x23
> [  247.236321]  acpi_walk_namespace+0x97/0xcb
> [  247.240471]  ? acpi_sleep_proc_init+0x28/0x28
> [  247.244880]  ? rest_init+0x130/0x130
> [  247.248507]  acpi_early_processor_set_pdc+0x30/0x4a
> [  247.253436]  acpi_init+0x19f/0x315
> [  247.256891]  do_one_initcall+0x3f/0x170
> [  247.260781]  kernel_init_freeable+0x11d/0x1a3
> [  247.265191]  ? rest_init+0x130/0x130
> [  247.268822]  kernel_init+0x9/0x100
> [  247.272276]  ret_from_fork+0x27/0x40
> [  247.275904] 
> [  247.275904] Showing all locks held in the system:
> [  247.282179] 2 locks held by khungtaskd/34:
> [  247.286326]  #0:  (rcu_read_lock){......}, at: [<ffffffff811332cc>] watchdog+0x9c/0x600
> [  247.294423]  #1:  (tasklist_lock){.+.+..}, at: [<ffffffff810dae1d>] debug_show_all_locks+0x3d/0x1a0
> [  247.303562] 
> [  247.305105] =============================================
> [  247.305105] 
> 

Lv, can you have a look at this, please?

Thanks,
Rafael


^ permalink raw reply	[flat|nested] 8+ messages in thread

* Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-11  3:09 ` Rafael J. Wysocki
@ 2017-01-18 13:25   ` Tomi Sarvela
  2017-01-19  3:00     ` Zheng, Lv
  0 siblings, 1 reply; 8+ messages in thread
From: Tomi Sarvela @ 2017-01-18 13:25 UTC (permalink / raw)
  To: Lv Zheng; +Cc: Rafael J. Wysocki, ACPI Devel Maling List

On Wednesday, 11 January 2017 04:09:29 EET Rafael J. Wysocki wrote:
> On Tuesday, January 10, 2017 12:07:36 PM Tomi Sarvela wrote:
> > 
> > This might help: there is dump after a while. I've been too hasty
> > to reboot the machine to see this before.
> Thanks!

Has there been any progress or interest towards tracking down this particular problem?

Tested with  4.10-rc3. Boot hangs to the same point, dmesg INFO bursts like below come with ~120sec intervals.

Best regards,

Tomi Sarvela

> > [    0.854462] ACPI: Added _OSI(Module Device)
> > [    0.858701] ACPI: Added _OSI(Processor Device)
> > [    0.863197] ACPI: Added _OSI(3.0 _SCP Extensions)
> > [    0.867952] ACPI: Added _OSI(Processor Aggregator Device)
> > [    0.893684] ACPI: Dynamic OEM Table Load:
> > [    0.897758] ACPI: SSDT 0xFFFF8802122EBA78 0003BA (v01 COMPAQ
> > CPU_TM2  00000001 MSFT 0100000E) [  247.066214] INFO: task
> > swapper/0:1 blocked for more than 120 seconds. [  247.072707]    
> >   Not tainted 4.10.0-rc2-gfxbench+ #1
> > [  247.077809] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"
> > disables this message. [  247.085731] swapper/0       D    0    
> > 1      0 0x00000000 [  247.091271] Call Trace:
> > [  247.093774]  ? __schedule+0x2c9/0xa60
> > [  247.097489]  schedule+0x3b/0x90
> > [  247.100685]  schedule_timeout+0x25b/0x4c0
> > [  247.104750]  ? debug_smp_processor_id+0x17/0x20
> > [  247.109334]  ? set_track+0x88/0x120
> > [  247.112878]  ? trace_hardirqs_on_caller+0x122/0x1b0
> > [  247.117808]  __down_timeout+0x81/0xd0
> > [  247.121523]  down_timeout+0x47/0x50
> > [  247.125065]  acpi_os_wait_semaphore+0x47/0x62
> > [  247.129475]  acpi_ut_acquire_mutex+0x43/0x81
> > [  247.133798]  acpi_get_table+0x2d/0x84
> > [  247.137513]  acpi_table_attr_init+0xcd/0x100
> > [  247.141834]  ? acpi_sysfs_table_handler+0x3e/0xb8
> > [  247.146590]  acpi_sysfs_table_handler+0x5d/0xb8
> > [  247.151174]  acpi_bus_table_handler+0x23/0x2a
> > [  247.155583]  acpi_tb_install_standard_table+0xe0/0x213
> > [  247.160773]  ? down_timeout+0x32/0x50
> > [  247.164489]  acpi_tb_install_and_load_table+0x3a/0x82
> > [  247.169592]  acpi_ex_load_op+0x194/0x201
> > [  247.173568]  ? acpi_ex_resolve_operands+0x207/0x4dc
> > [  247.178497]  acpi_ex_opcode_1A_1T_0R+0x25/0x46
> > [  247.182993]  acpi_ds_exec_end_op+0xc8/0x3df
> > [  247.187229]  acpi_ps_parse_loop+0x50e/0x560
> > [  247.191465]  acpi_ps_parse_aml+0x93/0x276
> > [  247.195526]  acpi_ps_execute_method+0x146/0x181
> > [  247.200108]  acpi_ns_evaluate+0x1bb/0x247
> > [  247.204170]  acpi_evaluate_object+0x178/0x274
> > [  247.208581]  ? acpi_processor_set_pdc+0x88/0x17b
> > [  247.213249]  acpi_processor_set_pdc+0x154/0x17b
> > [  247.217833]  early_init_pdc+0x9a/0xa3
> > [  247.221548]  ? up+0x2d/0x50
> > [  247.224395]  acpi_ns_walk_namespace+0xdc/0x18e
> > [  247.228891]  ? set_no_mwait+0x23/0x23
> > [  247.232606]  ? set_no_mwait+0x23/0x23
> > [  247.236321]  acpi_walk_namespace+0x97/0xcb
> > [  247.240471]  ? acpi_sleep_proc_init+0x28/0x28
> > [  247.244880]  ? rest_init+0x130/0x130
> > [  247.248507]  acpi_early_processor_set_pdc+0x30/0x4a
> > [  247.253436]  acpi_init+0x19f/0x315
> > [  247.256891]  do_one_initcall+0x3f/0x170
> > [  247.260781]  kernel_init_freeable+0x11d/0x1a3
> > [  247.265191]  ? rest_init+0x130/0x130
> > [  247.268822]  kernel_init+0x9/0x100
> > [  247.272276]  ret_from_fork+0x27/0x40
> > [  247.275904]
> > [  247.275904] Showing all locks held in the system:
> > [  247.282179] 2 locks held by khungtaskd/34:
> > [  247.286326]  #0:  (rcu_read_lock){......}, at:
> > [<ffffffff811332cc>] watchdog+0x9c/0x600 [  247.294423]  #1: 
> > (tasklist_lock){.+.+..}, at: [<ffffffff810dae1d>]
> > debug_show_all_locks+0x3d/0x1a0 [  247.303562]
> > [  247.305105] =============================================
> > [  247.305105]
> 
> Lv, can you have a look at this, please?
> 
> Thanks,
> Rafael



^ permalink raw reply	[flat|nested] 8+ messages in thread

* RE: ILK ACPI boot-up problem on HP 8100 SFF, bisected
  2017-01-18 13:25   ` Tomi Sarvela
@ 2017-01-19  3:00     ` Zheng, Lv
  0 siblings, 0 replies; 8+ messages in thread
From: Zheng, Lv @ 2017-01-19  3:00 UTC (permalink / raw)
  To: Sarvela, Tomi P; +Cc: Rafael J. Wysocki, ACPI Devel Maling List

Hi,


> From: Sarvela, Tomi P
> Subject: Re: ILK ACPI boot-up problem on HP 8100 SFF, bisected
> 
> On Wednesday, 11 January 2017 04:09:29 EET Rafael J. Wysocki wrote:
> > On Tuesday, January 10, 2017 12:07:36 PM Tomi Sarvela wrote:
> > >
> > > This might help: there is dump after a while. I've been too hasty
> > > to reboot the machine to see this before.
> > Thanks!
> 
> Has there been any progress or interest towards tracking down this particular problem?
> 
> Tested with  4.10-rc3. Boot hangs to the same point, dmesg INFO bursts like below come with ~120sec
> intervals.

Thanks for the report.
I also got this reported from LKP.
And was about to request the test platform.
The provided call stack helped me lot.
I can clearly see what's happening now.

Wait me for a while and you'll see the fix.

Thanks and best regards
Lv

> 
> Best regards,
> 
> Tomi Sarvela
> 
> > > [    0.854462] ACPI: Added _OSI(Module Device)
> > > [    0.858701] ACPI: Added _OSI(Processor Device)
> > > [    0.863197] ACPI: Added _OSI(3.0 _SCP Extensions)
> > > [    0.867952] ACPI: Added _OSI(Processor Aggregator Device)
> > > [    0.893684] ACPI: Dynamic OEM Table Load:
> > > [    0.897758] ACPI: SSDT 0xFFFF8802122EBA78 0003BA (v01 COMPAQ
> > > CPU_TM2  00000001 MSFT 0100000E) [  247.066214] INFO: task
> > > swapper/0:1 blocked for more than 120 seconds. [  247.072707]
> > >   Not tainted 4.10.0-rc2-gfxbench+ #1
> > > [  247.077809] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"
> > > disables this message. [  247.085731] swapper/0       D    0
> > > 1      0 0x00000000 [  247.091271] Call Trace:
> > > [  247.093774]  ? __schedule+0x2c9/0xa60
> > > [  247.097489]  schedule+0x3b/0x90
> > > [  247.100685]  schedule_timeout+0x25b/0x4c0
> > > [  247.104750]  ? debug_smp_processor_id+0x17/0x20
> > > [  247.109334]  ? set_track+0x88/0x120
> > > [  247.112878]  ? trace_hardirqs_on_caller+0x122/0x1b0
> > > [  247.117808]  __down_timeout+0x81/0xd0
> > > [  247.121523]  down_timeout+0x47/0x50
> > > [  247.125065]  acpi_os_wait_semaphore+0x47/0x62
> > > [  247.129475]  acpi_ut_acquire_mutex+0x43/0x81
> > > [  247.133798]  acpi_get_table+0x2d/0x84
> > > [  247.137513]  acpi_table_attr_init+0xcd/0x100
> > > [  247.141834]  ? acpi_sysfs_table_handler+0x3e/0xb8
> > > [  247.146590]  acpi_sysfs_table_handler+0x5d/0xb8
> > > [  247.151174]  acpi_bus_table_handler+0x23/0x2a
> > > [  247.155583]  acpi_tb_install_standard_table+0xe0/0x213
> > > [  247.160773]  ? down_timeout+0x32/0x50
> > > [  247.164489]  acpi_tb_install_and_load_table+0x3a/0x82
> > > [  247.169592]  acpi_ex_load_op+0x194/0x201
> > > [  247.173568]  ? acpi_ex_resolve_operands+0x207/0x4dc
> > > [  247.178497]  acpi_ex_opcode_1A_1T_0R+0x25/0x46
> > > [  247.182993]  acpi_ds_exec_end_op+0xc8/0x3df
> > > [  247.187229]  acpi_ps_parse_loop+0x50e/0x560
> > > [  247.191465]  acpi_ps_parse_aml+0x93/0x276
> > > [  247.195526]  acpi_ps_execute_method+0x146/0x181
> > > [  247.200108]  acpi_ns_evaluate+0x1bb/0x247
> > > [  247.204170]  acpi_evaluate_object+0x178/0x274
> > > [  247.208581]  ? acpi_processor_set_pdc+0x88/0x17b
> > > [  247.213249]  acpi_processor_set_pdc+0x154/0x17b
> > > [  247.217833]  early_init_pdc+0x9a/0xa3
> > > [  247.221548]  ? up+0x2d/0x50
> > > [  247.224395]  acpi_ns_walk_namespace+0xdc/0x18e
> > > [  247.228891]  ? set_no_mwait+0x23/0x23
> > > [  247.232606]  ? set_no_mwait+0x23/0x23
> > > [  247.236321]  acpi_walk_namespace+0x97/0xcb
> > > [  247.240471]  ? acpi_sleep_proc_init+0x28/0x28
> > > [  247.244880]  ? rest_init+0x130/0x130
> > > [  247.248507]  acpi_early_processor_set_pdc+0x30/0x4a
> > > [  247.253436]  acpi_init+0x19f/0x315
> > > [  247.256891]  do_one_initcall+0x3f/0x170
> > > [  247.260781]  kernel_init_freeable+0x11d/0x1a3
> > > [  247.265191]  ? rest_init+0x130/0x130
> > > [  247.268822]  kernel_init+0x9/0x100
> > > [  247.272276]  ret_from_fork+0x27/0x40
> > > [  247.275904]
> > > [  247.275904] Showing all locks held in the system:
> > > [  247.282179] 2 locks held by khungtaskd/34:
> > > [  247.286326]  #0:  (rcu_read_lock){......}, at:
> > > [<ffffffff811332cc>] watchdog+0x9c/0x600 [  247.294423]  #1:
> > > (tasklist_lock){.+.+..}, at: [<ffffffff810dae1d>]
> > > debug_show_all_locks+0x3d/0x1a0 [  247.303562]
> > > [  247.305105] =============================================
> > > [  247.305105]
> >
> > Lv, can you have a look at this, please?
> >
> > Thanks,
> > Rafael
> 


^ permalink raw reply	[flat|nested] 8+ messages in thread

end of thread, other threads:[~2017-01-19  3:01 UTC | newest]

Thread overview: 8+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2017-01-10 10:07 ILK ACPI boot-up problem on HP 8100 SFF, bisected Tomi Sarvela
2017-01-11  3:09 ` Rafael J. Wysocki
2017-01-18 13:25   ` Tomi Sarvela
2017-01-19  3:00     ` Zheng, Lv
  -- strict thread matches above, loose matches on Subject: below --
2017-01-09 16:01 Tomi Sarvela
2017-01-09 22:07 ` Rafael J. Wysocki
2017-01-09 22:28   ` Rafael J. Wysocki
2017-01-10  8:46     ` Tomi Sarvela

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox