From owner-freebsd-stable@FreeBSD.ORG Wed Apr 17 06:35:13 2013 Return-Path: Delivered-To: freebsd-stable@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:1900:2254:206a::19:1]) by hub.freebsd.org (Postfix) with ESMTP id 033E999C for ; Wed, 17 Apr 2013 06:35:13 +0000 (UTC) (envelope-from Andre.Albsmeier@siemens.com) Received: from david.siemens.de (david.siemens.de [192.35.17.14]) by mx1.freebsd.org (Postfix) with ESMTP id 31498E27 for ; Wed, 17 Apr 2013 06:35:11 +0000 (UTC) Received: from mail3.siemens.de (localhost [127.0.0.1]) by david.siemens.de (8.13.6/8.13.6) with ESMTP id r3H6Q15w008379; Wed, 17 Apr 2013 08:26:01 +0200 Received: from curry.mchp.siemens.de (curry.mchp.siemens.de [139.25.40.130]) by mail3.siemens.de (8.13.6/8.13.6) with ESMTP id r3H6Q0kF026853; Wed, 17 Apr 2013 08:26:00 +0200 Received: (from localhost) by curry.mchp.siemens.de (8.14.6/8.14.6) id r3H6Q0ql001304; Date: Wed, 17 Apr 2013 08:26:00 +0200 From: Andre Albsmeier To: Jeremy Chadwick Subject: Re: Lost CDROM on 9.1 with ATA_CAM on Promise controller Message-ID: <20130417062600.GA15613@bali> References: <20130416175520.GA9548@bali> <20130416193822.GA83620@icarus.home.lan> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: <20130416193822.GA83620@icarus.home.lan> X-Echelon: X-Advice: Drop that crappy M$-Outlook, I'm tired of your viruses! User-Agent: Mutt/1.5.21 (2010-09-15) Cc: "freebsd-stable@freebsd.org" X-BeenThere: freebsd-stable@freebsd.org X-Mailman-Version: 2.1.14 Precedence: list List-Id: Production branch of FreeBSD source code List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Wed, 17 Apr 2013 06:35:13 -0000 On Tue, 16-Apr-2013 at 21:38:22 +0200, Jeremy Chadwick wrote: > On Tue, Apr 16, 2013 at 07:55:20PM +0200, Andre Albsmeier wrote: > > I have lost one of my CDROM drives (HL-DT-STDVD-RAM GH22LP20/2.00) > > after going from 7.4 to 9.1 when using ATA_CAM. It is attached to > > a Promise PDC20268 UDMA100 controller. A standard harddisk drive > > attached to this controller works well. Cables, controller and drive > > where replaced already. > > > > Kernel gives me: > > > > atapci1: port 0xb000-0xb007,0xa800-0xa803,0xa400-0xa407,0xa000-0xa003,0x9800-0x980f mem 0xdf800000-0xdf803fff irq 11 at device 12.0 on pci0 > > ata2: at channel 0 on atapci1 > > ata3: at channel 1 on atapci1 > > ... > > ada0 at ata2 bus 0 scbus2 target 0 lun 0 > > ada0: ATA-7 device > > ada0: 100.000MB/s transfers (UDMA5, PIO 8192bytes) > > ada0: 286188MB (586114704 512 byte sectors: 16H 63S/T 16383C) > > ... > > (cd2:ata3:0:0:0): got CAM status 0x50 > > (cd2:ata3:0:0:0): fatal error, failed to attach to device > > (cd2:ata3:0:0:0): lost device, 4 refs > > (cd2:ata3:0:0:0): removing device entry > > ... > > > > Attaching the CDROM drive to the controller that is integrated on > > the mainboard (Intel PIIX4 UDMA33 controller) does not show this > > problem (but here I don't have UDMA66). > > > > It also works when not using ATA_CAM: > > > > ... > > acd0: DVDR at ata3-master UDMA66 > > ... > > > > So this semes to be a problem with the Promise controller and ATA_CAM. > > > > Any ideas? Or should I file PR? > > The controller in question is a Promise Ultra100 TX2. Right. Tried with an Ultra133, same effect. > > The error message comes from sys/cam/scsi/scsi_cd.c, in function > cddone(). The logic is a little hard for me to follow (I understand > about 70% of it). Look at lines 1724 to 1877 for stable/9. > > 1. Can you provide full output from a verbose boot when the CD/DVD drive > is attached to the Promise controller? Attached below. I have just filtered out some ahc cruft... Later I will try to boot a -current kernel -- just to see how this behaves... > > 2. What firmware version the card is using? The PDC20268 had many, many > firmware problems relating to ATAPI devices. It is the latest BIOS: 2.20.0.15. > > 3. I wouldn't worry about ATA66 vs. ATA33; this drive can only support > up to about 22MBytes/second so ATA66 isn't going to get you anything, > so as a workaround, using the PIIX4 for it would not hurt you. Probably. But I already had cdrecord complain when it came to the funky DMA speed test it is doing. It went away when using the UDMA66 port. And on the other hand I sometimes use the PIIX4 port for other stuff and I do not want to attach the cdrom to the slave port. > > 4. ONLY if this turns out to be a "controller thing": I'm not sure how > much effort should be spent trying to make this work, as the PDC20268 is > legacy/deprecated hardware (made/released 13 years ago). The whole box is more than 13 years old (good old Asus BX board) ;-) But since it worked in 7.4-STABLE I feel that this is some kind of regression. I do not want to waste anyone's resources in fixing it -- just if someone is curious and/or has an idea how to fix it... And here is the dmesg: Copyright (c) 1992-2013 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-STABLE #6: Wed Apr 17 07:56:57 CEST 2013 root@server.ofw.tld:/usr/obj/src/src-9/sys/bratfix i386 gcc version 4.2.1 20070831 patched [FreeBSD] Preloaded elf kernel "/boot/kernel/kernel" at 0xc097d000. Calibrating TSC clock ... TSC clock: 1405298309 Hz CPU: Intel(R) Celeron(TM) CPU 1400MHz (1405.30-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x6b1 Family = 0x6 Model = 0xb Stepping = 1 Features=0x383f9ff Instruction TLB: 4 KB pages, 4-way set associative, 32 entries Instruction TLB: 4 MB pages, fully associative, 2 entries Data TLB: 4 KB pages, 4-way set associative, 64 entries 2nd-level cache: 256 KB, 8-way set associative, 32 byte line size 1st-level instruction cache: 16 KB, 4-way set associative, 32 byte line size Data TLB: 4 MB Pages, 4-way set associative, 8 entries 1st-level data cache: 16 KB, 4-way set associative, 32 byte line size real memory = 268435456 (256 MB) Physical memory chunk(s): 0x0000000000001000 - 0x000000000009dfff, 643072 bytes (157 pages) 0x0000000000100000 - 0x00000000003fffff, 3145728 bytes (768 pages) 0x0000000000c26000 - 0x000000000fb18fff, 250556416 bytes (61171 pages) avail memory = 253022208 (241 MB) bios32: Found BIOS32 Service Directory header at 0xc00f92a0 bios32: Entry = 0xf06c0 (c00f06c0) Rev = 0 Len = 1 pcibios: PCI BIOS entry at 0xf0000+0x8c0 pnpbios: Found PnP BIOS data at 0xc00fc240 pnpbios: Entry = f0000:c270 Rev = 1.0 pnpbios: OEM ID cd041 Other BIOS signatures found: ULE: setup cpu 0 random: cpuctl: access to MSR registers/cpuid info. nfslock: pseudo-device io: mem: Pentium Pro MTRR support enabled null: ACPI: RSDP 0xf5a90 00014 (v00 ASUS ) ACPI: RSDT 0xffec000 0002C (v01 ASUS CUBX-L 30303031 MSFT 31313031) ACPI: FACP 0xffec080 00074 (v01 ASUS CUBX-L 30303031 MSFT 31313031) ACPI: DSDT 0xffec100 02626 (v01 ASUS CUBX-L 00001000 MSFT 0100000B) ACPI: FACS 0xffff000 00040 ACPI: BOOT 0xffec040 00028 (v01 ASUS CUBX-L 30303031 MSFT 31313031) acpi0: on motherboard acpi0: Power Button (fixed) acpi0: wakeup code va 0xc1f76000 pa 0x1000 atpic: Programming IRQ9 as level/low pci_open(1): mode 1 addr port (0x0cf8) is 0x8000005c pci_open(1a): mode1res=0x80000000 (0x80000000) pci_cfgcheck: device 0 [class=060000] [hdr=00] is there (id=71908086) pcibios: BIOS version 2.10 acpi0: reservation of 0, a0000 (3) failed acpi0: reservation of 100000, ff00000 (3) failed cpu0: on acpi0 cpu0: switching to generic Cx mode attimer0: port 0x40-0x43 irq 0 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 atrtc0: port 0x70-0x73 irq 8 on acpi0 atrtc0: registered as a time-of-day clock (resolution 1000000us, adjustment 0.500000000s) Event timer "RTC" frequency 32768 Hz quality 0 ACPI timer: 0/4 0/4 0/4 0/4 0/4 0/4 0/4 0/4 0/4 0/4 -> 0 Timecounter "ACPI-safe" frequency 3579545 Hz quality 850 acpi_timer0: <24-bit timer at 3.579545MHz> port 0xe408-0xe40b on acpi0 pci_link0: Index IRQ Rtd Ref IRQs Initial Probe 0 11 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 11 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_link1: Index IRQ Rtd Ref IRQs Initial Probe 0 10 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 10 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_link2: Index IRQ Rtd Ref IRQs Initial Probe 0 12 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 12 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_link3: Index IRQ Rtd Ref IRQs Initial Probe 0 15 N 0 3 4 5 6 7 9 10 11 12 14 15 Validation 0 15 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_button0: on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pcib0: decoding 4 range 0-0xcf7 pcib0: decoding 4 range 0xd00-0xffff pcib0: decoding 3 range 0xa0000-0xbffff pcib0: decoding 3 range 0xc8000-0xdffff pcib0: decoding 3 range 0x10000000-0xffffffff ACPI: Found matching pin for 0.12.INTA at func 0: 11 ACPI: Found matching pin for 0.11.INTA at func 0: 10 ACPI: Found matching pin for 0.10.INTA at func 0: 12 ACPI: Found matching pin for 0.9.INTA at func 0: 15 ACPI: Found matching pin for 0.4.INTD at func 2: 255 pci0: on pcib0 pci0: domain=0, physical bus=0 found-> vendor=0x8086, dev=0x7190, revid=0x03 domain=0, bus=0, slot=0, func=0 class=06-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0106, statreg=0x2210, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) map[10]: type Prefetchable Memory, range 32, base 0xe4000000, size 26, enabled pcib0: allocated type 3 (0xe4000000-0xe7ffffff) for rid 10 of pci0:0:0:0 found-> vendor=0x8086, dev=0x7191, revid=0x03 domain=0, bus=0, slot=1, func=0 class=06-04-00, hdrtype=0x01, mfdev=0 cmdreg=0x0117, statreg=0x0220, cachelnsz=0 (dwords) lattimer=0x40 (1920 ns), mingnt=0x88 (34000 ns), maxlat=0x00 (0 ns) found-> vendor=0x8086, dev=0x7110, revid=0x02 domain=0, bus=0, slot=4, func=0 class=06-01-00, hdrtype=0x00, mfdev=1 cmdreg=0x000f, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) found-> vendor=0x8086, dev=0x7111, revid=0x01 domain=0, bus=0, slot=4, func=1 class=01-01-80, hdrtype=0x00, mfdev=0 cmdreg=0x0000, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x20 (960 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) pcib0: allocated type 4 (0x1f0-0x1f7) for rid 10 of pci0:0:4:1 pcib0: allocated type 4 (0x3f6-0x3f6) for rid 14 of pci0:0:4:1 pcib0: allocated type 4 (0x170-0x177) for rid 18 of pci0:0:4:1 pcib0: allocated type 4 (0x376-0x376) for rid 1c of pci0:0:4:1 map[20]: type I/O Port, range 32, base 0xd800, size 4, port disabled pcib0: allocated type 4 (0xd800-0xd80f) for rid 20 of pci0:0:4:1 found-> vendor=0x8086, dev=0x7112, revid=0x01 domain=0, bus=0, slot=4, func=2 class=0c-03-00, hdrtype=0x00, mfdev=0 cmdreg=0x0005, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x20 (960 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) intpin=d, irq=255 map[20]: type I/O Port, range 32, base 0xd400, size 5, enabled pcib0: allocated type 4 (0xd400-0xd41f) for rid 20 of pci0:0:4:2 found-> vendor=0x8086, dev=0x7113, revid=0x02 domain=0, bus=0, slot=4, func=3 class=06-80-00, hdrtype=0x00, mfdev=0 cmdreg=0x0003, statreg=0x0280, cachelnsz=0 (dwords) lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) map[90]: type I/O Port, range 32, base 0xe800, size 4, enabled pcib0: allocated type 4 (0xe800-0xe80f) for rid 90 of pci0:0:4:3 found-> vendor=0x9004, dev=0x8178, revid=0x00 domain=0, bus=0, slot=9, func=0 class=01-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0017, statreg=0x0280, cachelnsz=8 (dwords) lattimer=0x20 (960 ns), mingnt=0x08 (2000 ns), maxlat=0x08 (2000 ns) intpin=a, irq=15 map[10]: type I/O Port, range 32, base 0xd000, size 8, enabled pcib0: allocated type 4 (0xd000-0xd0ff) for rid 10 of pci0:0:9:0 map[14]: type Memory, range 32, base 0xe1000000, size 12, enabled pcib0: allocated type 3 (0xe1000000-0xe1000fff) for rid 14 of pci0:0:9:0 pcib0: matched entry for 0.9.INTA (src \134_SB_.LNKD:0) pcib0: slot 9 INTA routed to irq 15 via \134_SB_.LNKD found-> vendor=0x8086, dev=0x107c, revid=0x05 domain=0, bus=0, slot=10, func=0 class=02-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0017, statreg=0x0230, cachelnsz=8 (dwords) lattimer=0x20 (960 ns), mingnt=0xff (63750 ns), maxlat=0x00 (0 ns) intpin=a, irq=12 powerspec 2 supports D0 D3 current D0 map[10]: type Memory, range 32, base 0xe0800000, size 17, enabled pcib0: allocated type 3 (0xe0800000-0xe081ffff) for rid 10 of pci0:0:10:0 map[18]: type I/O Port, range 32, base 0xb800, size 6, enabled pcib0: allocated type 4 (0xb800-0xb83f) for rid 18 of pci0:0:10:0 pcib0: matched entry for 0.10.INTA (src \134_SB_.LNKC:0) pcib0: slot 10 INTA routed to irq 12 via \134_SB_.LNKC found-> vendor=0x9005, dev=0x0080, revid=0x02 domain=0, bus=0, slot=11, func=0 class=01-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0017, statreg=0x02b0, cachelnsz=8 (dwords) lattimer=0x20 (960 ns), mingnt=0x28 (10000 ns), maxlat=0x19 (6250 ns) intpin=a, irq=10 powerspec 2 supports D0 D3 current D0 map[10]: type I/O Port, range 32, base 0xb400, size 8, enabled pcib0: allocated type 4 (0xb400-0xb4ff) for rid 10 of pci0:0:11:0 map[14]: type Memory, range 64, base 0xe0000000, size 12, enabled pcib0: allocated type 3 (0xe0000000-0xe0000fff) for rid 14 of pci0:0:11:0 pcib0: matched entry for 0.11.INTA (src \134_SB_.LNKB:0) pcib0: slot 11 INTA routed to irq 10 via \134_SB_.LNKB found-> vendor=0x105a, dev=0x4d68, revid=0x02 domain=0, bus=0, slot=12, func=0 class=01-80-85, hdrtype=0x00, mfdev=0 cmdreg=0x0007, statreg=0x0430, cachelnsz=8 (dwords) lattimer=0x20 (960 ns), mingnt=0x04 (1000 ns), maxlat=0x12 (4500 ns) intpin=a, irq=11 powerspec 1 supports D0 D1 D3 current D0 map[10]: type I/O Port, range 32, base 0xb000, size 3, enabled pcib0: allocated type 4 (0xb000-0xb007) for rid 10 of pci0:0:12:0 map[14]: type I/O Port, range 32, base 0xa800, size 2, enabled pcib0: allocated type 4 (0xa800-0xa803) for rid 14 of pci0:0:12:0 map[18]: type I/O Port, range 32, base 0xa400, size 3, enabled pcib0: allocated type 4 (0xa400-0xa407) for rid 18 of pci0:0:12:0 map[1c]: type I/O Port, range 32, base 0xa000, size 2, enabled pcib0: allocated type 4 (0xa000-0xa003) for rid 1c of pci0:0:12:0 map[20]: type I/O Port, range 32, base 0x9800, size 4, enabled pcib0: allocated type 4 (0x9800-0x980f) for rid 20 of pci0:0:12:0 map[24]: type Memory, range 32, base 0xdf800000, size 14, enabled pcib0: allocated type 3 (0xdf800000-0xdf803fff) for rid 24 of pci0:0:12:0 pcib0: matched entry for 0.12.INTA (src \134_SB_.LNKA:0) pcib0: slot 12 INTA routed to irq 11 via \134_SB_.LNKA eccmon0: RAM ECC Monitor v0.13 on i440BX/ZX (8086:7190), reporting tested eccmon0: Capabilities: ECC with hardware scrubber eccmon0: Current mode: ECC with hardware scrubber eccmon0: Bank Size Type ILV ECC eccmon0: 0 128M SDR N Y eccmon0: 2 128M SDR N Y eccmon0: Total RAM detected: 256M eccmon0: on hostb0 eccmon0: attached pcib1: at device 1.0 on pci0 pcib0: allocated type 3 (0xe1800000-0xe2dfffff) for rid 20 of pcib1 pcib0: allocated type 3 (0xe2f00000-0xe3ffffff) for rid 24 of pcib1 pcib1: domain 0 pcib1: secondary bus 1 pcib1: subordinate bus 1 pcib1: memory decode 0xe1800000-0xe2dfffff pcib1: prefetched decode 0xe2f00000-0xe3ffffff pci1: on pcib1 pci1: domain=0, physical bus=1 found-> vendor=0x102b, dev=0x0521, revid=0x03 domain=0, bus=1, slot=0, func=0 class=03-00-00, hdrtype=0x00, mfdev=0 cmdreg=0x0007, statreg=0x0290, cachelnsz=8 (dwords) lattimer=0x40 (1920 ns), mingnt=0x10 (4000 ns), maxlat=0x20 (8000 ns) intpin=a, irq=11 powerspec 1 supports D0 D3 current D0 map[10]: type Prefetchable Memory, range 32, base 0xe3000000, size 24, enabled pcib1: allocated prefetch range (0xe3000000-0xe3ffffff) for rid 10 of pci0:1:0:0 map[14]: type Memory, range 32, base 0xe2000000, size 14, enabled pcib1: allocated memory range (0xe2000000-0xe2003fff) for rid 14 of pci0:1:0:0 map[18]: type Memory, range 32, base 0xe1800000, size 23, enabled pcib1: allocated memory range (0xe1800000-0xe1ffffff) for rid 18 of pci0:1:0:0 pcib0: matched entry for 0.1.INTA (src \134_SB_.LNKA:0) pcib0: slot 1 INTA routed to irq 11 via \134_SB_.LNKA pcib1: slot 0 INTA is routed to irq 11 vgapci0: mem 0xe3000000-0xe3ffffff,0xe2000000-0xe2003fff,0xe1800000-0xe1ffffff irq 11 at device 0.0 on pci1 isab0: at device 4.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xd800-0xd80f at device 4.1 on pci0 ata0: at channel 0 on atapci0 ata1: at channel 1 on atapci0 pci0: at device 4.2 (no driver attached) intsmb0: port 0xe800-0xe80f at device 4.3 on pci0 intsmb0: intr IRQ 9 enabled revision 0 smbus0: on intsmb0 smb0: on smbus0 ahc0: port 0xd000-0xd0ff mem 0xe1000000-0xe1000fff irq 15 at device 9.0 on pci0 ahc0: Bugs (0x0025): TMODE_WIDEODD CACHETHEN PCI_MWI ahc0: Defaulting to MEMIO on ahc0: Reading SEEPROM...done. ahc0: Low byte termination Enabled ahc0: Downloading Sequencer Program... 442 instructions downloaded ahc0: Features 0x10001, Bugs 0x25, Flags 0x20485540 aic7880: Ultra Single Channel A, SCSI Id=7, 16/253 SCBs em0: port 0xb800-0xb83f mem 0xe0800000-0xe081ffff irq 12 at device 10.0 on pci0 em0: bpf attached em0: Ethernet address: 00:1b:21:0a:8d:db ahc1: port 0xb400-0xb4ff mem 0xe0000000-0xe0000fff irq 10 at device 11.0 on pci0 ahc1: Bugs (0x0040): SCBCHAN_UPLOAD ahc1: Defaulting to MEMIO on ahc1: Reading SEEPROM...done. ahc1: Manual SE Termination ahc1: Manual LVD Termination ahc1: BIOS eeprom is present ahc1: Secondary High byte termination Enabled ahc1: Secondary Low byte termination Enabled ahc1: Primary Low Byte termination Enabled ahc1: Primary High Byte termination Enabled ahc1: Downloading Sequencer Program... 423 instructions downloaded ahc1: Features 0x1def6, Bugs 0x40, Flags 0x20485560 aic7892: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs atapci1: port 0xb000-0xb007,0xa800-0xa803,0xa400-0xa407,0xa000-0xa003,0x9800-0x980f mem 0xdf800000-0xdf803fff irq 11 at device 12.0 on pci0 ata2: at channel 0 on atapci1 ata3: at channel 1 on atapci1 fdc0: port 0x3f2-0x3f5,0x3f7 irq 6 drq 2 on acpi0 fdc0: ic_type 90 part_id 80 fd0: <1440-KB 3.5" drive> on fdc0 drive 0 uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0 uart0: fast interrupt uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0 uart1: fast interrupt atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 atkbd: the current kbd controller command byte 0067 atkbd: keyboard ID 0x41ab (2) kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x3d0000 atkbd0: [GIANT-LOCKED] pnp_identify: Trying Read_Port at 203 ... pnp_identify: Trying Read_Port at 3c3 PNP Identify complete ahc_isa_probe 0: ioport 0xc00 alloc failed ... pcib0: allocated type 3 (0xdf800-0xdffff) for rid 2 of orm0 isa_probe_children: disabling PnP devices ata: ata0 already exists; skipping it ata: ata1 already exists; skipping it atkbdc: atkbdc0 already exists; skipping it atrtc: atrtc0 already exists; skipping it attimer: attimer0 already exists; skipping it fdc: fdc0 already exists; skipping it sc: sc0 already exists; skipping it uart: uart0 already exists; skipping it uart: uart1 already exists; skipping it isa_probe_children: probing non-PnP devices orm0: at iomem 0xc0000-0xc7fff,0xd8000-0xda7ff pnpid ORM0000 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <9 virtual consoles, flags=0x300> sc0: fb0, kbd0, terminal emulator: scteken (teken terminal) vga0: at port 0x3b0-0x3df iomem 0xa0000-0xbffff on isa0 pcib0: allocated type 4 (0x3b0-0x3df) for rid 0 of vga0 pcib0: allocated type 3 (0xa0000-0xbffff) for rid 0 of vga0 ppc0 failed to probe at irq 7 on isa0 wbwd0 failed to probe on isa0 isa_probe_children: probing PnP devices acpi_throttle0: on cpu0 acpi_throttle0: P_CNT from P_BLK 0xe410 Device configuration finished. procfs registered Timecounters tick every 10.000 msec lo0: bpf attached ata0: reset tp1 mask=00 ostat0=ff ostat1=ff ata1: reset tp1 mask=00 ostat0=ff ostat1=ff (noperiph:ahc0:0:-1:-1): SCSI bus reset delivered. 0 SCBs aborted. (noperiph:ahc1:0:-1:-1): SCSI bus reset delivered. 0 SCBs aborted. ata2: reset tp1 mask=03 ostat0=50 ostat1=00 ata2: stat0=0x50 err=0x01 lsb=0x00 msb=0x00 ata2: stat1=0x00 err=0x01 lsb=0x00 msb=0x00 ata2: reset tp2 stat0=50 stat1=00 devices=0x1 ata3: reset tp1 mask=03 ostat0=51 ostat1=00 ata3: stat0=0x00 err=0x01 lsb=0x14 msb=0xeb ata3: stat1=0x00 err=0x00 lsb=0x00 msb=0x00 ata3: reset tp2 stat0=00 stat1=00 devices=0x10000 ahc0: Selection Timeout on A:2. 0 SCBs aborted ahc0: Selection Timeout on A:3. 0 SCBs aborted ahc0: Selection Timeout on A:4. 0 SCBs aborted (probe5:ahc0:0:5:0): Down reving Protocol Version from 4 to 2? ... (ahc0:A:1:0): Received SDTR period c, offset f Filtered to period c, offset f ahc0: target 1 synchronous at 20.0MHz, offset = 0xf ahc1: Selection Timeout on A:1. 0 SCBs aborted ahc1: Selection Timeout on A:2. 0 SCBs aborted ahc1: Selection Timeout on A:3. 0 SCBs aborted (ahc1:A:4:0): Received WDTR 1 filtered to 0 (ahc1:A:4:0): Target Initiated WDTR (ahc1:A:4:0): Sending WDTR 0 ahc1: target 4 using 8bit transfers (ahc1:A:4:0): Received SDTR period a, offset 79 Filtered to period 0, offset 0 ahc1: target 4 using asynchronous transfers (ahc1:A:4:0): Target Initiated SDTR (ahc1:A:4:0): Sending SDTR period 45, offset 0 ahc1: Selection Timeout on A:5. 0 SCBs aborted ... ahc1: Selection Timeout on A:14. 0 SCBs aborted ahc1: Selection Timeout on A:15. 0 SCBs aborted (ahc1:A:4:0): Sending PPR bus_width 1, period 9, offset 7f, ppr_options 2 (ahc1:A:4:0): Received PPR width 1, period 9, offset 78,options 2 Filtered to width 1, period 9, offset 78, options 2 ahc1: target 4 using 16bit transfers ahc1: target 4 synchronous at 80.0MHz DT, offset = 0x78 (probe7:ahc1:0:0:0): Down reving Protocol Version from 4 to 2? (probe7:ahc1:0:0:0): Down reving Transport Version from 3 to 2? (ahc1:A:4:0): Sending PPR bus_width 1, period 9, offset 78, ppr_options 2 (ahc1:A:4:0): Received PPR width 1, period 9, offset 78,options 2 Filtered to width 1, period 9, offset 78, options 2 (ahc1:A:0:0): Sending WDTR 1 (ahc1:A:0:0): Received WDTR 1 filtered to 1 ahc1: target 0 using 16bit transfers (ahc1:A:0:0): Sending SDTR period c, offset 7f (ahc1:A:0:0): Received SDTR period c, offset f Filtered to period c, offset f ahc1: target 0 synchronous at 20.0MHz, offset = 0xf pass0 at ahc0 bus 0 scbus0 target 0 lun 0 pass0: Fixed Direct Access SCSI-2 device pass0: Serial Number F25V7824 pass0: 20.000MB/s transfers (20.000MHz, offset 15) pass1 at ahc0 bus 0 scbus0 target 1 lun 0 pass1: Fixed Direct Access SCSI-2 device pass1: Serial Number F2587270 pass1: 20.000MB/s transfers (20.000MHz, offset 15) pass2 at ahc0 bus 0 scbus0 target 5 lun 0 pass2: Removable CD-ROM SCSI-2 device pass2: 20.000MB/s transfers (20.000MHz, offset 15) pass3 at ahc0 bus 0 scbus0 target 6 lun 0 pass3: Removable CD-ROM SCSI-2 device pass3: 20.000MB/s transfers (20.000MHz, offset 15) pass4 at ahc1 bus 0 scbus1 target 0 lun 0 pass4: Fixed Direct Access SCSI-2 device pass4: Serial Number 3AL0RR7H0000701423PB pass4: 40.000MB/s transfers (20.000MHz, offset 15, 16bit) pass4: Command Queueing enabled pass5 at ahc1 bus 0 scbus1 target 4 lun 0 pass5: Removable Sequential Access SCSI-4 device pass5: Serial Number QD0719AMC00028 pass5: 160.000MB/s transfers (80.000MHz DT, offset 120, 16bit) pass6 at ata2 bus 0 scbus2 target 0 lun 0 pass6: ATA-7 device pass6: Serial Number B61T05CH pass6: 100.000MB/s transfers (UDMA5, PIO 8192bytes) pass7 at ata3 bus 0 scbus3 target 0 lun 0 pass7: Removable CD-ROM SCSI-0 device pass7: 66.700MB/s transfers (UDMA4, ATAPI 12bytes, PIO 65534bytes) sa0 at ahc1 bus 0 scbus1 target 4 lun 0 sa0: Removable Sequential Access SCSI-4 device sa0: Serial Number QD0719AMC00028 sa0: 160.000MB/s transfers (80.000MHz DT, offset 120, 16bit) ada0 at ata2 bus 0 scbus2 target 0 lun 0 ada0: ATA-7 device ada0: Serial Number B61T05CH ada0: 100.000MB/s transfers (UDMA5, PIO 8192bytes) ada0: 286188MB (586114704 512 byte sectors: 16H 63S/T 16383C) da10 at ahc1 bus 0 scbus1 target 0 lun 0 da10: Fixed Direct Access SCSI-2 device da10: Serial Number 3AL0RR7H0000701423PB da10: 40.000MB/s transfers (20.000MHz, offset 15, 16bit) da10: Command Queueing enabled da10: 8683MB (17783240 512 byte sectors: 255H 63S/T 1106C) (ahc0:A:5:0): Sending SDTR period c, offset f Timecounter "TSC" frequency 1405298309 Hz quality 800 GEOM: new disk da0 GEOM: new disk da1 GEOM: new disk da10 GEOM: new disk cd1 GEOM: new disk cd0 GEOM: new disk cd2 GEOM: new disk ada0 (ahc0:A:5:0): Received SDTR period c, offset f Filtered to period c, offset f (ahc0:A:6:0): Sending SDTR period c, offset f cd1 at ahc0 bus 0 scbus0 target 5 lun 0 cd1: Removable CD-ROM SCSI-2 device cd1: 20.000MB/s transfers (20.000MHz, offset 15) cd1: Attempt to query device size failed: NOT READY, Medium not present - tray closed (ahc0:A:6:0): Received SDTR period c, offset f Filtered to period c, offset f da1 at ahc0 bus 0 scbus0 target 1 lun 0 da1: Fixed Direct Access SCSI-2 device da1: Serial Number F2587270 da1: 20.000MB/s transfers (20.000MHz, offset 15) da1: 2063MB (4226725 512 byte sectors: 255H 63S/T 263C) da0 at ahc0 bus 0 scbus0 target 0 lun 0 da0: Fixed Direct Access SCSI-2 device da0: Serial Number F25V7824 da0: 20.000MB/s transfers (20.000MHz, offset 15) da0: 2063MB (4226725 512 byte sectors: 255H 63S/T 263C) (ahc0:A:5:0): Sending SDTR period c, offset f (ahc0:A:5:0): Received SDTR period c, offset f Filtered to period c, offset f ... (ahc0:A:6:0): Sending SDTR period c, offset f (ahc0:A:6:0): Received SDTR period c, offset f Filtered to period c, offset f cd0 at ahc0 bus 0 scbus0 target 6 lun 0 cd0: Removable CD-ROM SCSI-2 device cd0: 20.000MB/s transfers (20.000MHz, offset 15) cd0: Attempt to query device size failed: NOT READY, Medium not present - tray closed (ahc0:A:6:0): Sending SDTR period c, offset f (ahc0:A:6:0): Received SDTR period c, offset f Filtered to period c, offset f ... (ahc0:A:6:0): Sending SDTR period c, offset f (ahc0:A:6:0): Received SDTR period c, offset f Filtered to period c, offset f ata3: reset tp1 mask=03 ostat0=50 ostat1=00 ata3: stat0=0x00 err=0x01 lsb=0x14 msb=0xeb ata3: stat1=0x00 err=0x00 lsb=0x00 msb=0x00 ata3: reset tp2 stat0=00 stat1=00 devices=0x10000 (cd2:ata3:0:0:0): got CAM status 0x50 (cd2:ata3:0:0:0): fatal error, failed to attach to device (cd2:ata3:0:0:0): lost device, 4 refs Opened disk cd2 -> 6 (cd2:ata3:0:0:0): removing device entry (ahc0:A:5:0): Sending SDTR period c, offset f (ahc0:A:5:0): Received SDTR period c, offset f Filtered to period c, offset f ...