From owner-freebsd-bugs@FreeBSD.ORG Fri Nov 5 07:30:18 2010 Return-Path: Delivered-To: freebsd-bugs@hub.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 1E0091065670 for ; Fri, 5 Nov 2010 07:30:18 +0000 (UTC) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (freefall.freebsd.org [IPv6:2001:4f8:fff6::28]) by mx1.freebsd.org (Postfix) with ESMTP id E3D3D8FC14 for ; Fri, 5 Nov 2010 07:30:17 +0000 (UTC) Received: from freefall.freebsd.org (localhost [127.0.0.1]) by freefall.freebsd.org (8.14.4/8.14.4) with ESMTP id oA57UH8E096540 for ; Fri, 5 Nov 2010 07:30:17 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.14.4/8.14.4/Submit) id oA57UH7L096533; Fri, 5 Nov 2010 07:30:17 GMT (envelope-from gnats) Date: Fri, 5 Nov 2010 07:30:17 GMT Message-Id: <201011050730.oA57UH7L096533@freefall.freebsd.org> To: freebsd-bugs@FreeBSD.org From: Fulvio Ciriaco Cc: Subject: Re: kern/151924: very slow boot from disk: 15m+ X-BeenThere: freebsd-bugs@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list Reply-To: Fulvio Ciriaco List-Id: Bug reports List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 05 Nov 2010 07:30:18 -0000 The following reply was made to PR kern/151924; it has been noted by GNATS. From: Fulvio Ciriaco To: Remko Lodder Cc: fulvio ciriaco , freebsd-gnats-submit@FreeBSD.org Subject: Re: kern/151924: very slow boot from disk: 15m+ Date: Fri, 05 Nov 2010 08:26:34 +0100 --Multipart_Fri_Nov__5_08:26:33_2010-1 Content-Type: text/plain; charset=US-ASCII Hallo, attached find a dmesg from verbose boot. Fulvio --Multipart_Fri_Nov__5_08:26:33_2010-1 Content-Type: text/plain; charset=US-ASCII Content-Disposition: inline; filename="dmesg.verbose.txt" Content-Transfer-Encoding: quoted-printable Copyright (c) 1992-2010 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 8.1-RELEASE #0: Mon Jul 19 02:55:53 UTC 2010 root@almeida.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC i386 Preloaded elf kernel "/boot/kernel/kernel" at 0xc0fc7000. Preloaded elf module "/boot/kernel/if_iwi.ko" at 0xc0fc71c4. Timecounter "i8254" frequency 1193182 Hz quality 0 Calibrating TSC clock ... TSC clock: 1862135068 Hz CPU: Intel(R) Pentium(R) M processor 1.86GHz (1862.14-MHz 686-class CPU) Origin =3D "GenuineIntel" Id =3D 0x6d8 Family =3D 6 Model =3D d Stepp= ing =3D 8 Features=3D0xafe9fbff Features2=3D0x180 AMD Features=3D0x100000 Instruction TLB: 4 KB Pages, 4-way set associative, 128 entries Data TLB: 4 KB Pages, 4-way set associative, 128 entries Instruction TLB: 4 MB pages, fully associative, 2 entries 2nd-level cache: 2-MB, 8-way set associative, 64-byte line size 1st-level instruction cache: 32 KB, 8-way set associative, 64 byte line size Data TLB: 4 MB Pages, 4-way set associative, 8 entries 1st-level data cache: 32 KB, 8-way set associative, 64 byte line size L2 cache: 2048 kbytes, 8-way associative, 64 bytes/line real memory =3D 2147483648 (2048 MB) Physical memory chunk(s): 0x0000000000001000 - 0x000000000009dfff, 643072 bytes (157 pages) 0x0000000000100000 - 0x00000000003fffff, 3145728 bytes (768 pages) 0x0000000001026000 - 0x000000007db83fff, 2092294144 bytes (510814 pages) avail memory =3D 2090962944 (1994 MB) Table 'FACP' at 0x7ffd9400 Table 'APIC' at 0x7ffd9c00 APIC: Found table at 0x7ffd9c00 APIC: Using the MADT enumerator. MADT: Found CPU APIC ID 0 ACPI ID 0: enabled SMP: Added CPU 0 (AP) MADT: Found CPU APIC ID 1 ACPI ID 1: disabled ACPI APIC Table: x86bios: IVT 0x000000-0x0004ff at 0xc0000000 x86bios: SSEG 0x010000-0x01ffff at 0xc51c3000 x86bios: EBDA 0x09f000-0x09ffff at 0xc009f000 x86bios: ROM 0x0a0000-0x0effff at 0xc00a0000 APIC: CPU 0 has ACPI ID 0 bios32: Found BIOS32 Service Directory header at 0xc00ffe80 bios32: Entry =3D 0xffe90 (c00ffe90) Rev =3D 0 Len =3D 1 pcibios: PCI BIOS entry at 0xf0000+0xb5be pnpbios: Found PnP BIOS data at 0xc00fe2d0 pnpbios: Entry =3D f0000:e2f4 Rev =3D 1.0 pnpbios: Event flag at 4b4 Other BIOS signatures found: ULE: setup cpu 0 ACPI: RSDP 0xfc9b0 00014 (v0 DELL ) ACPI: RSDT 0x7ffd8790 00040 (v1 DELL CPi R 27D5091E ASL 00000061) ACPI: FACP 0x7ffd9400 00074 (v1 DELL CPi R 27D5091E ASL 00000061) ACPI: DSDT 0x7ffda000 0355D (v1 INT430 SYSFexxx 00001001 MSFT 0100000E) ACPI: FACS 0x7ffe8800 00040 ACPI: APIC 0x7ffd9c00 00068 (v1 DELL CPi R 27D5091E ASL 00000047) ACPI: ASF! 0x7ffd9800 0005B (v16 DELL CPi R 27D5091E ASL 00000061) ACPI: MCFG 0x7ffd9bc0 0003E (v16 DELL CPi R 27D5091E ASL 00000061) ACPI: SSDT 0x7ffd8be6 00280 (v1 PmRef Cpu0Ist 00003000 INTL 20030522) ACPI: SSDT 0x7ffd8a0e 001D8 (v1 PmRef Cpu0Cst 00003001 INTL 20030522) ACPI: SSDT 0x7ffd8813 001FB (v1 PmRef CpuPm 00003000 INTL 20030522) MADT: Found IO APIC ID 1, Interrupt 0 at 0xfec00000 ioapic0: Changing APIC ID to 1 ioapic0: Routing external 8259A's -> intpin 0 MADT: Interrupt override: source 0, irq 2 ioapic0: Routing IRQ 0 -> intpin 2 MADT: Interrupt override: source 9, irq 9 ioapic0: intpin 9 trigger: level lapic0: Routing NMI -> LINT1 lapic0: LINT1 trigger: edge lapic0: LINT1 polarity: high MADT: Ignoring local NMI routed to ACPI CPU 1 ioapic0 irqs 0-23 on motherboard cpu0 BSP: ID: 0x00000000 VER: 0x00050014 LDR: 0x00000000 DFR: 0xffffffff lint0: 0x00010700 lint1: 0x00000400 TPR: 0x00000000 SVR: 0x000001ff timer: 0x000100ef therm: 0x00010000 err: 0x000000f0 pmc: 0x00010400 wlan: <802.11 Link Layer> null: random: nfslock: pseudo-device io: kbd: new array size 4 kbd1 at kbdmux0 mem: Pentium Pro MTRR support enabled hptrr: RocketRAID 17xx/2xxx SATA controller driver v1.2 npx0: INT 16 interface acpi0: on motherboard PCIe: Memory Mapped configuration base @ 0xe0000000 pcibios: BIOS version 2.10 ioapic0: routing intpin 9 (ISA IRQ 9) to lapic 0 vector 48 acpi0: [MPSAFE] acpi0: [ITHREAD] ACPI: SSDT 0x7ffd87d0 00043 (v1 LMPWR DELLLOM 00001001 INTL 20030522) acpi0: wakeup code va 0xc51c0000 pa 0x1000 acpi_bus_number: root bus has no _BBN, assuming 0 AcpiOsDerivePciId: \\_SB_.PCI0.ISAB.PIR1 -> bus 0 dev 31 func 0 acpi_bus_number: root bus has no _BBN, assuming 0 AcpiOsDerivePciId: \\_SB_.PCI0.ISAB.PIR2 -> bus 0 dev 31 func 0 acpi0: reservation of 0, 9fc00 (3) failed acpi0: reservation of 100000, 7fed8000 (3) failed ACPI timer: 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 -> 10 Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 pci_link0: Index IRQ Rtd Ref IRQs Initial Probe 0 11 N 0 9 10 11 Validation 0 11 N 0 9 10 11 After Disable 0 255 N 0 9 10 11 pci_link1: Index IRQ Rtd Ref IRQs Initial Probe 0 10 N 0 5 7 Validation 0 255 N 0 5 7 After Disable 0 255 N 0 5 7 pci_link2: Index IRQ Rtd Ref IRQs Initial Probe 0 9 N 0 9 10 11 Validation 0 9 N 0 9 10 11 After Disable 0 255 N 0 9 10 11 pci_link3: Index IRQ Rtd Ref IRQs Initial Probe 0 5 N 0 5 7 9 10 11 Validation 0 5 N 0 5 7 9 10 11 After Disable 0 255 N 0 5 7 9 10 11 pci_link4: Index IRQ Rtd Ref IRQs Initial Probe 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 After Disable 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 pci_link5: Index IRQ Rtd Ref IRQs Initial Probe 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 After Disable 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 pci_link6: Index IRQ Rtd Ref IRQs Initial Probe 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 After Disable 0 255 N 0 3 4 5 6 7 9 10 11 12 14 15 acpi_acad0: on acpi0 battery0: on acpi0 battery1: on acpi0 acpi_lid0: on acpi0 acpi_button0: on acpi0 acpi_button1: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pci0: domain=3D0, physical bus=3D0 found-> vendor=3D0x8086, dev=3D0x2590, revid=3D0x03 domain=3D0, bus=3D0, slot=3D0, func=3D0 class=3D06-00-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0006, statreg=3D0x2090, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) found-> vendor=3D0x8086, dev=3D0x2591, revid=3D0x03 domain=3D0, bus=3D0, slot=3D1, func=3D0 class=3D06-04-00, hdrtype=3D0x01, mfdev=3D0 cmdreg=3D0x0107, statreg=3D0x0010, cachelnsz=3D16 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x0a (2500 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D255 powerspec 2 supports D0 D3 current D0 MSI supports 1 message found-> vendor=3D0x8086, dev=3D0x2660, revid=3D0x03 domain=3D0, bus=3D0, slot=3D28, func=3D0 class=3D06-04-00, hdrtype=3D0x01, mfdev=3D1 cmdreg=3D0x0007, statreg=3D0x0010, cachelnsz=3D16 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x02 (500 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D255 powerspec 2 supports D0 D3 current D0 MSI supports 1 message found-> vendor=3D0x8086, dev=3D0x2658, revid=3D0x03 domain=3D0, bus=3D0, slot=3D29, func=3D0 class=3D0c-03-00, hdrtype=3D0x00, mfdev=3D1 cmdreg=3D0x0005, statreg=3D0x0280, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D11 map[20]: type I/O Port, range 32, base 0xbf80, size 5, enabled pcib0: matched entry for 0.29.INTA pcib0: slot 29 INTA hardwired to IRQ 16 unknown: Reserved 0x20 bytes for rid 0x20 type 4 at 0xbf80 found-> vendor=3D0x8086, dev=3D0x2659, revid=3D0x03 domain=3D0, bus=3D0, slot=3D29, func=3D1 class=3D0c-03-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0005, statreg=3D0x0280, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Db, irq=3D10 map[20]: type I/O Port, range 32, base 0xbf60, size 5, enabled pcib0: matched entry for 0.29.INTB pcib0: slot 29 INTB hardwired to IRQ 17 unknown: Reserved 0x20 bytes for rid 0x20 type 4 at 0xbf60 found-> vendor=3D0x8086, dev=3D0x265a, revid=3D0x03 domain=3D0, bus=3D0, slot=3D29, func=3D2 class=3D0c-03-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0005, statreg=3D0x0280, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Dc, irq=3D9 map[20]: type I/O Port, range 32, base 0xbf40, size 5, enabled pcib0: matched entry for 0.29.INTC pcib0: slot 29 INTC hardwired to IRQ 18 unknown: Reserved 0x20 bytes for rid 0x20 type 4 at 0xbf40 found-> vendor=3D0x8086, dev=3D0x265b, revid=3D0x03 domain=3D0, bus=3D0, slot=3D29, func=3D3 class=3D0c-03-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0005, statreg=3D0x0280, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Dd, irq=3D5 map[20]: type I/O Port, range 32, base 0xbf20, size 5, enabled pcib0: matched entry for 0.29.INTD pcib0: slot 29 INTD hardwired to IRQ 19 unknown: Reserved 0x20 bytes for rid 0x20 type 4 at 0xbf20 found-> vendor=3D0x8086, dev=3D0x265c, revid=3D0x03 domain=3D0, bus=3D0, slot=3D29, func=3D7 class=3D0c-03-20, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0106, statreg=3D0x0290, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D11 powerspec 2 supports D0 D3 current D0 map[10]: type Memory, range 32, base 0xffa80800, size 10, enabled pcib0: matched entry for 0.29.INTA pcib0: slot 29 INTA hardwired to IRQ 16 unknown: Reserved 0x400 bytes for rid 0x10 type 3 at 0xffa80800 found-> vendor=3D0x8086, dev=3D0x2448, revid=3D0xd3 domain=3D0, bus=3D0, slot=3D30, func=3D0 class=3D06-04-01, hdrtype=3D0x01, mfdev=3D1 cmdreg=3D0x0107, statreg=3D0x0010, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x02 (500 ns), maxlat=3D0x00 (0 ns) found-> vendor=3D0x8086, dev=3D0x266e, revid=3D0x03 domain=3D0, bus=3D0, slot=3D30, func=3D2 class=3D04-01-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0007, statreg=3D0x0290, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D11 powerspec 2 supports D0 D3 current D0 map[10]: type I/O Port, range 32, base 0xed00, size 8, enabled map[14]: type I/O Port, range 32, base 0xec40, size 6, enabled map[18]: type Memory, range 32, base 0xdffffe00, size 9, enabled map[1c]: type Memory, range 32, base 0xdffffd00, size 8, enabled pcib0: matched entry for 0.30.INTA pcib0: slot 30 INTA hardwired to IRQ 16 found-> vendor=3D0x8086, dev=3D0x266d, revid=3D0x03 domain=3D0, bus=3D0, slot=3D30, func=3D3 class=3D07-03-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0005, statreg=3D0x0290, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Db, irq=3D10 powerspec 2 supports D0 D3 current D0 map[10]: type I/O Port, range 32, base 0xee00, size 8, enabled map[14]: type I/O Port, range 32, base 0xec80, size 7, enabled pcib0: matched entry for 0.30.INTB pcib0: slot 30 INTB hardwired to IRQ 17 found-> vendor=3D0x8086, dev=3D0x2641, revid=3D0x03 domain=3D0, bus=3D0, slot=3D31, func=3D0 class=3D06-01-00, hdrtype=3D0x00, mfdev=3D1 cmdreg=3D0x0107, statreg=3D0x0200, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) found-> vendor=3D0x8086, dev=3D0x2653, revid=3D0x03 domain=3D0, bus=3D0, slot=3D31, func=3D2 class=3D01-01-80, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0005, statreg=3D0x02b8, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Db, irq=3D10 powerspec 2 supports D0 D3 current D0 map[20]: type I/O Port, range 32, base 0xbfa0, size 4, enabled pcib0: matched entry for 0.31.INTB pcib0: slot 31 INTB hardwired to IRQ 17 pcib1: at device 1.0 on pci0 pcib1: domain 0 pcib1: secondary bus 1 pcib1: subordinate bus 1 pcib1: I/O decode 0xd000-0xdfff pcib1: memory decode 0xdfd00000-0xdfefffff pcib1: prefetched decode 0xd0000000-0xd7ffffff pci1: on pcib1 pci1: domain=3D0, physical bus=3D1 found-> vendor=3D0x1002, dev=3D0x3150, revid=3D0x00 domain=3D0, bus=3D1, slot=3D0, func=3D0 class=3D03-00-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0007, statreg=3D0x0010, cachelnsz=3D16 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D11 powerspec 2 supports D0 D1 D2 D3 current D0 MSI supports 1 message, 64 bit map[10]: type Prefetchable Memory, range 32, base 0xd0000000, size 27, ena= bled pcib1: requested memory range 0xd0000000-0xd7ffffff: good map[14]: type I/O Port, range 32, base 0xde00, size 8, enabled pcib1: requested I/O range 0xde00-0xdeff: in range map[18]: type Memory, range 32, base 0xdfdf0000, size 16, enabled pcib1: requested memory range 0xdfdf0000-0xdfdfffff: good pcib1: matched entry for 1.0.INTA pcib1: slot 0 INTA hardwired to IRQ 16 vgapci0: port 0xde00-0xdeff mem 0xd0000000-0xd7fff= fff,0xdfdf0000-0xdfdfffff irq 16 at device 0.0 on pci1 pcib2: at device 28.0 on pci0 pcib2: domain 0 pcib2: secondary bus 2 pcib2: subordinate bus 2 pcib2: I/O decode 0xf000-0xfff pcib2: memory decode 0xdfc00000-0xdfcfffff pcib2: no prefetched decode pcib2: could not get PCI interrupt routing table for \\_SB_.PCI0.PXP0 - AE_= NOT_FOUND pci2: on pcib2 pci2: domain=3D0, physical bus=3D2 found-> vendor=3D0x14e4, dev=3D0x1677, revid=3D0x01 domain=3D0, bus=3D2, slot=3D0, func=3D0 class=3D02-00-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0106, statreg=3D0x0010, cachelnsz=3D16 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D11 powerspec 2 supports D0 D3 current D0 MSI supports 8 messages, 64 bit map[10]: type Memory, range 64, base 0xdfcf0000, size 16, enabled pcib2: requested memory range 0xdfcf0000-0xdfcfffff: good pcib0: matched entry for 0.28.INTA pcib0: slot 28 INTA hardwired to IRQ 16 pcib2: slot 0 INTA is routed to irq 16 pci0:2:0:0: bad VPD cksum, remain 14 bge0: = mem 0xdfcf0000-0xdfcfffff irq 16 at device 0.0 on pci2 bge0: Reserved 0x10000 bytes for rid 0x10 type 3 at 0xdfcf0000 bge0: adjust device control 0x2000 -> 0x5000 bge0: CHIP ID 0x00004001; ASIC REV 0x04; CHIP REV 0x40; PCI-E miibus0: on bge0 brgphy0: PHY 1 on miibus0 brgphy0: OUI 0x000818, model 0x0018, rev. 0 brgphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000ba= seT-FDX, auto bge0: bpf attached bge0: Ethernet address: 00:14:22:e0:cc:40 ioapic0: routing intpin 16 (PCI IRQ 16) to lapic 0 vector 49 bge0: [MPSAFE] bge0: [ITHREAD] uhci0: port 0xbf80-0x= bf9f irq 16 at device 29.0 on pci0 uhci0: [MPSAFE] uhci0: [ITHREAD] usbus0: on uhci0 uhci1: port 0xbf60-0x= bf7f irq 17 at device 29.1 on pci0 ioapic0: routing intpin 17 (PCI IRQ 17) to lapic 0 vector 50 uhci1: [MPSAFE] uhci1: [ITHREAD] usbus1: on uhci1 uhci2: port 0xbf40-0x= bf5f irq 18 at device 29.2 on pci0 ioapic0: routing intpin 18 (PCI IRQ 18) to lapic 0 vector 51 uhci2: [MPSAFE] uhci2: [ITHREAD] usbus2: on uhci2 uhci3: port 0xbf20-0x= bf3f irq 19 at device 29.3 on pci0 ioapic0: routing intpin 19 (PCI IRQ 19) to lapic 0 vector 52 uhci3: [MPSAFE] uhci3: [ITHREAD] usbus3: on uhci3 ehci0: mem 0xffa80800-0xffa80bff = irq 16 at device 29.7 on pci0 ehci0: [MPSAFE] ehci0: [ITHREAD] usbus4: EHCI version 1.0 usbus4: on ehci0 pcib3: at device 30.0 on pci0 pcib3: domain 0 pcib3: secondary bus 3 pcib3: subordinate bus 4 pcib3: I/O decode 0xf000-0xfff pcib3: memory decode 0xdfb00000-0xdfbfffff pcib3: no prefetched decode pcib3: Subtractively decoded bridge. pci3: on pcib3 pci3: domain=3D0, physical bus=3D3 found-> vendor=3D0x104c, dev=3D0x8036, revid=3D0x00 domain=3D0, bus=3D3, slot=3D1, func=3D0 class=3D06-07-00, hdrtype=3D0x02, mfdev=3D1 cmdreg=3D0x0000, statreg=3D0x0210, cachelnsz=3D16 (dwords) lattimer=3D0x40 (1920 ns), mingnt=3D0x40 (16000 ns), maxlat=3D0x07 (1750 n= s) intpin=3Da, irq=3D255 powerspec 2 supports D0 D1 D2 D3 current D0 map[10]: type Memory, range 32, base 0, size 12, memory disabled found-> vendor=3D0x104c, dev=3D0x8038, revid=3D0x00 domain=3D0, bus=3D3, slot=3D1, func=3D5 class=3D07-80-00, hdrtype=3D0x00, mfdev=3D1 cmdreg=3D0x0102, statreg=3D0x0210, cachelnsz=3D0 (dwords) lattimer=3D0x00 (0 ns), mingnt=3D0x00 (0 ns), maxlat=3D0x00 (0 ns) intpin=3Da, irq=3D5 powerspec 2 supports D0 D1 D2 D3 current D0 map[10]: type Memory, range 32, base 0xdfbfd000, size 12, enabled pcib3: requested memory range 0xdfbfd000-0xdfbfdfff: good map[14]: type Memory, range 32, base 0xdfbfe000, size 12, enabled pcib3: requested memory range 0xdfbfe000-0xdfbfefff: good pcib3: matched entry for 3.1.INTA pcib3: slot 1 INTA hardwired to IRQ 19 found-> vendor=3D0x8086, dev=3D0x4220, revid=3D0x05 domain=3D0, bus=3D3, slot=3D3, func=3D0 class=3D02-80-00, hdrtype=3D0x00, mfdev=3D0 cmdreg=3D0x0116, statreg=3D0x0290, cachelnsz=3D16 (dwords) lattimer=3D0x40 (1920 ns), mingnt=3D0x03 (750 ns), maxlat=3D0x18 (6000 ns) intpin=3Da, irq=3D10 powerspec 2 supports D0 D3 current D0 map[10]: type Memory, range 32, base 0xdfbff000, size 12, enabled pcib3: requested memory range 0xdfbff000-0xdfbfffff: good pcib3: matched entry for 3.3.INTA pcib3: slot 3 INTA hardwired to IRQ 17 cbb0: at device 1.0 on pci3 pcib3: cbb0 requested memory range 0x0-0xffffffff: good cbb0: Lazy allocation of 0x1000 bytes rid 0x10 type 3 at 0x80000000 cbb0: Reserved 0x1000 bytes for rid 0x10 type 3 at 0x80000000 cardbus0: on cbb0 pccard0: <16-bit PCCard bus> on cbb0 pcib3: matched entry for 3.1.INTA pcib3: slot 1 INTA hardwired to IRQ 19 cbb0: [MPSAFE] cbb0: [FILTER] cbb0: PCI Configuration space: 0x00: 0x8036104c 0x02100007 0x06070000 0x00824010=20 0x10: 0x80000000 0x020000a0 0x20040403 0xfffff000=20 0x20: 0x00000000 0xfffff000 0x00000000 0xfffffffc=20 0x30: 0x00000000 0xfffffffc 0x00000000 0x07400113=20 0x40: 0x01861028 0x00000001 0x00000000 0x00000000=20 0x50: 0x00000000 0x00000000 0x00000000 0x00000000=20 0x60: 0x00000000 0x00000000 0x00000000 0x00000000=20 0x70: 0x00000000 0x00000000 0x00000000 0x00000000=20 0x80: 0x0840d061 0x047f0019 0x00030000 0x01111122=20 0x90: 0x606482c0 0x00000000 0x00000000 0x00000000=20 0xa0: 0xfe120001 0x00c00000 0x00000000 0x00000000=20 0xb0: 0x00000000 0x00000000 0x00000000 0x00000000=20 0xc0: 0x00000000 0x00000000 0x00000000 0x00000000=20 0xd0: 0x00000000 0x00000000 0x00000000 0x00000000=20 0xe0: 0x00000000 0x00000000 0x00000000 0x00000000=20 0xf0: 0x00000000 0x00000000 0x00000000 0x00000000=20 pci3: at device 1.5 (no driver attached) iwi0: mem 0xdfbff000-0xdfbfffff irq 17 at de= vice 3.0 on pci3 iwi0: Reserved 0x1000 bytes for rid 0x10 type 3 at 0xdfbff000 iwi0: [MPSAFE] iwi0: [ITHREAD] iwi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps iwi0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbp= s 36Mbps 48Mbps 54Mbps pci0: at device 30.2 (no driver attached) pci0: at device 30.3 (no driver attached) isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x17= 7,0x376,0xbfa0-0xbfaf irq 17 at device 31.2 on pci0 atapci0: Reserved 0x10 bytes for rid 0x20 type 4 at 0xbfa0 ata0: on atapci0 atapci0: Reserved 0x8 bytes for rid 0x10 type 4 at 0x1f0 atapci0: Reserved 0x1 bytes for rid 0x14 type 4 at 0x3f6 ata0: reset tp1 mask=3D03 ostat0=3D50 ostat1=3D00 ata0: stat0=3D0xd0 err=3D0x01 lsb=3D0x00 msb=3D0x00 ata0: stat0=3D0x50 err=3D0x01 lsb=3D0x00 msb=3D0x00 ata0: stat1=3D0x00 err=3D0x01 lsb=3D0x00 msb=3D0x00 ata0: reset tp2 stat0=3D50 stat1=3D00 devices=3D0x1 ioapic0: routing intpin 14 (ISA IRQ 14) to lapic 0 vector 53 ata0: [MPSAFE] ata0: [ITHREAD] ata1: on atapci0 atapci0: Reserved 0x8 bytes for rid 0x18 type 4 at 0x170 atapci0: Reserved 0x1 bytes for rid 0x1c type 4 at 0x376 ata1: reset tp1 mask=3D03 ostat0=3D50 ostat1=3D00 ata1: stat0=3D0x50 err=3D0x01 lsb=3D0x14 msb=3D0xeb ata1: stat1=3D0x00 err=3D0x04 lsb=3D0x00 msb=3D0x00 ata1: reset tp2 stat0=3D50 stat1=3D00 devices=3D0x10000 ioapic0: routing intpin 15 (ISA IRQ 15) to lapic 0 vector 54 ata1: [MPSAFE] ata1: [ITHREAD] acpi_tz0: on acpi0 psmcpnp0: irq 12 on acpi0 atkbdc0: port 0x60,0x64,0x62,0x66 irq 1 on ac= pi0 atkbd0: irq 1 on atkbdc0 atkbd: the current kbd controller command byte 0065 atkbd: keyboard ID 0x41ab (2) kbd0 at atkbd0 kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x3d0000 ioapic0: routing intpin 1 (ISA IRQ 1) to lapic 0 vector 55 atkbd0: [GIANT-LOCKED] atkbd0: [ITHREAD] psm0: current command byte:0065 psm0: irq 12 on atkbdc0 ioapic0: routing intpin 12 (ISA IRQ 12) to lapic 0 vector 56 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model GlidePoint, device ID 0-00, 2 buttons psm0: config:00000000, flags:00000008, packet size:3 psm0: syncmask:c0, syncbits:00 atrtc0: port 0x70-0x71,0x72-0x77 irq 8 on acpi0 atrtc0: registered as a time-of-day clock (resolution 1000000us) uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 ioapic0: routing intpin 4 (ISA IRQ 4) to lapic 0 vector 57 uart0: [FILTER] uart0: fast interrupt unknown: status reg test failed ff unknown: status reg test failed ff unknown: status reg test failed ff unknown: status reg test failed ff unknown: status reg test failed ff unknown: status reg test failed ff ahc_isa_probe 14: ioport 0xec00 alloc failed ex_isa_identify() pnp_identify: Trying Read_Port at 203 pnp_identify: Trying Read_Port at 243 pnp_identify: Trying Read_Port at 283 pnp_identify: Trying Read_Port at 2c3 pnp_identify: Trying Read_Port at 303 pnp_identify: Trying Read_Port at 343 pnp_identify: Trying Read_Port at 383 pnp_identify: Trying Read_Port at 3c3 PNP Identify complete isa_probe_children: disabling PnP devices pmtimer0 on isa0 ata: ata0 already exists; skipping it ata: ata1 already exists; skipping it atkbdc: atkbdc0 already exists; skipping it atrtc: atrtc0 already exists; skipping it sc: sc0 already exists; skipping it uart: uart0 already exists; skipping it isa_probe_children: probing non-PnP devices orm0: at iomem 0xc0000-0xcffff pnpid ORM0000 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=3D0x300> sc0: fb0, kbd1, terminal emulator: scteken (teken terminal) vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 fdc0 failed to probe at port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on isa0 ppc0: parallel port not found. ppc0: failed to probe at irq 7 on isa0 uart1: failed to probe at port 0x2f8-0x2ff irq 3 on isa0 isa_probe_children: probing PnP devices est0: on cpu0 p4tcc0: on cpu0 Device configuration finished. Reducing kern.maxvnodes 134098 -> 100000 procfs registered lapic: Divisor 2, Frequency 66504832 Hz Timecounter "TSC" frequency 1862135068 Hz quality 800 Timecounters tick every 1.000 msec vlan: initialized, using hash tables with chaining lo0: bpf attached hptrr: no controller detected. ata0: Identifying devices: 00000001 ata0: New devices: 00000001 usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 12Mbps Full Speed USB v1.0 usbus4: 480Mbps High Speed USB v2.0 acpi_acad0: acline initialization start acpi_acad0: On Line acpi_acad0: acline initialization done, tried 1 times battery0: battery initialization start 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 battery0: battery initialization done, tried 1 times battery1: battery initialization start ata0-master: pio=3DPIO4 wdma=3DWDMA2 udma=3DUDMA100 cable=3D80 wire ad0: setting UDMA100 ad0: 76319MB at ata0-master UDMA100 SATA ad0: 156301488 sectors [155061C/16H/63S] 16 sectors/interrupt 1 depth queue GEOM: new disk ad0 uhub0: 2 ports with 2 removable, self powered uhub1: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered uhub3: 2 ports with 2 removable, self powered ad0: Intel check1 failed ad0: Adaptec check1 failed ad0: LSI (v3) check1 failed ad0: LSI (v2) check1 failed ad0: FreeBSD check1 failed ata1: Identifying devices: 00010000 ata1: New devices: 00010000 ata1-master: pio=3DPIO4 wdma=3DWDMA2 udma=3DUDMA33 cable=3D40 wire acd0: setting UDMA33 acd0: CDRW drive at ata1 as master acd0: read 1722KB/s (4134KB/s) write 172KB/s (4134KB/s), 1536KB buffer, UDM= A33 SATA acd0: Reads: CDR, CDRW, CDDA stream, DVDROM, DVDR, packet acd0: Writes: CDR, CDRW, test write, burnproof acd0: Audio: play, 256 volume levels acd0: Mechanism: ejectable tray, unlocked acd0: Medium: no/blank disc ATA PseudoRAID loaded Root mount waiting for: usbus4 Root mount waiting for: usbus4 uhub4: 8 ports with 8 removable, self powered Root mount waiting for: usbus4 Trying to mount root from ufs:/dev/ad0s1a ct_to_ts([2010-11-05 07:21:39]) =3D 1288941699.000000000 start_init: trying /sbin/init ugen1.2: at usbus1 splash: image decoder found: blank_saver drm0: on vgapci0 vgapci0: attempting to allocate 1 MSI vectors (1 supported) msi: routing MSI IRQ 256 to local APIC 0 vector 58 vgapci0: using IRQ 256 for MSI info: [drm] MSI enabled 1 message(s) vgapci0: Reserved 0x10000 bytes for rid 0x18 type 3 at 0xdfdf0000 vgapci0: child drm0 requested pci_enable_busmaster info: [drm] Initialized radeon 1.31.0 20080613 vgapci0: Reserved 0x8000000 bytes for rid 0x10 type 3 at 0xd0000000 info: [drm] Setting GART location based on new memory map info: [drm] Loading R300 Microcode info: [drm] Num pipes: 1 info: [drm] writeback test succeeded in 1 usecs drm0: [MPSAFE] drm0: [ITHREAD] firmware: 'iwi_bss' version 300: 191154 bytes loaded at 0xc6504000 wlan0: bpf attached wlan0: bpf attached wlan0: Ethernet address: 00:16:6f:36:1c:64 iwi0: need multicast update callback wlan0: link state changed to UP battery1: battery initialization failed, giving up --Multipart_Fri_Nov__5_08:26:33_2010-1 Content-Type: text/plain; charset=US-ASCII At Thu, 4 Nov 2010 11:23:31 +0100, Remko Lodder wrote: > > > > > Can you also send a verbose boot (dmesg) so that we can see how the hardware probing etc goes? To be honest; > the information you send in now, is not enough to see and understand why this takes long. It would also be great > if you can have a look whether or not there are error messages in the logfiles (/var/log/*) that might suggest that > there are timeouts or something (which in turn might indicate that the disk is having problems or something). > > Thanks, > Remko > > -- > /"\ Best regards, | remko@FreeBSD.org > \ / Remko Lodder | > X http://www.evilcoder.org/ | Quis custodiet ipsos custodes > / \ ASCII Ribbon Campaign | Against HTML Mail and News > > > > --Multipart_Fri_Nov__5_08:26:33_2010-1--