Re: PII SMP system hangs during boot with ACPI enabled

From: John Polstra <jdp_at_polstra.com>
Date: Mon, 24 Nov 2003 13:07:56 -0800 (PST)
On 24-Nov-2003 Nate Lawson wrote:
> 
> Please also send the output of acpidump -t -d > jdp-P2.asl

When I try to run that command, I get:

  acpidump: sysctl machdep.acpi_root does not point to RSDP

The sysctl command shows that machdep.acpi_root is 0.
Remember, though, in order to boot it I had to disable ACPI in
/boot/loader.conf.

> If you can break to the debugger after it has hung, a tr would be nice.

The fact that it didn't occur to me to try that says a lot about how
long I've been away from -current. :-(  I've attached traces from
two different boots.  They seem to vary somewhat.  I can supply line
numbers on request.

John

db> trace
siointr1(c298d000,0,c06c9bb7,6a0,cdb64a04) at siointr1+0xec
siointr(c298d000,c06a7546,c070bf40,c2944100,4) at siointr+0x35
intr_execute_handlers(c129f88c,cdb64a1c,cdb64a64,c065ca63,34) at intr_execute_ha
ndlers+0xc8
lapic_handle_intr(34) at lapic_handle_intr+0x3a
Xapic_isr1() at Xapic_isr1+0x33
--- interrupt, eip = 0xc053b9a4, esp = 0xcdb64a60, ebp = 0xcdb64a64 ---
wakeup(c2944100,0,c06a7546,140,6c) at wakeup+0x4
AcpiOsSignalSemaphore(c2944100,1) at AcpiOsSignalSemaphore+0xa8
AcpiUtReleaseMutex(9,30,c295e8c0,c295e760,cdb64acc) at AcpiUtReleaseMutex+0x8c
AcpiUtReleaseToCache(3,c295e760,cdb64ad8,c045ac17,c295e760) at AcpiUtReleaseToCa
che+0x8c
AcpiPsFreeOp(c295e760,cdb64afc,c045ab37,c12a0800,0) at AcpiPsFreeOp+0x30
AcpiPsDeleteCompletedOp(c12a0800,0,c12a0800,c295e7c0,c12a0800) at AcpiPsDeleteCo
mpletedOp+0x17
AcpiPsGetNextWalkOp(c12a0800,c295e760,c045ac00,c2967080,c295e8c0) at AcpiPsGetNe
xtWalkOp+0x77
AcpiPsDeleteParseTree(c295e8c0,c12a0c00,c12a0de4,0,cdb64bf4) at AcpiPsDeletePars
eTree+0x9a
AcpiPsCompleteThisOp(c12a0c00,c295e8c0,0,c12a0c10,150) at AcpiPsCompleteThisOp+0
x1b8
AcpiPsParseLoop(c12a0c00,c2967340,cdb64c14,c12a0c00,c12a0de4) at AcpiPsParseLoop
+0x6c8
AcpiPsParseAml(c12a0c00,c2967380,c295ca80,ce5b5ac0,d) at AcpiPsParseAml+0x7c
AcpiPsxExecute(c295ca80,0,cdb64c9c,c295ca80,0) at AcpiPsxExecute+0x202
AcpiNsExecuteControlMethod(c295ca80,0,cdb64c9c,c2944180,c294dedc) at AcpiNsExecu
teControlMethod+0x5f
AcpiNsEvaluateByHandle(c295ca80,0,0,76,c295ca80) at AcpiNsEvaluateByHandle+0x96
AcpiEvAsynchExecuteGpeMethod(c294dedc,0,c06a7461,7b,0) at AcpiEvAsynchExecuteGpe
Method+0x8c
acpi_task_thread(0,cdb64d48,c06b7385,311,5f616964) at acpi_task_thread+0x105
fork_exit(c0474e20,0,cdb64d48) at fork_exit+0xb4
fork_trampoline() at fork_trampoline+0x8
--- trap 0x1, eip = 0, esp = 0xcdb64d7c, ebp = 0 ---
db> c
~Stopped at      siointr1+0xec:  jmp     siointr1+0x220
db> show all procs
  pid   proc     uarea   uid  ppid  pgrp  flag   stat  wmesg    wchan  cmd
   48 c299a8d4 d2633000    0     0     0 0000204 [IWAIT] swi0: tty:sio
   47 c28f0a98 ce57a000    0     0     0 0000204 new [RUNQ] usbtask
   46 c28f0c5c ce57b000    0     0     0 0000204 new [RUNQ] usb0
    8 c28f0e20 ce57c000    0     0     0 0000204 new [RUNQ] acpi_task2
    7 c2935000 ce57d000    0     0     0 0000204 new [RUNQ] acpi_task1
    6 c29351c4 ce57e000    0     0     0 0000204 [CPU 0] acpi_task0
   45 c2935388 ce57f000    0     0     0 0000204 [IWAIT] swi7: acpitaskq
   44 c293554c ce580000    0     0     0 0000204 new [IWAIT] swi3: cambio
   43 c2935710 ce581000    0     0     0 0000204 new [IWAIT] swi2: camnet
   42 c29358d4 ce582000    0     0     0 0000204 new [IWAIT] swi5:+
    5 c2935a98 ce583000    0     0     0 0000204 [SLP]tqthr 0xc070f268] taskqueu
e
   41 c2935c5c ce5a8000    0     0     0 0000204 new [IWAIT] swi6:+
   40 c2935e20 ce5a9000    0     0     0 0000204 [IWAIT] swi7: task queue
   39 c2937000 ce5aa000    0     0     0 0000204 [RUNQ] random
    4 c28e154c ce54a000    0     0     0 0000204 [RUNQ] g_down
    3 c28e1710 ce54b000    0     0     0 0000204 [RUNQ] g_up
    2 c28e18d4 ce54c000    0     0     0 0000204 [RUNQ] g_event
   38 c28e1a98 ce54d000    0     0     0 0000204 new [IWAIT] swi4: vm
   37 c28e1c5c ce54e000    0     0     0 000020c [IWAIT] swi8: tty:sio clock
   36 c28e1e20 ce54f000    0     0     0 0000204 new [IWAIT] swi1: net
   35 c28f0000 ce550000    0     0     0 0000204 new [IWAIT] irq9:
   34 c28f01c4 ce575000    0     0     0 0000204 new [IWAIT] irq0: clk
   33 c28f0388 ce576000    0     0     0 0000204 new [IWAIT] irq23:
   32 c28f054c ce577000    0     0     0 0000204 new [IWAIT] irq22:
   31 c28f0710 ce578000    0     0     0 0000204 new [IWAIT] irq21:
   30 c28f08d4 ce579000    0     0     0 0000204 [RUNQ] irq20: acpi0
   29 c12ae1c4 cdb49000    0     0     0 0000204 new [IWAIT] irq19: fxp0 uhci0
   28 c12ae388 cdb4a000    0     0     0 0000204 new [IWAIT] irq18:
   27 c12ae54c cdb4b000    0     0     0 0000204 new [IWAIT] irq17: fxp1
   26 c12ae710 cdb4c000    0     0     0 0000204 new [IWAIT] irq16: ahc0 ahc1
   25 c12ae8d4 cdb71000    0     0     0 0000204 new [IWAIT] irq15: ata1
   24 c12aea98 cdb72000    0     0     0 0000204 [IWAIT] irq14: ata0
   23 c12aec5c cdb73000    0     0     0 0000204 new [IWAIT] irq13:
   22 c12aee20 cdb74000    0     0     0 0000204 new [IWAIT] irq12:
   21 c28e1000 ce547000    0     0     0 0000204 new [IWAIT] irq11:
   20 c28e11c4 ce548000    0     0     0 0000204 new [IWAIT] irq10:
   19 c28e1388 ce549000    0     0     0 0000204 new [IWAIT] irq8: rtc
   18 c12a7000 cdaf7000    0     0     0 0000204 new [IWAIT] irq7:
   17 c12a71c4 cdb40000    0     0     0 0000204 [IWAIT] irq6: fdc0
   16 c12a7388 cdb41000    0     0     0 0000204 new [IWAIT] irq5:
   15 c12a754c cdb42000    0     0     0 0000204 new [IWAIT] irq4: sio0
   14 c12a7710 cdb43000    0     0     0 0000204 new [IWAIT] irq3: sio1
   13 c12a78d4 cdb44000    0     0     0 0000204 new [IWAIT] irq1:
   12 c12a7a98 cdb45000    0     0     0 000020c [Can run] idle: cpu0
   11 c12a7c5c cdb46000    0     0     0 000020c [Can run] idle: cpu1
    1 c12a7e20 cdb47000    0     0     0 0000200 new [INACTIVE] swapper
   10 c12ae000 cdb48000    0     0     0 0000204 [CV]ktrace 0xc070ba04] ktrace
    0 c0708580 c081f000    0     0     0 0000200 [RUNQ] swapper
db> c

db> trace
siointr1(c298d000,0,c06c9bb7,6a0,cdb64b04) at siointr1+0xec
siointr(c298d000,c29657c0,cdb64afc,c044b090,4) at siointr+0x35
intr_execute_handlers(c129f88c,cdb64b1c,cdb64b7c,c065ca63,34) at intr_execute_ha
ndlers+0xc8
lapic_handle_intr(34) at lapic_handle_intr+0x3a
Xapic_isr1() at Xapic_isr1+0x33
--- interrupt, eip = 0xc052a396, esp = 0xcdb64b60, ebp = 0xcdb64b7c ---
_mtx_unlock_flags(c2944100,0,c06a7546,150,6c) at _mtx_unlock_flags+0x96
AcpiOsSignalSemaphore(c2944100,1) at AcpiOsSignalSemaphore+0xc8
AcpiUtReleaseMutex(9,8,c045f9cc,c2965940,c12a0c00) at AcpiUtReleaseMutex+0x8c
AcpiUtAcquireFromCache(2,cdb64bf4,c0462229,c12a0c00,cdb64c34) at AcpiUtAcquireFr
omCache+0x53
AcpiUtCreateGenericState(c12a0c00,cdb64c34,c045a199,c12a0e18,c2965940) at AcpiUt
CreateGenericState+0x12
AcpiUtCreateThreadState(c12a0e18,c2965940,cdb64c14,c12a0c00,c12a0de4) at AcpiUtC
reateThreadState+0x9
AcpiPsParseAml(c12a0c00,c2967380,c295ca80,ce5b5ac0,d) at AcpiPsParseAml+0x29
AcpiPsxExecute(c295ca80,0,cdb64c9c,c295ca80,0) at AcpiPsxExecute+0x202
AcpiNsExecuteControlMethod(c295ca80,0,cdb64c9c,c2944180,c294dedc) at AcpiNsExecu
teControlMethod+0x5f
AcpiNsEvaluateByHandle(c295ca80,0,0,76,c295ca80) at AcpiNsEvaluateByHandle+0x96
AcpiEvAsynchExecuteGpeMethod(c294dedc,0,c06a7461,7b,0) at AcpiEvAsynchExecuteGpe
Method+0x8c
acpi_task_thread(0,cdb64d48,c06b7385,311,5f616964) at acpi_task_thread+0x105
fork_exit(c0474e20,0,cdb64d48) at fork_exit+0xb4
fork_trampoline() at fork_trampoline+0x8
--- trap 0x1, eip = 0, esp = 0xcdb64d7c, ebp = 0 ---
db> show all procs
  pid   proc     uarea   uid  ppid  pgrp  flag   stat  wmesg    wchan  cmd
   48 c299a8d4 d2633000    0     0     0 0000204 [IWAIT] swi0: tty:sio
   47 c28f0a98 ce57a000    0     0     0 0000204 new [RUNQ] usbtask
   46 c28f0c5c ce57b000    0     0     0 0000204 new [RUNQ] usb0
    8 c28f0e20 ce57c000    0     0     0 0000204 new [RUNQ] acpi_task2
    7 c2935000 ce57d000    0     0     0 0000204 new [RUNQ] acpi_task1
    6 c29351c4 ce57e000    0     0     0 0000204 [CPU 0] acpi_task0
   45 c2935388 ce57f000    0     0     0 0000204 [IWAIT] swi7: acpitaskq
   44 c293554c ce580000    0     0     0 0000204 new [IWAIT] swi3: cambio
   43 c2935710 ce581000    0     0     0 0000204 new [IWAIT] swi2: camnet
   42 c29358d4 ce582000    0     0     0 0000204 new [IWAIT] swi5:+
    5 c2935a98 ce583000    0     0     0 0000204 [SLP]tqthr 0xc070f268] taskqueu
e
   41 c2935c5c ce5a8000    0     0     0 0000204 new [IWAIT] swi6:+
   40 c2935e20 ce5a9000    0     0     0 0000204 [IWAIT] swi7: task queue
   39 c2937000 ce5aa000    0     0     0 0000204 [RUNQ] random
    4 c28e154c ce54a000    0     0     0 0000204 [RUNQ] g_down
    3 c28e1710 ce54b000    0     0     0 0000204 [RUNQ] g_up
    2 c28e18d4 ce54c000    0     0     0 0000204 [RUNQ] g_event
   38 c28e1a98 ce54d000    0     0     0 0000204 new [IWAIT] swi4: vm
   37 c28e1c5c ce54e000    0     0     0 000020c [IWAIT] swi8: tty:sio clock
   36 c28e1e20 ce54f000    0     0     0 0000204 new [IWAIT] swi1: net
   35 c28f0000 ce550000    0     0     0 0000204 new [IWAIT] irq9:
   34 c28f01c4 ce575000    0     0     0 0000204 new [IWAIT] irq0: clk
   33 c28f0388 ce576000    0     0     0 0000204 new [IWAIT] irq23:
   32 c28f054c ce577000    0     0     0 0000204 new [IWAIT] irq22:
   31 c28f0710 ce578000    0     0     0 0000204 new [IWAIT] irq21:
   30 c28f08d4 ce579000    0     0     0 0000204 [RUNQ] irq20: acpi0
   29 c12ae1c4 cdb49000    0     0     0 0000204 new [IWAIT] irq19: fxp0 uhci0
   28 c12ae388 cdb4a000    0     0     0 0000204 new [IWAIT] irq18:
   27 c12ae54c cdb4b000    0     0     0 0000204 new [IWAIT] irq17: fxp1
   26 c12ae710 cdb4c000    0     0     0 0000204 new [IWAIT] irq16: ahc0 ahc1
   25 c12ae8d4 cdb71000    0     0     0 0000204 new [IWAIT] irq15: ata1
   24 c12aea98 cdb72000    0     0     0 0000204 [IWAIT] irq14: ata0
   23 c12aec5c cdb73000    0     0     0 0000204 new [IWAIT] irq13:
   22 c12aee20 cdb74000    0     0     0 0000204 new [IWAIT] irq12:
   21 c28e1000 ce547000    0     0     0 0000204 new [IWAIT] irq11:
   20 c28e11c4 ce548000    0     0     0 0000204 new [IWAIT] irq10:
   19 c28e1388 ce549000    0     0     0 0000204 new [IWAIT] irq8: rtc
   18 c12a7000 cdaf7000    0     0     0 0000204 new [IWAIT] irq7:
   17 c12a71c4 cdb40000    0     0     0 0000204 [IWAIT] irq6: fdc0
   16 c12a7388 cdb41000    0     0     0 0000204 new [IWAIT] irq5:
   15 c12a754c cdb42000    0     0     0 0000204 new [IWAIT] irq4: sio0
   14 c12a7710 cdb43000    0     0     0 0000204 new [IWAIT] irq3: sio1
   13 c12a78d4 cdb44000    0     0     0 0000204 new [IWAIT] irq1:
   12 c12a7a98 cdb45000    0     0     0 000020c [Can run] idle: cpu0
   11 c12a7c5c cdb46000    0     0     0 000020c [Can run] idle: cpu1
    1 c12a7e20 cdb47000    0     0     0 0000200 new [INACTIVE] swapper
   10 c12ae000 cdb48000    0     0     0 0000204 [CV]ktrace 0xc070ba04] ktrace
    0 c0708580 c081f000    0     0     0 0000200 [RUNQ] swapper
db> c

End of MIME message
Received on Mon Nov 24 2003 - 12:07:59 UTC

This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:37:30 UTC