From owner-freebsd-bugs@FreeBSD.ORG Wed Nov 7 01:10:01 2012 Return-Path: Delivered-To: freebsd-bugs@hub.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [69.147.83.52]) by hub.freebsd.org (Postfix) with ESMTP id 9D9D4BC5 for ; Wed, 7 Nov 2012 01:10:01 +0000 (UTC) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (freefall.freebsd.org [IPv6:2001:1900:2254:206c::16:87]) by mx1.freebsd.org (Postfix) with ESMTP id 7160B8FC0C for ; Wed, 7 Nov 2012 01:10:01 +0000 (UTC) Received: from freefall.freebsd.org (localhost [127.0.0.1]) by freefall.freebsd.org (8.14.5/8.14.5) with ESMTP id qA71A1HW087199 for ; Wed, 7 Nov 2012 01:10:01 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.14.5/8.14.5/Submit) id qA71A1g7087198; Wed, 7 Nov 2012 01:10:01 GMT (envelope-from gnats) Resent-Date: Wed, 7 Nov 2012 01:10:01 GMT Resent-Message-Id: <201211070110.qA71A1g7087198@freefall.freebsd.org> Resent-From: FreeBSD-gnats-submit@FreeBSD.org (GNATS Filer) Resent-To: freebsd-bugs@FreeBSD.org Resent-Reply-To: FreeBSD-gnats-submit@FreeBSD.org, Taner Tas Received: from mx1.freebsd.org (mx1.freebsd.org [69.147.83.52]) by hub.freebsd.org (Postfix) with ESMTP id D0619B23 for ; Wed, 7 Nov 2012 01:08:37 +0000 (UTC) (envelope-from nobody@FreeBSD.org) Received: from red.freebsd.org (red.freebsd.org [IPv6:2001:4f8:fff6::22]) by mx1.freebsd.org (Postfix) with ESMTP id B764E8FC12 for ; Wed, 7 Nov 2012 01:08:37 +0000 (UTC) Received: from red.freebsd.org (localhost [127.0.0.1]) by red.freebsd.org (8.14.5/8.14.5) with ESMTP id qA718b55076118 for ; Wed, 7 Nov 2012 01:08:37 GMT (envelope-from nobody@red.freebsd.org) Received: (from nobody@localhost) by red.freebsd.org (8.14.5/8.14.5/Submit) id qA718bGY076117; Wed, 7 Nov 2012 01:08:37 GMT (envelope-from nobody) Message-Id: <201211070108.qA718bGY076117@red.freebsd.org> Date: Wed, 7 Nov 2012 01:08:37 GMT From: Taner Tas To: freebsd-gnats-submit@FreeBSD.org X-Send-Pr-Version: www-3.1 Subject: kern/173435: Atapi cdrom boot delay X-BeenThere: freebsd-bugs@freebsd.org X-Mailman-Version: 2.1.14 Precedence: list List-Id: Bug reports List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Wed, 07 Nov 2012 01:10:01 -0000 >Number: 173435 >Category: kern >Synopsis: Atapi cdrom boot delay >Confidential: no >Severity: non-critical >Priority: low >Responsible: freebsd-bugs >State: open >Quarter: >Keywords: >Date-Required: >Class: sw-bug >Submitter-Id: current-users >Arrival-Date: Wed Nov 07 01:10:00 UTC 2012 >Closed-Date: >Last-Modified: >Originator: Taner Tas >Release: 9.1-RC3 >Organization: >Environment: FreeBSD 9.1-RC3 FreeBSD 9.1-RC3 #0 r242324: Tue Oct 30 00:58:57 UTC 2012 root@farrell.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC amd64 >Description: Hi, I recently booted via 9.1-RC3 cdrom and I have caused a approximately 1 minute boot delay problem during atapi cdrom/device detect. I got these kernel messages during delay: (aprobe0:ata0:0:1:0): ATAPI_IDENTIFY. ACB: a1 00 00 00 00 40 00 00 00 00 00 00 (aprobe0:ata0:0:1:0): CAM status: Command timeout (aprobe0:ata0:0:1:0): Error 5, Retry was blocked run_interrupt_driven_hooks: still waiting after 60 seconds for xpt_config (aprobe0:ata0:0:1:0): ATAPI_IDENTIFY. ACB: a1 00 00 00 00 40 00 00 00 00 00 00 (aprobe0:ata0:0:1:0): CAM status: Command timeout (aprobe0:ata0:0:1:0): Error 5, Retry was blocked Same problem exists in current 10.HEAD >How-To-Repeat: Booting via 9.1-RC3 GENERIC kernel using NVIDIA nForce 720D/GeForce 8200 Chipset mainboard with ATAPI/IDE device connected. >Fix: Patch attached with submission follows: 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 9.1-RC3 #0 r242324: Tue Oct 30 00:58:57 UTC 2012 root@farrell.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC amd64 CPU: AMD Athlon(tm) II X2 245 Processor (2914.57-MHz K8-class CPU) Origin = "AuthenticAMD" Id = 0x100f62 Family = 10 Model = 6 Stepping = 2 Features=0x178bfbff Features2=0x802009 AMD Features=0xee500800 AMD Features2=0x37ff TSC: P-state invariant real memory = 3221225472 (3072 MB) avail memory = 3081187328 (2938 MB) Event timer "LAPIC" quality 400 ACPI APIC Table: <050710 APIC1635> 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 irqs 0-23 on motherboard kbd1 at kbdmux0 acpi0: <050710 XSDT1635> on motherboard acpi0: Power Button (fixed) acpi0: reservation of fee01000, ff000 (3) failed acpi0: reservation of fec00000, 1000 (3) failed acpi0: reservation of fee00000, 1000 (3) failed acpi0: reservation of 0, a0000 (3) failed acpi0: reservation of 100000, bff00000 (3) failed cpu0: on acpi0 cpu1: on acpi0 hpet0: iomem 0xfed00000-0xfed00fff irq 2,8 on acpi0 Timecounter "HPET" frequency 25000000 Hz quality 950 attimer0: port 0x40-0x43 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 atrtc0: port 0x70-0x71 on acpi0 Event timer "RTC" frequency 32768 Hz quality 0 Timecounter "ACPI-fast" frequency 3579545 Hz quality 900 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x508-0x50b on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pci0: at device 0.0 (no driver attached) isab0: port 0x900-0x9ff at device 1.0 on pci0 isa0: on isab0 pci0: at device 1.1 (no driver attached) pci0: at device 1.2 (no driver attached) pci0: at device 1.3 (no driver attached) pci0: at device 1.4 (no driver attached) ohci0: mem 0xf9e7e000-0xf9e7efff irq 22 at device 2.0 on pci0 usbus0 on ohci0 ehci0: mem 0xf9e7fc00-0xf9e7fcff irq 23 at device 2.1 on pci0 usbus1: EHCI version 1.0 usbus1 on ehci0 ohci1: mem 0xf9e7d000-0xf9e7dfff irq 20 at device 4.0 on pci0 usbus2 on ohci1 ehci1: mem 0xf9e7f800-0xf9e7f8ff irq 21 at device 4.1 on pci0 usbus3: EHCI version 1.0 usbus3 on ehci1 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xffa0-0xffaf at device 6.0 on pci0 ata0: at channel 0 on atapci0 ata1: at channel 1 on atapci0 hdac0: mem 0xf9e78000-0xf9e7bfff irq 22 at device 7.0 on pci0 pcib1: at device 8.0 on pci0 pci1: on pcib1 ath0: mem 0xf9ff0000-0xf9ffffff irq 19 at device 7.0 on pci1 ath0: AR2413 mac 7.9 RF2413 phy 4.5 ahci0: port 0xd480-0xd487,0xd400-0xd403,0xd080-0xd087,0xd000-0xd003,0xcc00-0xcc0f mem 0xf9e76000-0xf9e77fff irq 23 at device 9.0 on pci0 ahci0: AHCI v1.20 with 6 3Gbps ports, Port Multiplier supported ahcich0: at channel 0 on ahci0 ahcich1: at channel 1 on ahci0 ahcich2: at channel 2 on ahci0 ahcich3: at channel 3 on ahci0 nfe0: port 0xc880-0xc887 mem 0xf9e7c000-0xf9e7cfff,0xf9e7f400-0xf9e7f4ff,0xf9e7f000-0xf9e7f00f irq 20 at device 10.0 on pci0 miibus0: on nfe0 rgephy0: PHY 3 on miibus0 rgephy0: none, 10baseT, 10baseT-FDX, 10baseT-FDX-flow, 100baseTX, 100baseTX-FDX, 100baseTX-FDX-flow, 1000baseT, 1000baseT-master, 1000baseT-FDX, 1000baseT-FDX-master, 1000baseT-FDX-flow, 1000baseT-FDX-flow-master, auto, auto-flow nfe0: Ethernet address: 00:26:18:0a:1e:b1 pcib2: irq 16 at device 16.0 on pci0 pci2: on pcib2 vgapci0: port 0xec00-0xec7f mem 0xfa000000-0xfaffffff,0xd0000000-0xdfffffff,0xce000000-0xcfffffff irq 16 at device 0.0 on pci2 hdac1: mem 0xfbffc000-0xfbffffff irq 16 at device 0.1 on pci2 pcib3: irq 17 at device 18.0 on pci0 pci3: on pcib3 pcib4: irq 18 at device 19.0 on pci0 pci4: on pcib4 acpi_button0: on acpi0 ppc0: port 0x378-0x37f irq 7 on acpi0 ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode ppbus0: on ppc0 plip0: on ppbus0 lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ctl: CAM Target Layer loaded hwpstate0: on cpu0 Timecounters tick every 1.000 msec hdacc0: at cad 0 on hdac0 hdaa0: at nid 1 on hdacc0 pcm0: at nid 20 and 24,26 on hdaa0 pcm1: at nid 27 and 25 on hdaa0 pcm2: at nid 30 on hdaa0 hdacc1: at cad 0 on hdac1 hdaa1: at nid 1 on hdacc1 pcm3: at nid 5 on hdaa1 hdacc2: at cad 1 on hdac1 hdaa2: at nid 1 on hdacc2 pcm4: at nid 5 on hdaa2 hdacc3: at cad 2 on hdac1 hdaa3: at nid 1 on hdacc3 pcm5: at nid 5 on hdaa3 hdacc4: at cad 3 on hdac1 hdaa4: at nid 1 on hdacc4 pcm6: at nid 5 on hdaa4 usbus0: 12Mbps Full Speed USB v1.0 usbus1: 480Mbps High Speed USB v2.0 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 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 uhub0: 6 ports with 6 removable, self powered uhub2: 6 ports with 6 removable, self powered uhub1: 6 ports with 6 removable, self powered uhub3: 6 ports with 6 removable, self powered ugen2.2: at usbus2 ums0: on usbus2 ums0: 16 buttons and [XYZT] coordinates ID=0 (aprobe0:ata0:0:1:0): ATAPI_IDENTIFY. ACB: a1 00 00 00 00 40 00 00 00 00 00 00 (aprobe0:ata0:0:1:0): CAM status: Command timeout (aprobe0:ata0:0:1:0): Error 5, Retry was blocked run_interrupt_driven_hooks: still waiting after 60 seconds for xpt_config (aprobe0:ata0:0:1:0): ATAPI_IDENTIFY. ACB: a1 00 00 00 00 40 00 00 00 00 00 00 (aprobe0:ata0:0:1:0): CAM status: Command timeout (aprobe0:ata0:0:1:0): Error 5, Retry was blocked 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: 476940MB (976773168 512 byte sectors: 16H 63S/T 16383C) ada0: Previously was known as ad4 SMP: AP CPU #1 Launched! Timecounter "TSC-low" frequency 11385020 Hz quality 800 cd0 at ata0 bus 0 scbus0 target 0 lun 0 cd0: Removable CD-ROM SCSI-0 device cd0: 33.300MB/s transfers (UDMA2, ATAPI 12bytes, PIO 65534bytes) cd0: cd present [74929 x 2048 byte records] Trying to mount root from cd9660:/dev/iso9660/FREEBSD_INSTALL [ro]... none0@pci0:0:0:0: class=0x050000 card=0x82f21043 chip=0x075410de rev=0xa2 hdr=0x00 isab0@pci0:0:1:0: class=0x060100 card=0x82f21043 chip=0x075c10de rev=0xa2 hdr=0x00 none1@pci0:0:1:1: class=0x0c0500 card=0x82f21043 chip=0x075210de rev=0xa1 hdr=0x00 none2@pci0:0:1:2: class=0x050000 card=0x82f21043 chip=0x075110de rev=0xa1 hdr=0x00 none3@pci0:0:1:3: class=0x0b4000 card=0x82f21043 chip=0x075310de rev=0xa2 hdr=0x00 none4@pci0:0:1:4: class=0x050000 card=0x82f21043 chip=0x056810de rev=0xa1 hdr=0x00 ohci0@pci0:0:2:0: class=0x0c0310 card=0x82f21043 chip=0x077b10de rev=0xa1 hdr=0x00 ehci0@pci0:0:2:1: class=0x0c0320 card=0x82f21043 chip=0x077c10de rev=0xa1 hdr=0x00 ohci1@pci0:0:4:0: class=0x0c0310 card=0x82f21043 chip=0x077d10de rev=0xa1 hdr=0x00 ehci1@pci0:0:4:1: class=0x0c0320 card=0x82f21043 chip=0x077e10de rev=0xa1 hdr=0x00 atapci0@pci0:0:6:0: class=0x01018a card=0x82f21043 chip=0x075910de rev=0xa1 hdr=0x00 hdac0@pci0:0:7:0: class=0x040300 card=0x82901043 chip=0x077410de rev=0xa1 hdr=0x00 pcib1@pci0:0:8:0: class=0x060401 card=0x82f21043 chip=0x075a10de rev=0xa1 hdr=0x01 ahci0@pci0:0:9:0: class=0x010601 card=0x82f21043 chip=0x0ad410de rev=0xa2 hdr=0x00 nfe0@pci0:0:10:0: class=0x020000 card=0x82f21043 chip=0x076010de rev=0xa2 hdr=0x00 pcib2@pci0:0:16:0: class=0x060400 card=0x82f21043 chip=0x077810de rev=0xa1 hdr=0x01 pcib3@pci0:0:18:0: class=0x060400 card=0x82f21043 chip=0x075b10de rev=0xa1 hdr=0x01 pcib4@pci0:0:19:0: class=0x060400 card=0x82f21043 chip=0x077a10de rev=0xa1 hdr=0x01 hostb0@pci0:0:24:0: class=0x060000 card=0x00000000 chip=0x12001022 rev=0x00 hdr=0x00 hostb1@pci0:0:24:1: class=0x060000 card=0x00000000 chip=0x12011022 rev=0x00 hdr=0x00 hostb2@pci0:0:24:2: class=0x060000 card=0x00000000 chip=0x12021022 rev=0x00 hdr=0x00 hostb3@pci0:0:24:3: class=0x060000 card=0x00000000 chip=0x12031022 rev=0x00 hdr=0x00 hostb4@pci0:0:24:4: class=0x060000 card=0x00000000 chip=0x12041022 rev=0x00 hdr=0x00 ath0@pci0:1:7:0: class=0x020000 card=0x1051168c chip=0x0013168c rev=0x01 hdr=0x00 vgapci0@pci0:2:0:0: class=0x030000 card=0x12133842 chip=0x0a6510de rev=0xa2 hdr=0x00 hdac1@pci0:2:0:1: class=0x040300 card=0x12133842 chip=0x0be310de rev=0xa1 hdr=0x00 >Release-Note: >Audit-Trail: >Unformatted: