Subject: Re: 'shutdown -p now' power down broken on i386/-current (?)
To: Juan RP <juan@xtrarom.org>
From: Markus W Kilbinger <mk@kilbi.de>
List: current-users
Date: 09/02/2007 18:42:23
>>>>> "Juan" == Juan RP <juan@xtrarom.org> writes:

    >> Current -current kernels are no capable to power down my dual
    >> cpu i386 box. Last message displayed after syncing disks is:
    >>
    >> acpi: Entering state 5
    >>
    >> Then the machine hangs and stays powered on.
    >>
    >> Does anybody else see this?

    Juan> Probably a locking error or any other problem, can you try
    Juan> with options DEBUG/DIAGNOSTIC/LOCKDEBUG?

I did: With all 3 options turned on (DIAGNOSTIC was enabled already)
the machine panics during booting (While doing some ipv6 stuff? see
remote console output attached).

Something else I can test or other information I can provide?

Markus.


  >> NetBSD/i386 BIOS Boot, Revision 3.3
  >> (kilbi@qie, Thu Aug 30 08:46:30 MEST 2007)
  >> Memory: 639/1047472 k
  > boot nnetbsd
  booting hd0a:nnetbsd
  5043176+238180+345424 [298352+296316]=0x5f0e44
  Loaded initial symtab at 0xc065f7b4, strtab at 0xc06a88c8, # entries 17610
  Copyright (c) 1996, 1997, 1998, 1999, 2000, 2001, 2002, 2003, 2004, 2005,
      2006, 2007
      The NetBSD Foundation, Inc.  All rights reserved.
  Copyright (c) 1982, 1986, 1989, 1991, 1993
      The Regents of the University of California.  All rights reserved.
  
  NetBSD 4.99.30 (QIE.MP) #0: Sun Sep  2 17:41:50 MEST 2007
          kilbi@qie:/usr/src/sys/arch/i386/compile/QIE.MP
  total memory = 1023 MB
  avail memory = 997 MB
  mainbus0 (root)
  cpu0 at mainbus0 apid 0: (boot processor)
  cpu0: AMD Athlon MP 2000+ (686-class), 1666.87 MHz, id 0x662
  cpu0: "AMD Athlon(TM) MP 2000+"
  cpu1 at mainbus0 apid 1: (application processor)
  cpu1: AMD Athlon MP 2000+ (686-class), 1666.73 MHz, id 0x662
  cpu1: "AMD Athlon(TM) MP 2000+"
  ioapic0 at mainbus0 apid 2
  acpi0 at mainbus0: Advanced Configuration and Power Interface
  ACPI-Safe 24-bit timer
  [...]
  IPsec: Initialized Security Association Processing.
  boot device: wd0
  root on wd0a dumps on wd0b
  mountroot: trying lfs...
  mountroot: trying ffs...
  root file system type: ffs
  init: copying out path `/sbin/init' 11
  Sun Sep  2 16:17:05 GMT 2007
  swapctl: adding /de/wd0b as swap device at priority 0
  Starting file system checks:
  /dev/rwd0a: file system is clean; not checking
  /dev/rwd0e: file system is clean; not checking
  /dev/rwd0g: file system is clean; not checking
  /dev/rwd1e: 9409 files, 1382216 free (345554 clusters)
  Setting tty flags.
  Setting sysctl variables:
  kern.sbmax: 262144 -> 1048576
  net.inet.tcp.sendspace: 32768 -> 131072
  net.inet.tcp.recvspace: 32768 -> 131072
  net.inet.udp.sendspace: 9216 -> 36864
  net.inet.udp.recvspace: 41600 -> 166400
  net.inet6.udp6.sendspace: 9216 -> 36864
  net.inet6.udp6.recvspace: 42080 -> 168320
  net.inet.tcp.ecn.enable: 0 -> 1
  net.inet.ipsec.ecn: 0 -> 1
  net.inet6.tcp6.ecn.enable: 1 -> 1
  net.inet6.ipsec6.ecn: 0 -> 1
  Starting network.
  Hostname: qie
  NIS domainname: kilbi
  IPv6 mode: autoconfigured host
  Configuring network interfaces: fxp0panic: assert_sleepable: idle
  Stopped in pid 0.2 (system) at  netbsd:cpu_Debugger+0x4:        leave
  db{0}> bt
  cpu_Debugger(c058a7f3,cb6d68fc,0,5,16523f0) at netbsd:cpu_Debugger+0x4
  panic(c0569fa9,12,cb6d6950,c0369d63,0) at netbsd:panic+0x155
  assert_sleepable(0,c0560108,c0659ac0,c0625580,1e40940) at netbsd:assert_sleepabl
  e+0x53
  malloc(12,c05de080,0,2,101) at netbsd:malloc+0x2c3
  sockaddr_alloc(12,12,0,c036a4c1,c064e302) at netbsd:sockaddr_alloc+0x34
  sockaddr_dl_alloc(1,6,0,4,0) at netbsd:sockaddr_dl_alloc+0x51
  nd6_rtrequest(1,c1a37ee4,cb6d6b18,c1a37ee4,cb6d6b94) at netbsd:nd6_rtrequest+0xe
  2
  rtrequest1(1,cb6d6b18,cb6d6bb0,c1deeccc,c0625598) at netbsd:rtrequest1+0x502
  rtrequest(1,c1deb08c,c1db9944,cb6d6b94,101) at netbsd:rtrequest+0x44
  nd6_prefix_onlink(c1deb080,40,60,c1deb600,cb6d6d30) at netbsd:nd6_prefix_onlink+
  0x153
  nd6_prelist_add(cb6d6d30,c1e4d4c0,cb6d6dd0,c038caed,c0659ac0) at netbsd:nd6_prel
  ist_add+0x172
  nd6_ra_input(c1a35d00,28,58,1,cb6d6e20) at netbsd:nd6_ra_input+0xbde
  icmp6_input(cb6d6fe8,cb6d6fcc,3a,1,1651b20) at netbsd:icmp6_input+0x89a
  ip6_input(c1a21e00,0,c1d44380,c010d1c2,cb649c04) at netbsd:ip6_input+0x8ad
  ip6intr(cb649c04,c523ccb3,uvm_fault(0xc0624480, 0xcb6d7000, 1) -> 0xe
  kernel: supervisor trap page fault, code=0
  Faulted in DDB; continuing...
  db{0}> c
  syncing disks... Kernel lock error: _kernel_lock: spinout
  
  lock address : 0x00000000c064e0e8 type     :               spin
  shared holds :                  0 exclusive:                  1
  shares wanted:                  0 exclusive:                  1
  current cpu  :                  1 last held:                  0
  current lwp  : 0x00000000cc114700 last held: 0x00000000cb6e1e00
  last locked  : 0x00000000c040de7a unlocked : 0x00000000c040dec5
  curcpu holds :                  0 wanted by: 0x00000000cc114700
  
  panic: LOCKDEBUG
  Stopped in pid 93.1 (rtsol) at  netbsd:cpu_Debugger+0x4:        leave
  db{1}> c
  
  dumping to dev 0,1 offset 1049511
  dump 1023 1022 1021 [...]