From owner-freebsd-current@FreeBSD.ORG Thu Jun 23 13:52:55 2011 Return-Path: Delivered-To: current@freebsd.org Received: from mx1.freebsd.org (unknown [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 0F0F31065748 for ; Thu, 23 Jun 2011 13:52:55 +0000 (UTC) (envelope-from david@catwhisker.org) Received: from albert.catwhisker.org (m209-73.dsl.rawbw.com [198.144.209.73]) by mx1.freebsd.org (Postfix) with ESMTP id C06FD8FC16 for ; Thu, 23 Jun 2011 13:52:54 +0000 (UTC) Received: from albert.catwhisker.org (localhost [127.0.0.1]) by albert.catwhisker.org (8.14.4/8.14.4) with ESMTP id p5NDbdoE045009 for ; Thu, 23 Jun 2011 06:37:39 -0700 (PDT) (envelope-from david@albert.catwhisker.org) Received: (from david@localhost) by albert.catwhisker.org (8.14.4/8.14.4/Submit) id p5NDbdQS045008 for current@freebsd.org; Thu, 23 Jun 2011 06:37:39 -0700 (PDT) (envelope-from david) Date: Thu, 23 Jun 2011 06:37:39 -0700 From: David Wolfskill To: current@freebsd.org Message-ID: <20110623133739.GO29050@albert.catwhisker.org> Mail-Followup-To: David Wolfskill , current@freebsd.org Mime-Version: 1.0 Content-Type: multipart/signed; micalg=pgp-sha1; protocol="application/pgp-signature"; boundary="K4LMwn8CgX2KMboP" Content-Disposition: inline User-Agent: Mutt/1.4.2.3i Cc: Subject: @r223471: panic: run_interrupt_driven_config_hooks: waited too long X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 23 Jun 2011 13:52:55 -0000 --K4LMwn8CgX2KMboP Content-Type: multipart/mixed; boundary="yaap9KN+GmBP785v" Content-Disposition: inline --yaap9KN+GmBP785v Content-Type: text/plain; charset=us-ascii Content-Disposition: inline Content-Transfer-Encoding: quoted-printable I last built head at r223421; I upgraded sources to r223471. "make buildworld" was uneventful; building the kernel demonstrated that I needed the patch from r223474, which I applied (after which building the kernel was also uneventful). Here's a cut/paste from serial console of my build machine (laptop also failed similarly, but serial console is a bot more awkward, and the symptoms look the same anyhow): GDB: no debug ports present KDB: debugger backends: ddb KDB: current backend: ddb Copyright (c) 1992-2011 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 9.0-CURRENT #538 r223471M: Thu Jun 23 05:47:53 PDT 2011 root@freebeast.catwhisker.org:/usr/obj/usr/src/sys/GENERIC i386 WARNING: WITNESS option enabled, expect reduced performance. CPU: Intel(R) Xeon(TM) CPU 3.60GHz (3600.21-MHz 686-class CPU) Origin =3D "GenuineIntel" Id =3D 0xf41 Family =3D f Model =3D 4 Stepp= ing =3D 1 Features=3D0xbfebfbff Features2=3D0x659d AMD Features=3D0x20100000 TSC: P-state invariant real memory =3D 2147483648 (2048 MB) avail memory =3D 2081562624 (1985 MB) Event timer "LAPIC" quality 400 ACPI APIC Table: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs FreeBSD/SMP: 2 package(s) x 1 core(s) cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 6 ioapic0 irqs 0-23 on motherboard ioapic1 irqs 24-47 on motherboard ioapic2 irqs 48-71 on motherboard kbd1 at kbdmux0 acpi0: on motherboard acpi0: Power Button (fixed) Timecounter "ACPI-fast" frequency 3579545 Hz quality 900 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 cpu1: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pci0: at device 0.1 (no driver attached) pci0: at device 1.0 (no driver attached) pcib1: irq 16 at device 2.0 on pci0 pci1: on pcib1 pcib2: at device 0.0 on pci1 pci2: on pcib2 aac0: mem 0xdc000000-0xdfffffff irq 24 at device = 1.0 on pci2 aac0: Enable Raw I/O aac0: New comm. interface enabled aac0: Adaptec 2200S, aac driver 2.1.9-1 aacp0: on aac0 aacp1: on aac0 pcib3: at device 0.2 on pci1 pci3: on pcib3 em0: port 0x2000-0x203f= mem 0xd8200000-0xd821ffff irq 54 at device 2.0 on pci3 em0: Ethernet address: 00:30:48:2d:32:6a em1: port 0x2040-0x207f= mem 0xd8220000-0xd823ffff irq 55 at device 2.1 on pci3 em1: Ethernet address: 00:30:48:2d:32:6b pcib4: irq 16 at device 4.0 on pci0 pci4: on pcib4 pcib5: irq 16 at device 6.0 on pci0 pci5: on pcib5 uhci0: port 0x1400-0x141f irq 1= 6 at device 29.0 on pci0 usbus0: on uhci0 uhci1: port 0x1420-0x143f irq 1= 9 at device 29.1 on pci0 usbus1: on uhci1 uhci2: port 0x1440-0x145f irq 1= 8 at device 29.2 on pci0 usbus2: on uhci2 uhci3: port 0x1460-0x147f irq 1= 6 at device 29.3 on pci0 usbus3: on uhci3 ehci0: mem 0xd8001000-0xd80013f= f irq 23 at device 29.7 on pci0 usbus4: EHCI version 1.0 usbus4: on ehci0 pcib6: at device 30.0 on pci0 pci6: on pcib6 vgapci0: port 0x3000-0x30ff mem 0xd9000000-0xd9fff= fff,0xd8300000-0xd8300fff irq 17 at device 1.0 on pci6 isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177= ,0x376,0x14a0-0x14af at device 31.1 on pci0 ata0: on atapci0 ata1: on atapci0 pci0: at device 31.3 (no driver attached) acpi_button0: on acpi0 atrtc0: port 0x70-0x77 irq 8 on acpi0 Event timer "RTC" frequency 32768 Hz quality 0 attimer0: port 0x40-0x43 irq 0 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 atkbdc0: port 0x60,0x64 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 Generic PS/2 mouse, device ID 0 uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 uart0: console (9600,n,8,1) uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0 fdc0: port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0 fd0: <1440-KB 3.5" drive> on fdc0 drive 0 pmtimer0 on isa0 orm0: at iomem 0xc0000-0xc7fff,0xc8000-0xc8fff,0xc9000-0x= c9fff,0xca000-0xcafff,0xcb000-0xcf7ff pnpid ORM0000 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=3D0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ppc0: parallel port not found. acpi_perf0: on cpu0 acpi_perf1: on cpu1 p4tcc0: on cpu0 p4tcc1: on cpu1 Timecounters tick every 1.000 msec aacd0: on aac0 aacd0: 34970MB (71619584 sectors) aacd1: on aac0 aacd1: 69974MB (143307008 sectors) usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 ugen0.1: at usbus0 uhub0: on usbus0 ugen1.1: at usbus1 uhub1: on usbus1 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 12Mbps Full Speed USB v1.0 ugen2.1: at usbus2 uhub2: on usbus2 ugen3.1: at usbus3 uhub3: on usbus3 usbus4: 480Mbps High Speed USB v2.0 ugen4.1: at usbus4 uhub4: on usbus4 uhub0: 2 ports with 2 removable, self powered uhub1: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered ata1: DMA limited to UDMA33, controller found non-ATA66 cable uhub3: 2 ports with 2 removable, self powered uhub4: 8 ports with 8 removable, self powered run_interrupt_driven_hooks: still waiting after 60 seconds for xpt_config run_interrupt_driven_hooks: still waiting after 120 seconds for xpt_config run_interrupt_driven_hooks: still waiting after 180 seconds for xpt_config run_interrupt_driven_hooks: still waiting after 240 seconds for xpt_config run_interrupt_driven_hooks: still waiting after 300 seconds for xpt_config panic: run_interrupt_driven_config_hooks: waited too long cpuid =3D 0 KDB: enter: panic [ thread pid 0 tid 100000 ] Stopped at kdb_enter+0x3a: movl $0,kdb_why db> bt Tracing pid 0 tid 100000 td 0xc1087100 kdb_enter(c0ef2d95,c0ef2d95,c0ef5b22,c1820cf8,0,...) at kdb_enter+0x3a panic(c0ef5b22,0,c0ef5a73,8c,ea60,...) at panic+0x134 boot_run_interrupt_driven_config_hooks(0,181ec00,181ec00,181e000,1825000,..= .) at boot_run_interrupt_driven_config_hooks+0x167 mi_startup() at mi_startup+0xac begin() at begin+0x2c db>=20 I've attached the dmesg.boot from yesterday (r223421). Anything else I can do to help isolate & fix this? It appears that getting a crash dump isn't likely to happen for this one. Peace, david --=20 David H. Wolfskill david@catwhisker.org Depriving a girl or boy of an opportunity for education is evil. See http://www.catwhisker.org/~david/publickey.gpg for my public key. --yaap9KN+GmBP785v Content-Type: text/plain; charset=us-ascii Content-Disposition: attachment; filename="dmesg.boot.9.0-CURRENT" Content-Transfer-Encoding: quoted-printable Copyright (c) 1992-2011 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 9.0-CURRENT #537 r223421: Wed Jun 22 05:25:55 PDT 2011 root@freebeast.catwhisker.org:/usr/obj/usr/src/sys/GENERIC i386 WARNING: WITNESS option enabled, expect reduced performance. CPU: Intel(R) Xeon(TM) CPU 3.60GHz (3600.21-MHz 686-class CPU) Origin =3D "GenuineIntel" Id =3D 0xf41 Family =3D f Model =3D 4 Stepp= ing =3D 1 Features=3D0xbfebfbff Features2=3D0x659d AMD Features=3D0x20100000 TSC: P-state invariant real memory =3D 2147483648 (2048 MB) avail memory =3D 2081562624 (1985 MB) Event timer "LAPIC" quality 400 ACPI APIC Table: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs FreeBSD/SMP: 2 package(s) x 1 core(s) cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 6 ioapic0 irqs 0-23 on motherboard ioapic1 irqs 24-47 on motherboard ioapic2 irqs 48-71 on motherboard kbd1 at kbdmux0 acpi0: on motherboard acpi0: Power Button (fixed) Timecounter "ACPI-fast" frequency 3579545 Hz quality 900 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 cpu1: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pci0: at device 0.1 (no driver attached) pci0: at device 1.0 (no driver attached) pcib1: irq 16 at device 2.0 on pci0 pci1: on pcib1 pcib2: at device 0.0 on pci1 pci2: on pcib2 aac0: mem 0xdc000000-0xdfffffff irq 24 at device = 1.0 on pci2 aac0: Enable Raw I/O aac0: New comm. interface enabled aac0: Adaptec 2200S, aac driver 2.1.9-1 aacp0: on aac0 aacp1: on aac0 pcib3: at device 0.2 on pci1 pci3: on pcib3 em0: port 0x2000-0x203f= mem 0xd8200000-0xd821ffff irq 54 at device 2.0 on pci3 em0: Ethernet address: 00:30:48:2d:32:6a em1: port 0x2040-0x207f= mem 0xd8220000-0xd823ffff irq 55 at device 2.1 on pci3 em1: Ethernet address: 00:30:48:2d:32:6b pcib4: irq 16 at device 4.0 on pci0 pci4: on pcib4 pcib5: irq 16 at device 6.0 on pci0 pci5: on pcib5 uhci0: port 0x1400-0x141f irq 1= 6 at device 29.0 on pci0 usbus0: on uhci0 uhci1: port 0x1420-0x143f irq 1= 9 at device 29.1 on pci0 usbus1: on uhci1 uhci2: port 0x1440-0x145f irq 1= 8 at device 29.2 on pci0 usbus2: on uhci2 uhci3: port 0x1460-0x147f irq 1= 6 at device 29.3 on pci0 usbus3: on uhci3 ehci0: mem 0xd8001000-0xd80013f= f irq 23 at device 29.7 on pci0 usbus4: EHCI version 1.0 usbus4: on ehci0 pcib6: at device 30.0 on pci0 pci6: on pcib6 vgapci0: port 0x3000-0x30ff mem 0xd9000000-0xd9fff= fff,0xd8300000-0xd8300fff irq 17 at device 1.0 on pci6 isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177= ,0x376,0x14a0-0x14af at device 31.1 on pci0 ata0: on atapci0 ata1: on atapci0 pci0: at device 31.3 (no driver attached) acpi_button0: on acpi0 atrtc0: port 0x70-0x77 irq 8 on acpi0 Event timer "RTC" frequency 32768 Hz quality 0 attimer0: port 0x40-0x43 irq 0 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 atkbdc0: port 0x60,0x64 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 Generic PS/2 mouse, device ID 0 uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 uart0: console (9600,n,8,1) uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0 fdc0: port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on acpi0 fd0: <1440-KB 3.5" drive> on fdc0 drive 0 pmtimer0 on isa0 orm0: at iomem 0xc0000-0xc7fff,0xc8000-0xc8fff,0xc9000-0x= c9fff,0xca000-0xcafff,0xcb000-0xcf7ff pnpid ORM0000 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=3D0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ppc0: parallel port not found. acpi_perf0: on cpu0 acpi_perf1: on cpu1 p4tcc0: on cpu0 p4tcc1: on cpu1 Timecounters tick every 1.000 msec aacd0: on aac0 aacd0: 34970MB (71619584 sectors) aacd1: on aac0 aacd1: 69974MB (143307008 sectors) usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 ugen0.1: at usbus0 uhub0: on usbus0 ugen1.1: at usbus1 uhub1: on usbus1 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 12Mbps Full Speed USB v1.0 ugen2.1: at usbus2 uhub2: on usbus2 ugen3.1: at usbus3 uhub3: on usbus3 usbus4: 480Mbps High Speed USB v2.0 ugen4.1: at usbus4 uhub4: on usbus4 uhub0: 2 ports with 2 removable, self powered uhub1: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered ata1: DMA limited to UDMA33, controller found non-ATA66 cable uhub3: 2 ports with 2 removable, self powered uhub4: 8 ports with 8 removable, self powered ses0 at aacp0 bus 0 scbus0 target 6 lun 0 ses0: Fixed Uninstalled SCSI-2 device=20 ses0: 3.300MB/s transfers ses0: SAF-TE Compliant Device pass0 at aacp0 bus 0 scbus0 target 0 lun 0 cd0 at ata1 bus 0 scbus3 target 1 lun 0 cd0: Removable CD-ROM SCSI-0 device=20 cd0: 33.300MB/s transfers (UDMA2, ATAPI 12bytes, PIO 65534bytes) cd0: Attempt to query device size failed: NOT READY, Medium not present pass0: Fixed Uninstalled SCSI-3 device=20 pass0: 3.300MB/s transfers pass1 at aacp0 bus 0 scbus0 target 1 lun 0 pass1: Fixed Uninstalled SCSI-3 device=20 pass1: 3.300MB/s transfers pass2 at aacp0 bus 0 scbus0 target 2 lun 0 pass2: Fixed Uninstalled SCSI-3 device=20 pass2: 3.300MB/s transfers pass3 at aacp0 bus 0 scbus0 target 3 lun 0 pass3: Fixed Uninstalled SCSI-3 device=20 pass3: 3.300MB/s transfers xpt_action_default: CCB type 0xe not supported SMP: AP CPU #1 Launched! Timecounter "TSC-low" frequency 14063305 Hz quality 1000 WARNING: WITNESS option enabled, expect reduced performance. Trying to mount root from ufs:/dev/aacd0s4a [rw]... WARNING: TMPFS is considered to be a highly experimental feature in FreeBSD. em0: link state changed to UP --yaap9KN+GmBP785v-- --K4LMwn8CgX2KMboP Content-Type: application/pgp-signature Content-Disposition: inline -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.17 (FreeBSD) iEYEARECAAYFAk4DQaIACgkQmprOCmdXAD36IwCfcjoqXFtHmxJdH8yIkPvZifCu HiwAn3C5dmiwbQMUYwdE0estFpZsACBt =GCUV -----END PGP SIGNATURE----- --K4LMwn8CgX2KMboP--