From owner-freebsd-bugs@FreeBSD.ORG Thu Nov 4 17:30:13 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 36C4F106566B for ; Thu, 4 Nov 2010 17:30:13 +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 09F3D8FC0C for ; Thu, 4 Nov 2010 17:30:13 +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 oA4HUCap003790 for ; Thu, 4 Nov 2010 17:30:12 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.14.4/8.14.4/Submit) id oA4HUCfI003787; Thu, 4 Nov 2010 17:30:12 GMT (envelope-from gnats) Date: Thu, 4 Nov 2010 17:30:12 GMT Message-Id: <201011041730.oA4HUCfI003787@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: Thu, 04 Nov 2010 17:30:13 -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: Thu, 04 Nov 2010 17:51:23 +0100 --Multipart_Thu_Nov__4_17:51:22_2010-1 Content-Type: text/plain; charset=US-ASCII Hallo, first of all, all the phases of the boot are slow, to explain it better, at boot I have: FreeBSD/i386... (root@ |/-\ 2min Load boot/defaults/loader.conf |/-\ 2min Warning: unable to open file /boot/loader.conf.local |/-\ 4min /boot/kernel/kernel text 0x....... if_iwi... |/-\ 2min zpool_cache ... * failed |/-\ \/|- 1min and the prompt. There is no problem once the system is up, not even exercising the disk intensively. I attach the dmesg: --Multipart_Thu_Nov__4_17:51:22_2010-1 Content-Type: text/plain; charset=US-ASCII Content-Disposition: inline; filename="dmesg.txt" 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 Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: Intel(R) Pentium(R) M processor 1.86GHz (1862.13-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x6d8 Family = 6 Model = d Stepping = 8 Features=0xafe9fbff Features2=0x180 AMD Features=0x100000 real memory = 2147483648 (2048 MB) avail memory = 2090962944 (1994 MB) ACPI APIC Table: ioapic0: Changing APIC ID to 1 ioapic0 irqs 0-23 on motherboard kbd1 at kbdmux0 acpi0: on motherboard acpi0: [ITHREAD] acpi0: reservation of 0, 9fc00 (3) failed acpi0: reservation of 100000, 7fed8000 (3) failed Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 cpu0: on acpi0 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 pcib1: at device 1.0 on pci0 pci1: on pcib1 vgapci0: port 0xde00-0xdeff mem 0xd0000000-0xd7ffffff,0xdfdf0000-0xdfdfffff irq 16 at device 0.0 on pci1 pcib2: at device 28.0 on pci0 pci2: on pcib2 bge0: mem 0xdfcf0000-0xdfcfffff irq 16 at device 0.0 on pci2 miibus0: on bge0 brgphy0: PHY 1 on miibus0 brgphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-FDX, auto bge0: Ethernet address: 00:14:22:e0:cc:40 bge0: [ITHREAD] uhci0: port 0xbf80-0xbf9f irq 16 at device 29.0 on pci0 uhci0: [ITHREAD] usbus0: on uhci0 uhci1: port 0xbf60-0xbf7f irq 17 at device 29.1 on pci0 uhci1: [ITHREAD] usbus1: on uhci1 uhci2: port 0xbf40-0xbf5f irq 18 at device 29.2 on pci0 uhci2: [ITHREAD] usbus2: on uhci2 uhci3: port 0xbf20-0xbf3f irq 19 at device 29.3 on pci0 uhci3: [ITHREAD] usbus3: on uhci3 ehci0: mem 0xffa80800-0xffa80bff irq 16 at device 29.7 on pci0 ehci0: [ITHREAD] usbus4: EHCI version 1.0 usbus4: on ehci0 pcib3: at device 30.0 on pci0 pci3: on pcib3 cbb0: at device 1.0 on pci3 cardbus0: on cbb0 pccard0: <16-bit PCCard bus> on cbb0 cbb0: [FILTER] pci3: at device 1.5 (no driver attached) iwi0: mem 0xdfbff000-0xdfbfffff irq 17 at device 3.0 on pci3 iwi0: [ITHREAD] 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-0x177,0x376,0xbfa0-0xbfaf irq 17 at device 31.2 on pci0 ata0: on atapci0 ata0: [ITHREAD] ata1: on atapci0 ata1: [ITHREAD] 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] atkbd0: [ITHREAD] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model GlidePoint, device ID 0 atrtc0: port 0x70-0x71,0x72-0x77 irq 8 on acpi0 uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 uart0: [FILTER] pmtimer0 on isa0 orm0: at iomem 0xc0000-0xcffff pnpid ORM0000 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 ppc0: parallel port not found. est0: on cpu0 p4tcc0: on cpu0 Timecounter "TSC" frequency 1862132075 Hz quality 800 Timecounters tick every 1.000 msec 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 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 ad0: 76319MB at ata0-master UDMA100 SATA 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 acd0: CDRW at ata1-master UDMA33 SATA 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 ugen1.2: at usbus1 wlan0: Ethernet address: 00:16:6f:36:1c:64 iwi0: need multicast update callback wlan0: link state changed to UP drm0: on vgapci0 info: [drm] MSI enabled 1 message(s) vgapci0: child drm0 requested pci_enable_busmaster info: [drm] Initialized radeon 1.31.0 20080613 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: [ITHREAD] wlan0: link state changed to DOWN wlan0: link state changed to UP Fulvio 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_Thu_Nov__4_17:51:22_2010-1--