CD Burner and ATAPICAM Problem

Jason Cox
2006-02-17T08:18:29Z

Hello all,

While trying to get CD burning working under FreeBSD 6.0 (and
6.1-PreRelease), I keep getting the following error in my dmesg and cd1
is never created. The drive is a Philips CDRW4012P. It shows up
as /dev/acd1 and reports correctly in dmesg. However, once atapicam
tries to query it, it just repeats the follwoing (output from dmesg with
boot -v):

ata1: reiniting channel ..
ata1: reset tp1 mask=03 ostat0=50 ostat1=00
ata1: stat0=0x00 err=0x01 lsb=0x14 msb=0xeb
ata1: stat1=0x00 err=0x01 lsb=0x14 msb=0xeb
ata1: reset tp2 stat0=00 stat1=00 devices=0xc<ATAPI_SLAVE,ATAPI_MASTER>
acd0: setting PIO4 on ICH5 chip
acd0: setting UDMA33 on ICH5 chip
acd1: setting PIO4 on ICH5 chip
acd1: setting UDMA33 on ICH5 chip
ata1: reinit done ..
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): (probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
Unretryable error
(probe8:ata1:0:1:0): error 22
(probe8:ata1:0:1:0): Unretryable Error

I have looked all over the internet and everywhere says it should have
been fixed in 4.7. Any advice on what else to try?

Also, I'm unable to mount any cd from either the Sony DRU-810A (DVD
Burner) or the Philips. Attached is the dmesg output from a regular boot
(not a verbose output). Anything else you need to help me with this?

Jason

-------------- next part --------------
Copyright (c) 1992-2005 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 6.1-PRERELEASE #10: Tue Feb  7 13:10:53 CST 2006
    root@jpcoxdesktop.mshome.net:/usr/obj/usr/src/sys/TestKernel
ACPI APIC Table: <INTEL  D865GLC >
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: Intel(R) Pentium(R) 4 CPU 2.40GHz (2394.17-MHz 686-class CPU)
  Origin = "GenuineIntel"  Id = 0xf27  Stepping = 7

Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
  Features2=0x4400<CNTX-ID,<b14>>
real memory  = 536014848 (511 MB)
avail memory = 510988288 (487 MB)
ioapic0 <Version 2.0> irqs 0-23 on motherboard
npx0: [FAST]
npx0: on motherboard
npx0: INT 16 interface
acpi0: <INTEL D865GLC> on motherboard
acpi0: Power Button (fixed)
Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0
cpu0: <ACPI CPU> on acpi0
acpi_throttle0: <ACPI CPU Throttling> on cpu0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
agp0: <Intel 82865 host to AGP bridge> mem 0xe0000000-0xefffffff at device
0.0 on pci0
pcib1: <ACPI PCI-PCI bridge> at device 1.0 on pci0
pci1: <ACPI PCI bus> on pcib1
nvidia0: <GeForce FX 5600> mem 0xfc000000-0xfcffffff,0xd0000000-0xdfffffff
irq 16 at device 0.0 on pci1
nvidia0: [GIANT-LOCKED]
uhci0: <Intel 82801EB (ICH5) USB controller USB-A> port 0xcc00-0xcc1f irq
16 at device 29.0 on pci0
uhci0: [GIANT-LOCKED]
usb0: <Intel 82801EB (ICH5) USB controller USB-A> on uhci0
usb0: USB revision 1.0
uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 2 ports with 2 removable, self powered
uhci1: <Intel 82801EB (ICH5) USB controller USB-B> port 0xd000-0xd01f irq
19 at device 29.1 on pci0
uhci1: [GIANT-LOCKED]
usb1: <Intel 82801EB (ICH5) USB controller USB-B> on uhci1
usb1: USB revision 1.0
uhub1: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1: 2 ports with 2 removable, self powered
uhci2: <Intel 82801EB (ICH5) USB controller USB-C> port 0xd400-0xd41f irq
18 at device 29.2 on pci0
uhci2: [GIANT-LOCKED]
usb2: <Intel 82801EB (ICH5) USB controller USB-C> on uhci2
usb2: USB revision 1.0
uhub2: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub2: 2 ports with 2 removable, self powered
uhci3: <Intel 82801EB (ICH5) USB controller USB-D> port 0xd800-0xd81f irq
16 at device 29.3 on pci0
uhci3: [GIANT-LOCKED]
usb3: <Intel 82801EB (ICH5) USB controller USB-D> on uhci3
usb3: USB revision 1.0
uhub3: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub3: 2 ports with 2 removable, self powered
ehci0: <Intel 82801EB/R (ICH5) USB 2.0 controller> mem
0xfe100000-0xfe1003ff irq 23 at device 29.7 on pci0
ehci0: [GIANT-LOCKED]
usb4: waiting for BIOS to give up control
usb4: timed out waiting for BIOS
usb4: EHCI version 1.0
usb4: companion controllers, 2 ports each: usb0 usb1 usb2 usb3
usb4: <Intel 82801EB/R (ICH5) USB 2.0 controller> on ehci0
usb4: USB revision 2.0
uhub4: Intel EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
uhub4: 8 ports with 8 removable, self powered
pcib2: <ACPI PCI-PCI bridge> at device 30.0 on pci0
pci2: <ACPI PCI bus> on pcib2
atapci0: <Promise PDC20268 UDMA100 controller> port
0xbc00-0xbc07,0xb800-0xb803,0xb400-0xb407,0xb000-0xb003,0xac00-0xac0f mem
0xfe020000-0xfe023fff irq 22 at device 1.0 on pci2
ata2: <ATA channel 0> on atapci0
ata3: <ATA channel 1> on atapci0
ahc0: <Adaptec 2940 SCSI adapter> port 0xa800-0xa8ff mem
0xfe024000-0xfe024fff irq 17 at device 2.0 on pci2
ahc0: [GIANT-LOCKED]
aic7870: Single Channel A, SCSI Id=7, 16/253 SCBs
fxp0: <Intel 82801BA (D865) Pro/100 VE Ethernet> port 0xa400-0xa43f mem
0xfe025000-0xfe025fff irq 20 at device 8.0 on pci2
miibus0: <MII bus> on fxp0
inphy0: <i82562ET 10/100 media interface> on miibus0
inphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
fxp0: Ethernet address: 00:0c:f1:91:5e:b8
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
atapci1: <Intel ICH5 UDMA100 controller> port
0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xffa0-0xffaf at device 31.1 on pci0
ata0: <ATA channel 0> on atapci1
ata1: <ATA channel 1> on atapci1
atapci2: <Intel ICH5 SATA150 controller> port
0xec00-0xec07,0xe800-0xe803,0xe400-0xe407,0xe000-0xe003,0xdc00-0xdc0f irq 18 at
device 31.2 on pci0
ata4: <ATA channel 0> on atapci2
ata5: <ATA channel 1> on atapci2
pci0: <serial bus, SMBus> at device 31.3 (no driver attached)
pcm0: <Intel ICH5 (82801EB)> mem
0xfe100400-0xfe1005ff,0xfe100800-0xfe1008ff irq 17 at device 31.5 on pci0
pcm0: primary codec not ready!
pcm0: <Analog Devices AD1985 AC97 Codec>
acpi_button0: <Sleep Button> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: [GIANT-LOCKED]
psm0: model IntelliMouse, device ID 3
fdc0: <floppy drive controller> port
0x3f0-0x3f1,0x3f2-0x3f3,0x3f4-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: [FAST]
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
pmtimer0 on isa0
orm0: <ISA Option ROMs> at iomem 0xd0000-0xd27ff,0xd2800-0xd2fff on isa0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Timecounter "TSC" frequency 2394168828 Hz quality 800
Timecounters tick every 1.000 msec
Waiting 5 seconds for SCSI devices to settle
ad0: 38166MB <WDC WD400JB-00ENA0 05.03E05> at ata0-master UDMA100
ad1: 38166MB <WDC WD400JB-00ETA0 77.07W77> at ata0-slave UDMA100
acd0: DVDR <SONY DVD RW DRU-810A/1.0a> at ata1-master UDMA33
acd1: CDRW <PHILIPS CDRW4012P/P1.1> at ata1-slave UDMA33
ad4: 114473MB <Seagate ST3120026A 8.01> at ata2-master UDMA100
ad5: 114473MB <Seagate ST3120814A 2AAA> at ata2-slave UDMA100
da0 at ahc0 bus 0 target 5 lun 0
da0: <iomega jaz 2GB E.17> Removable Direct Access SCSI-2 device
da0: 10.000MB/s transfers (10.000MHz, offset 15)
da0: Attempt to query device size failed: NOT READY, Medium not present
(da0:ahc0:0:5:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ahc0:0:5:0): CAM Status: SCSI Status Error
(da0:ahc0:0:5:0): SCSI Status: Check Condition
(da0:ahc0:0:5:0): NOT READY asc:3a,0
(da0:ahc0:0:5:0): Medium not present
(da0:ahc0:0:5:0): Unretryable error
Opened disk da0 -> 6
(da0:ahc0:0:5:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ahc0:0:5:0): CAM Status: SCSI Status Error
(da0:ahc0:0:5:0): SCSI Status: Check Condition
(da0:ahc0:0:5:0): NOT READY asc:3a,0
(da0:ahc0:0:5:0): Medium not present
(da0:ahc0:0:5:0): Unretryable error
Opened disk da0 -> 6
(da0:ahc0:0:5:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ahc0:0:5:0): CAM Status: SCSI Status Error
(da0:ahc0:0:5:0): SCSI Status: Check Condition
(da0:ahc0:0:5:0): NOT READY asc:3a,0
(da0:ahc0:0:5:0): Medium not present
(da0:ahc0:0:5:0): Unretryable error
Opened disk da0 -> 6
Trying to mount root from ufs:/dev/ad1s1a
WARNING: / was not properly dismounted
WARNING: /tmp was not properly dismounted
WARNING: /usr was not properly dismounted
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
cd0 at ata1 bus 0 target 0 lun 0
cd0: <SONY DVD RW DRU-810A 1.0a> Removable CD-ROM SCSI-0 device
cd0: 33.000MB/s transfers
cd0: Attempt to query device size failed: NOT READY, Medium not present
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error
(probe8:ata1:0:1:0): INQUIRY. CDB: 12 0 0 0 24 0
(probe8:ata1:0:1:0): CAM Status: SCSI Status Error
(probe8:ata1:0:1:0): SCSI Status: Check Condition
(probe8:ata1:0:1:0): ILLEGAL REQUEST asc:20,0
(probe8:ata1:0:1:0): Invalid command operation code
(probe8:ata1:0:1:0): Unretryable error