From owner-freebsd-acpi@FreeBSD.ORG Tue Nov 20 10:35:28 2012 Return-Path: Delivered-To: freebsd-acpi@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [69.147.83.52]) by hub.freebsd.org (Postfix) with ESMTP id 03DDF4D1 for ; Tue, 20 Nov 2012 10:35:28 +0000 (UTC) (envelope-from stefan@fafoe.narf.at) Received: from fep14.mx.upcmail.net (fep14.mx.upcmail.net [62.179.121.34]) by mx1.freebsd.org (Postfix) with ESMTP id 6CD138FC08 for ; Tue, 20 Nov 2012 10:35:26 +0000 (UTC) Received: from edge02.upcmail.net ([192.168.13.237]) by viefep14-int.chello.at (InterMail vM.8.01.05.05 201-2260-151-110-20120111) with ESMTP id <20121120103525.ZKRJ11100.viefep14-int.chello.at@edge02.upcmail.net> for ; Tue, 20 Nov 2012 11:35:25 +0100 Received: from mole.fafoe.narf.at ([80.109.55.137]) by edge02.upcmail.net with edge id RmbP1k00A2xdvHc02mbPyN; Tue, 20 Nov 2012 11:35:25 +0100 X-SourceIP: 80.109.55.137 Received: by mole.fafoe.narf.at (Postfix, from userid 1001) id 0CA866D454; Tue, 20 Nov 2012 11:35:23 +0100 (CET) Date: Tue, 20 Nov 2012 11:35:23 +0100 From: Stefan Farfeleder To: freebsd-acpi@freebsd.org Subject: ACPI panic Message-ID: <20121120103522.GB2012@mole.fafoe.narf.at> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline User-Agent: Mutt/1.5.21 (2010-09-15) X-BeenThere: freebsd-acpi@freebsd.org X-Mailman-Version: 2.1.14 Precedence: list List-Id: ACPI and power management development List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 20 Nov 2012 10:35:28 -0000 Hi, today I got the following panic on booting. The error seems to be some kind of race condition, as the same kernel booted fine before and afterwards. This is current, r243234. Any additional information required to debug/fix this? Stefan ### mole.fafoe.narf.at dumped core - see /var/crash/vmcore.7 Tue Nov 20 10:44:28 CET 2012 FreeBSD mole.fafoe.narf.at 10.0-CURRENT FreeBSD 10.0-CURRENT #126 r243234M: Sun Nov 18 19:36:28 CET 2012 stefan@mole.fafoe.narf.at:/usr/obj/usr/src/sys/MOLE amd64 panic: GNU gdb 6.1.1 [FreeBSD] Copyright 2004 Free Software Foundation, Inc. GDB is free software, covered by the GNU General Public License, and you are welcome to change it and/or distribute copies of it under certain conditions. Type "show copying" to see the conditions. There is absolutely no warranty for GDB. Type "show warranty" for details. This GDB was configured as "amd64-marcel-freebsd"... Unread portion of the kernel message buffer: Copyright (c) 1992-2012 The FreeBSD Project. Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 The Regents of the University of California. All rights reserved. FreeBSD is a registered trademark of The FreeBSD Foundation. FreeBSD 10.0-CURRENT #126 r243234M: Sun Nov 18 19:36:28 CET 2012 stefan@mole.fafoe.narf.at:/usr/obj/usr/src/sys/MOLE amd64 CPU: Intel(R) Core(TM)2 Duo CPU T9600 @ 2.80GHz (2793.06-MHz K8-class CPU) Origin = "GenuineIntel" Id = 0x1067a Family = 0x6 Model = 0x17 Stepping = 10 Features=0xbfebfbff Features2=0xc08e3fd AMD Features=0x20100800 AMD Features2=0x1 TSC: P-state invariant, performance statistics real memory = 4294967296 (4096 MB) avail memory = 4017496064 (3831 MB) Event timer "LAPIC" quality 400 ACPI APIC Table: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs FreeBSD/SMP: 1 package(s) x 2 core(s) cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 1 ioapic0: Changing APIC ID to 2 ioapic0 irqs 0-23 on motherboard kbd1 at kbdmux0 acpi0: on motherboard hpet0: iomem 0xfed00000-0xfed003ff on acpi0 Timecounter "HPET" frequency 14318180 Hz quality 950 Event timer "HPET" frequency 14318180 Hz quality 450 Event timer "HPET1" frequency 14318180 Hz quality 440 Event timer "HPET2" frequency 14318180 Hz quality 440 Event timer "HPET3" frequency 14318180 Hz quality 440 acpi0: reservation of 0, 9f000 (3) failed acpi0: reservation of 100000, df351c00 (3) failed cpu0: on acpi0 cpu1: on acpi0 atrtc0: port 0x70-0x71,0x72-0x77 irq 8 on acpi0 Event timer "RTC" frequency 32768 Hz quality 0 attimer0: port 0x40-0x43,0x50-0x53 irq 2 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 Timecounter "ACPI-fast" frequency 3579545 Hz quality 900 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 acpi_ec0: port 0x930,0x934 on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pcib1: at device 1.0 on pci0 pci1: on pcib1 vgapci0: port 0xdf00-0xdf7f mem 0xf5000000-0xf5ffffff,0xe0000000-0xefffffff,0xf2000000-0xf3ffffff irq 16 at device 0.0 on pci1 nvidia0: on vgapci0 vgapci0: child nvidia0 requested pci_enable_io vgapci0: child nvidia0 requested pci_enable_io pci0: at device 3.0 (no driver attached) atapci0: port 0xef78-0xef7f,0xef70-0xef73,0xef80-0xef87,0xef74-0xef77,0xef90-0xef9f irq 18 at device 3.2 on pci0 ata2: at channel 0 on atapci0 ata3: at channel 1 on atapci0 pci0: at device 3.3 (no driver attached) em0: port 0xefe0-0xefff mem 0xf6fe0000-0xf6ffffff,0xf6fdb000-0xf6fdbfff irq 22 at device 25.0 on pci0 em0: Using an MSI interrupt em0: Ethernet address: 00:24:e8:e4:17:93 uhci0: port 0x6f60-0x6f7f irq 20 at device 26.0 on pci0 usbus0 on uhci0 uhci1: port 0x6f80-0x6f9f irq 21 at device 26.1 on pci0 usbus1 on uhci1 uhci2: port 0x6fa0-0x6fbf irq 22 at device 26.2 on pci0 usbus2 on uhci2 ehci0: mem 0xfed1c400-0xfed1c7ff irq 22 at device 26.7 on pci0 usbus3: EHCI version 1.0 usbus3 on ehci0 hdac0: mem 0xf6fdc000-0xf6fdffff irq 21 at device 27.0 on pci0 pcib2: at device 28.0 on pci0 pci11: on pcib2 pcib3: at device 28.1 on pci0 pci12: on pcib3 iwn0: mem 0xf1ffe000-0xf1ffffff irq 17 at device 0.0 on pci12 pcib4: at device 28.2 on pci0 pci13: on pcib4 pcib5: at device 28.3 on pci0 pci14: on pcib5 uhci3: port 0x6f00-0x6f1f irq 20 at device 29.0 on pci0 usbus4 on uhci3 uhci4: port 0x6f20-0x6f3f irq 21 at device 29.1 on pci0 usbus5 on uhci4 uhci5: port 0x6f40-0x6f5f irq 22 at device 29.2 on pci0 usbus6 on uhci5 ehci1: mem 0xfed1c000-0xfed1c3ff irq 20 at device 29.7 on pci0 usbus7: EHCI version 1.0 usbus7 on ehci1 pcib6: at device 30.0 on pci0 pci3: on pcib6 cbb0: irq 19 at device 1.0 on pci3 cardbus0: on cbb0 pccard0: <16-bit PCCard bus> on cbb0 fwohci0: <1394 Open Host Controller Interface> mem 0xf1bff800-0xf1bfffff irq 17 at device 1.1 on pci3 fwohci0: OHCI version 1.10 (ROM=0) fwohci0: No. of Isochronous channels is 4. fwohci0: EUI64 38:4f:c0:00:2a:55:44:90 fwohci0: Phy 1394a available S400, 1 ports. fwohci0: Link S400, max_rec 2048 bytes. firewire0: on fwohci0 dcons_crom0: on firewire0 dcons_crom0: bus_addr 0x2944000 fwohci0: Initiate bus reset fwohci0: fwohci_intr_core: BUS reset fwohci0: fwohci_intr_core: node_id=0x00000000, SelfID Count=1, CYCLEMASTER mode sdhci_pci0: mem 0xf1bff600-0xf1bff6ff irq 18 at device 1.2 on pci3 sdhci_pci0: 1 slot(s) allocated pci3: at device 1.3 (no driver attached) isab0: at device 31.0 on pci0 isa0: on isab0 ahci0: port 0x6e70-0x6e77,0x6e78-0x6e7b,0x6e80-0x6e87,0x6e88-0x6e8b,0x6ea0-0x6ebf mem 0xfed1c800-0xfed1cfff irq 19 at device 31.2 on pci0 ahci0: AHCI v1.20 with 4 3Gbps ports, Port Multiplier supported ahcich0: at channel 0 on ahci0 ahcich1: at channel 1 on ahci0 ahcich4: at channel 4 on ahci0 ahcich5: at channel 5 on ahci0 ahciem0: on ahci0 pci0: at device 31.3 (no driver attached) acpi_lid0: on acpi0 acpi_button0: on acpi0 acpi_button1: on acpi0 acpi_acad0: on acpi0 battery0: on acpi0 battery1: on acpi0 acpi_tz0: on acpi0 atkbdc0: port 0x60,0x64,0x62,0x66 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: model GlidePoint, device ID 0 orm0: at iomem 0xc0000-0xce7ff,0xce800-0xd37ff,0xd3800-0xd3fff on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 coretemp0: on cpu0 est0: on cpu0 p4tcc0: on cpu0 coretemp1: on cpu1 est1: on cpu1 p4tcc1: on cpu1 Timecounters tick every 1.000 msec firewire0: 1 nodes, maxhop <= 0 cable IRM irm(0) (me) firewire0: bus manager 0 hdacc0: at cad 0 on hdac0 hdaa0: at nid 1 on hdacc0 pcm0: at nid 13,10 and 11,14 on hdaa0 pcm1: at nid 15 and 24 on hdaa0 pcm2: at nid 30 on hdaa0 usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 480Mbps High Speed USB v2.0 usbus4: 12Mbps Full Speed USB v1.0 usbus5: 12Mbps Full Speed USB v1.0 usbus6: 12Mbps Full Speed USB v1.0 usbus7: 480Mbps High Speed USB v2.0 ugen0.1: at usbus0 uhub0: on usbus0 ugen1.1: at usbus1 uhub1: on usbus1 ugen2.1: at usbus2 uhub2: on usbus2 ugen3.1: at usbus3 uhub3: on usbus3 ugen4.1: at usbus4 uhub4: on usbus4 ugen5.1: at usbus5 uhub5: on usbus5 ugen6.1: at usbus6 uhub6: on usbus6 ugen7.1: at usbus7 uhub7: on usbus7 uhub0: 2 ports with 2 removable, self powered uhub1: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered uhub4: 2 ports with 2 removable, self powered uhub5: 2 ports with 2 removable, self powered uhub6: 2 ports with 2 removable, self powered ada0 at ahcich0 bus 0 scbus2 target 0 lun 0 ada0: ATA-8 SATA 2.x device ada0: 300.000MB/s transfers (SATA 2.x, UDMA6, PIO 8192bytes) ada0: Command Queueing enabled ada0: 305245MB (625142448 512 byte sectors: 16H 63S/T 16383C) ada0: Previously was known as ad8 pass1 at ahcich1 bus 0 scbus3 target 0 lun 0 pass1: Removable CD-ROM SCSI-0 device pass1: 150.000MB/s transfers (SATA 1.x, UDMA5, ATAPI 12bytes, PIO 8192bytes) pass2 at ahciem0 bus 0 scbus6 target 0 lun 0 pass2: SEMB S-E-S 2.00 device SMP: AP CPU #1 Launched! uhub3: 6 ports with 6 removable, self powered uhub7: 6 ports with 6 removable, self powered Root mount waiting for: usbus3 Root mount waiting for: usbus3 Trying to mount root from ufs:/dev/ufsid/4b1812cf9fe773b5 [rw]... <118>Setting hostuuid: 44454c4c-5000-1035-8042-b8c04f4b344a. <118>Setting hostid: 0x33c89956. <118>Entropy harvesting: interrupts ethernet point_to_point Fatal trap 12: page fault while in kernel mode cpuid = 1; apic id = 01 fault virtual address = 0x10116 fault code = supervisor read data, page not present instruction pointer = 0x20:0xffffffff802b5820 stack pointer = 0x28:0xffffff811fe4f490 frame pointer = 0x28:0xffffff811fe4f4c0 code segment = base 0x0, limit 0xfffff, type 0x1b = DPL 0, pres 1, long 1, def32 0, gran 1 processor eflags = interrupt enabled, resume, IOPL = 0 current process = 52 (sysctl) Reading symbols from /boot/kernel/if_iwn.ko...Reading symbols from /boot/kernel/if_iwn.ko.symbols...done. done. Loaded symbols for /boot/kernel/if_iwn.ko Reading symbols from /boot/kernel/iwn5000fw.ko...Reading symbols from /boot/kernel/iwn5000fw.ko.symbols...done. done. Loaded symbols for /boot/kernel/iwn5000fw.ko Reading symbols from /boot/modules/nvidia.ko...done. Loaded symbols for /boot/modules/nvidia.ko Reading symbols from /boot/kernel/linux.ko...Reading symbols from /boot/kernel/linux.ko.symbols...done. done. Loaded symbols for /boot/kernel/linux.ko #0 doadump (textdump=0) at pcpu.h:229 229 pcpu.h: No such file or directory. in pcpu.h (kgdb) #0 doadump (textdump=0) at pcpu.h:229 #1 0xffffffff802bec2e in db_dump (dummy=, dummy2=0, dummy3=0, dummy4=0x0) at /usr/src/sys/ddb/db_command.c:543 #2 0xffffffff802be7f4 in db_command (last_cmdp=, cmd_table=, dopager=1) at /usr/src/sys/ddb/db_command.c:449 #3 0xffffffff802be4e2 in db_command_loop () at /usr/src/sys/ddb/db_command.c:502 #4 0xffffffff802c0dc0 in db_trap (type=, code=0) at /usr/src/sys/ddb/db_main.c:231 #5 0xffffffff804c15de in kdb_trap (type=12, code=0, tf=) at /usr/src/sys/kern/subr_kdb.c:654 #6 0xffffffff806ee845 in trap_fatal (frame=0xffffff811fe4f3e0, eva=) at /usr/src/sys/amd64/amd64/trap.c:867 #7 0xffffffff806eeae6 in trap_pfault (frame=0x0, usermode=0) at /usr/src/sys/amd64/amd64/trap.c:698 #8 0xffffffff806ee1fc in trap (frame=0xffffff811fe4f3e0) at /usr/src/sys/amd64/amd64/trap.c:463 #9 0xffffffff806d8dc3 in calltrap () at /tmp/exception-EAhiLL.s:142 #10 0xffffffff802b5820 in AcpiOsAcquireObject (Cache=0xfffffe000292a700) at /usr/src/sys/contrib/dev/acpica/components/utilities/utcache.c:310 #11 0xffffffff802b8441 in AcpiUtCreateInternalObjectDbg ( ModuleName=0xffffffff8074a2f6 "dsutils", LineNumber=703, ComponentId=64, Type=1) at /usr/src/sys/contrib/dev/acpica/components/utilities/utobject.c:437 #12 0xffffffff8029bf65 in AcpiDsCreateOperand (WalkState=0xfffffe000618b800, Arg=0xfffffe00041b3bc0, ArgIndex=) at /usr/src/sys/contrib/dev/acpica/components/dispatcher/dsutils.c:703 #13 0xffffffff8029c062 in AcpiDsCreateOperands (WalkState=0xfffffe000618b800, FirstArg=) at /usr/src/sys/contrib/dev/acpica/components/dispatcher/dsutils.c:798 #14 0xffffffff8029c507 in AcpiDsExecEndOp (WalkState=0xfffffe000618b800) at /usr/src/sys/contrib/dev/acpica/components/dispatcher/dswexec.c:449 #15 0xffffffff802afe04 in AcpiPsParseLoop (WalkState=0xfffffe000618b800) at /usr/src/sys/contrib/dev/acpica/components/parser/psloop.c:1276 #16 0xffffffff802b068d in AcpiPsParseAml (WalkState=) at /usr/src/sys/contrib/dev/acpica/components/parser/psparse.c:525 #17 0xffffffff802b11e7 in AcpiPsExecuteMethod (Info=0xfffffe0006191c80) at /usr/src/sys/contrib/dev/acpica/components/parser/psxface.c:368 #18 0xffffffff802aac16 in AcpiNsEvaluate (Info=0xfffffe0006191c80) at /usr/src/sys/contrib/dev/acpica/components/namespace/nseval.c:193 #19 0xffffffff802add48 in AcpiEvaluateObject (Handle=0xfffffe0002a09280, Pathname=, ExternalParams=, ReturnBuffer=0xffffff811fe4f7c0) at /usr/src/sys/contrib/dev/acpica/components/namespace/nsxfeval.c:289 #20 0xffffffff802ce378 in acpi_cmbat_get_bst (arg=0xfffffe0002a3d200) at /usr/src/sys/dev/acpica/acpi_cmbat.c:258 #21 0xffffffff802ce202 in acpi_cmbat_bst (dev=0xfffffe0002a3d200, bstp=0xfffffe0006125300) at /usr/src/sys/dev/acpica/acpi_cmbat.c:419 #22 0xffffffff802cd2ef in acpi_battery_get_battinfo (dev=0x0, battinfo=0xffffffff80a5d380) at acpi_if.h:142 #23 0xffffffff802cd91f in acpi_battery_sysctl (oidp=0xfffffe000418c500, arg1=, arg2=64, req=0xffffff811fe4f968) at /usr/src/sys/dev/acpica/acpi_battery.c:428 #24 0xffffffff80496c8c in sysctl_root (arg1=, arg2=) at /usr/src/sys/kern/kern_sysctl.c:1513 #25 0xffffffff80497248 in userland_sysctl (td=, name=0xffffff811fe4fa30, namelen=, old=, oldlenp=, inkernel=, new=, newlen=, retval=, flags=535099728) at /usr/src/sys/kern/kern_sysctl.c:1623 #26 0xffffffff80497034 in sys___sysctl (td=0xfffffe00041a5900, uap=0xffffff811fe4fb40) at /usr/src/sys/kern/kern_sysctl.c:1549 #27 0xffffffff806eef0e in amd64_syscall (td=0xfffffe00041a5900, traced=0) at subr_syscall.c:135 #28 0xffffffff806d90ab in Xfast_syscall () at /tmp/exception-EAhiLL.s:292 #29 0x000000080093456a in ?? () Previous frame inner to this frame (corrupt stack?) Current language: auto; currently minimal (kgdb)