Date: Sat, 5 Jan 2008 23:00:08 GMT From: Maslan <maslanbsd@gmail.com> To: freebsd-gnats-submit@FreeBSD.org Subject: kern/119374: ATAPI or ATAPICAM bug Message-ID: <200801052300.m05N08as087728@www.freebsd.org> Resent-Message-ID: <200801052310.m05NA2JZ027606@freefall.freebsd.org>
next in thread | raw e-mail | index | archive | help
>Number: 119374 >Category: kern >Synopsis: ATAPI or ATAPICAM bug >Confidential: no >Severity: critical >Priority: high >Responsible: freebsd-bugs >State: open >Quarter: >Keywords: >Date-Required: >Class: sw-bug >Submitter-Id: current-users >Arrival-Date: Sat Jan 05 23:10:01 UTC 2008 >Closed-Date: >Last-Modified: >Originator: Maslan >Release: FreeBSD-7.0 Beta4 >Organization: >Environment: FreeBSD laptop.asmlab 7.0-BETA4 FreeBSD 7.0-BETA4 #0: Sun Dec 2 19:19:04 UTC 2007 root@logan.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC i386 >Description: After updating from 7.0-BETA3 to 7.0-BETA4, it seems there is a bug in the ATAPI or ATAPICAM driver. When burning a CD-R using cdrecord i got: #cdrecord -v dev=2,0,0 7.0-RC1-i386-disc2.iso cdrecord: No write mode specified. cdrecord: Asuming -tao mode. cdrecord: Future versions of cdrecord may have different drive dependent defaults. cdrecord: Continuing in 5 seconds... Cdrecord-Clone 2.01 (i386-unknown-freebsd7.0) Copyright (C) 1995-2004 J�rg Schilling TOC Type: 1 = CD-ROM scsidev: '2,0,0' scsibus: 2 target: 0 lun: 0 Using libscg version 'schily-0.8'. SCSI buffer size: 64512 atapi: 0 Device type : Removable CD-ROM Version : 0 Response Format: 2 Capabilities : Vendor_info : 'MATSHITA' Identifikation : 'DVD-RAM UJ-850S ' Revision : '1.05' Device seems to be: Generic mmc2 DVD-R/DVD-RW. Current: 0x0009 Profile: 0x0012 Profile: 0x002B Profile: 0x001B Profile: 0x001A Profile: 0x0016 Profile: 0x0015 Profile: 0x0013 Profile: 0x0014 Profile: 0x0011 Profile: 0x0010 Profile: 0x000A Profile: 0x0009 (current) Profile: 0x0008 Profile: 0x0002 cdrecord: This version of cdrecord does not include DVD-R/DVD-RW support code. cdrecord: If you need DVD-R/DVD-RW support, ask the Author for cdrecord-ProDVD. cdrecord: Free test versions and free keys for personal use are at ftp://ftp.berlios.de/pub/cdrecord/ProDVD/ Using generic SCSI-3/mmc CD-R/CD-RW driver (mmc_cdr). Driver flags : MMC-3 SWABAUDIO BURNFREE Supported modes: TAO PACKET SAO Drive buf size : 1310720 = 1280 KB FIFO size : 4194304 = 4096 KB Track 01: data 694 MB Total size: 797 MB (79:02.34) = 355676 sectors Lout start: 798 MB (79:04/26) = 355676 sectors Current Secsize: 2048 ATIP info from disk: Indicated writing power: 5 Is not unrestricted Is not erasable Disk sub type: Medium Type B, low Beta category (B-) (4) ATIP start of lead in: -11607 (97:27/18) ATIP start of lead out: 359849 (79:59/74) Disk type: Short strategy type (Phthalocyanine or similar) Manuf. index: 18 Manufacturer: Plasmon Data systems Ltd. Blocks total: 359849 Blocks current: 359849 Blocks remaining: 4173 Starting to write CD/DVD at speed 24 in real TAO mode for single session. Last chance to quit, starting real write 0 seconds. Operation starts. Waiting for reader process to fill input buffer ... input buffer ready. BURN-Free is OFF. Performing OPC... Starting new track at sector: 0 Track 01: 611 of 694 MB written (fifo 100%) [buf 97%] 16.1x.cdrecord: Input/output error. write_g1: scsi sendcmd: retryable error CDB: 2A 00 00 04 C6 14 00 00 1F 00 status: 0x2 (CHECK CONDITION) Sense Bytes: F1 00 03 00 04 C3 A1 0A 00 2B 00 00 0C 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 Sense Key: 0x3 Medium Error, deferred error, Segment 0 Sense Code: 0x0C Qual 0x00 (write error) Fru 0x0 Sense flags: Blk 312225 (valid) cmd finished after 6.224s timeout 40s write track data: error after 640720896 bytes cdrecord: A write error occured. cdrecord: Please properly read the error message above. Writing time: 318.593s Average write speed 15.1x. Min drive buffer fill was 83% Fixating... I always find a lot of error messages in dmesg like that: acd0: FAILURE - WRITE_BIG MEDIUM ERROR asc=0x0c ascq=0x00 Here is a full dmesg: Copyright (c) 1992-2007 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 7.0-BETA4 #0: Sun Dec 2 19:19:04 UTC 2007 root@logan.cse.buffalo.edu:/usr/obj/usr/src/sys/GENERIC Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: Intel(R) Core(TM) Duo CPU T2250 @ 1.73GHz (1729.53-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x6ec Stepping = 12 Features=0xbfe9fbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE> Features2=0xc189<SSE3,MON,EST,TM2,xTPR,PDCM> AMD Features=0x100000<NX> Cores per package: 2 real memory = 1063714816 (1014 MB) avail memory = 1027284992 (979 MB) ACPI APIC Table: <HP 30BB > FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 1 ioapic0: Changing APIC ID to 1 ioapic0 <Version 2.0> irqs 0-23 on motherboard kbd1 at kbdmux0 ath_hal: 0.9.20.3 (AR5210, AR5211, AR5212, RF5111, RF5112, RF2413, RF5413) acpi0: <HPQOEM SLIC-MPC> on motherboard acpi0: [ITHREAD] acpi0: Power Button (fixed) Timecounter "HPET" frequency 14318180 Hz quality 900 Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1008-0x100b on acpi0 acpi_ec0: <Embedded Controller: GPE 0x17> port 0x62,0x66 on acpi0 cpu0: <ACPI CPU> on acpi0 est0: <Enhanced SpeedStep Frequency Control> on cpu0 p4tcc0: <CPU Frequency Thermal Control> on cpu0 cpu1: <ACPI CPU> on acpi0 est1: <Enhanced SpeedStep Frequency Control> on cpu1 p4tcc1: <CPU Frequency Thermal Control> on cpu1 acpi_button0: <Power Button> on acpi0 acpi_button1: <Sleep Button> on acpi0 acpi_acad0: <AC Adapter> on acpi0 battery0: <ACPI Control Method Battery> on acpi0 acpi_lid0: <Control Method Lid Switch> on acpi0 pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0 pci0: <ACPI PCI bus> on pcib0 vgapci0: <VGA-compatible display> port 0x1800-0x1807 mem 0xd8100000-0xd817ffff,0xc0000000-0xcfffffff,0xd8200000-0xd823ffff irq 16 at device 2.0 on pci0 agp0: <Intel 82945GM (945GM GMCH) SVGA controller> on vgapci0 agp0: detected 7932k stolen memory agp0: aperture size is 256M vgapci1: <VGA-compatible display> mem 0xd8180000-0xd81fffff at device 2.1 on pci0 pcm0: <Intel 82801G High Definition Audio Controller> mem 0xd8240000-0xd8243fff irq 22 at device 27.0 on pci0 pcm0: [ITHREAD] pcib1: <ACPI PCI-PCI bridge> irq 17 at device 28.0 on pci0 pci2: <ACPI PCI bus> on pcib1 pci2: <network> at device 0.0 (no driver attached) pcib2: <ACPI PCI-PCI bridge> irq 16 at device 28.1 on pci0 pci3: <ACPI PCI bus> on pcib2 uhci0: <UHCI (generic) USB controller> port 0x1820-0x183f irq 23 at device 29.0 on pci0 uhci0: [GIANT-LOCKED] uhci0: [ITHREAD] usb0: <UHCI (generic) USB controller> on uhci0 usb0: USB revision 1.0 uhub0: <Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb0 uhub0: 2 ports with 2 removable, self powered uhci1: <UHCI (generic) USB controller> port 0x1840-0x185f irq 19 at device 29.1 on pci0 uhci1: [GIANT-LOCKED] uhci1: [ITHREAD] usb1: <UHCI (generic) USB controller> on uhci1 usb1: USB revision 1.0 uhub1: <Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb1 uhub1: 2 ports with 2 removable, self powered uhci2: <UHCI (generic) USB controller> port 0x1860-0x187f irq 18 at device 29.2 on pci0 uhci2: [GIANT-LOCKED] uhci2: [ITHREAD] usb2: <UHCI (generic) USB controller> on uhci2 usb2: USB revision 1.0 uhub2: <Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb2 uhub2: 2 ports with 2 removable, self powered uhci3: <UHCI (generic) USB controller> port 0x1880-0x189f irq 16 at device 29.3 on pci0 uhci3: [GIANT-LOCKED] uhci3: [ITHREAD] usb3: <UHCI (generic) USB controller> on uhci3 usb3: USB revision 1.0 uhub3: <Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1> on usb3 uhub3: 2 ports with 2 removable, self powered ehci0: <Intel 82801GB/R (ICH7) USB 2.0 controller> mem 0xd8444000-0xd84443ff irq 23 at device 29.7 on pci0 ehci0: [GIANT-LOCKED] ehci0: [ITHREAD] usb4: EHCI version 1.0 usb4: companion controllers, 2 ports each: usb0 usb1 usb2 usb3 usb4: <Intel 82801GB/R (ICH7) 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> on usb4 uhub4: 8 ports with 8 removable, self powered ugen0: <vendor 0x05ca product 0x1810, class 239/2, rev 2.00/1.00, addr 2> on uhub4 pcib3: <ACPI PCI-PCI bridge> at device 30.0 on pci0 pci5: <ACPI PCI bus> on pcib3 fwohci0: <1394 Open Host Controller Interface> mem 0xd8001000-0xd80017ff irq 16 at device 5.0 on pci5 fwohci0: [FILTER] fwohci0: OHCI version 1.10 (ROM=0) fwohci0: No. of Isochronous channels is 4. fwohci0: EUI64 00:24:1b:00:22:79:01:00 fwohci0: Phy 1394a available S400, 1 ports. fwohci0: Link S400, max_rec 2048 bytes. firewire0: <IEEE1394(FireWire) bus> on fwohci0 fwe0: <Ethernet over FireWire> on firewire0 if_fwe0: Fake Ethernet address: 02:24:1b:79:01:00 fwe0: Ethernet address: 02:24:1b:79:01:00 fwip0: <IP over FireWire> on firewire0 fwip0: Firewire address: 00:24:1b:00:22:79:01:00 @ 0xfffe00000000, S400, maxrec 2048 sbp0: <SBP-2/SCSI over FireWire> on firewire0 dcons_crom0: <dcons configuration ROM> on firewire0 dcons_crom0: bus_addr 0x1550000 fwohci0: Initiate bus reset fwohci0: BUS reset fwohci0: node_id=0xc800ffc0, gen=1, CYCLEMASTER mode pci5: <base peripheral> at device 5.1 (no driver attached) pci5: <base peripheral> at device 5.2 (no driver attached) pci5: <base peripheral> at device 5.3 (no driver attached) pci5: <base peripheral> at device 5.4 (no driver attached) fxp0: <Intel Pro/100 VE Network Connection> port 0x4000-0x403f mem 0xd8000000-0xd8000fff irq 20 at device 8.0 on pci5 miibus0: <MII bus> on fxp0 inphy0: <i82562ET 10/100 media interface> PHY 1 on miibus0 inphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto fxp0: Ethernet address: 00:1b:24:01:d2:3a fxp0: [ITHREAD] isab0: <PCI-ISA bridge> at device 31.0 on pci0 isa0: <ISA bus> on isab0 atapci0: <Intel ICH7M SATA300 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x18b0-0x18bf at device 31.2 on pci0 ata0: <ATA channel 0> on atapci0 ata0: [ITHREAD] ata1: <ATA channel 1> on atapci0 ata1: [ITHREAD] pci0: <serial bus, SMBus> at device 31.3 (no driver attached) acpi_tz0: <Thermal Zone> 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] atkbd0: [ITHREAD] psm0: <PS/2 Mouse> irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model IntelliMouse, device ID 3 pmtimer0 on isa0 orm0: <ISA Option ROMs> at iomem 0xce800-0xcffff,0xdf000-0xdf7ff,0xe0000-0xe17ff pnpid ORM0000 on isa0 ppc0: parallel port not found. sc0: <System console> at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> sio0: configured irq 4 not in bitmap of probed irqs 0 sio0: port may not be enabled sio0: configured irq 4 not in bitmap of probed irqs 0 sio0: port may not be enabled sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0 sio0: type 8250 or not responding sio0: [FILTER] sio1: configured irq 3 not in bitmap of probed irqs 0 sio1: port may not be enabled vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ugen1: <Broadcom Corp HP Integrated Module, class 224/1, rev 2.00/1.00, addr 2> on uhub2 Timecounters tick every 1.000 msec firewire0: 1 nodes, maxhop <= 0, cable IRM = 0 (me) firewire0: bus manager 0 (me) ad0: 114473MB <FUJITSU MHV2120BH PL 892C> at ata0-master SATA150 acd0: DVDR <MATSHITADVD-RAM UJ-850S/1.05> at ata1-master PIO4 pcm0: <HDA Codec: Conexant Venice> pcm0: <HDA Driver Revision: 20071129_0050> GEOM_LABEL: Label for provider ad0s1 is ntfs/WinXP. GEOM_LABEL: Label for provider ad0s5 is msdosfs/MOVIES. GEOM_LABEL: Label for provider ad0s6 is msdosfs/ . GEOM_LABEL: Label for provider ad0s7 is msdosfs/SHARE. GEOM_LABEL: Label for provider ad0s8 is ext2fs/Linux. acd0: FAILURE - INQUIRY ILLEGAL REQUEST asc=0x24 ascq=0x00 cd0 at ata1 bus 0 target 0 lun 0 cd0: <MATSHITA DVD-RAM UJ-850S 1.05> Removable CD-ROM SCSI-0 device cd0: 16.000MB/s transfers cd0: Attempt to query device size failed: NOT READY, Medium not present SMP: AP CPU #1 Launched! Trying to mount root from ufs:/dev/ad0s3a GEOM_LABEL: Label msdosfs/MOVIES removed. GEOM_LABEL: Label msdosfs/ removed. GEOM_LABEL: Label msdosfs/SHARE removed. fuse4bsd: version 0.3.9-pre1, FUSE ABI 7.8 drm0: <Intel i945GM> on vgapci0 info: [drm] AGP at 0xc0000000 256MB info: [drm] Initialized i915 1.5.0 20060119 drm0: [ITHREAD] acd0: FAILURE - READ_TOC ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - unknown CMD (0x03) ILLEGAL REQUEST asc=0x24 ascq=0x00 GEOM_LABEL: Label for provider acd0t01 is iso9660/ . acd0: FAILURE - READ_DVD_STRUCTURE ILLEGAL REQUEST asc=0x30 ascq=0x02 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - READ_BUFFER ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - START_STOP ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - READ_TOC ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - WRITE_BIG MEDIUM ERROR asc=0x0c ascq=0x00 acd0: FAILURE - READ_DVD_STRUCTURE ILLEGAL REQUEST asc=0x30 ascq=0x02 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - READ_BUFFER ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - START_STOP ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - READ_TOC ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - START_STOP ILLEGAL REQUEST asc=0x24 ascq=0x00 (cd0:ata1:0:0:0): STOP START UNIT. CDB: 1b 0 0 0 3 0 (cd0:ata1:0:0:0): CAM Status: SCSI Status Error (cd0:ata1:0:0:0): SCSI Status: Check Condition (cd0:ata1:0:0:0): ILLEGAL REQUEST asc:24,0 (cd0:ata1:0:0:0): Invalid field in CDB (cd0:ata1:0:0:0): Unretryable error acd0: FAILURE - START_STOP ILLEGAL REQUEST asc=0x24 ascq=0x00 (cd0:ata1:0:0:0): STOP START UNIT. CDB: 1b 0 0 0 3 0 (cd0:ata1:0:0:0): CAM Status: SCSI Status Error (cd0:ata1:0:0:0): SCSI Status: Check Condition (cd0:ata1:0:0:0): ILLEGAL REQUEST asc:24,0 (cd0:ata1:0:0:0): Invalid field in CDB (cd0:ata1:0:0:0): Unretryable error acd0: FAILURE - READ_BIG ILLEGAL REQUEST asc=0x64 ascq=0x00 (cd0:ata1:0:0:0): READ(10). CDB: 28 0 0 3 fb 96 0 0 2 0 (cd0:ata1:0:0:0): CAM Status: SCSI Status Error (cd0:ata1:0:0:0): SCSI Status: Check Condition (cd0:ata1:0:0:0): ILLEGAL REQUEST csi:0,1d,0,0 asc:64,0 (cd0:ata1:0:0:0): Illegal mode for this track (cd0:ata1:0:0:0): Unretryable error (cd0:ata1:0:0:0): cddone: got error 0x6 back acd0: FAILURE - READ_DVD_STRUCTURE ILLEGAL REQUEST asc=0x30 ascq=0x02 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - MODE_SELECT_BIG ILLEGAL REQUEST asc=0x26 ascq=0x00 acd0: FAILURE - READ_BUFFER ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - START_STOP ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - READ_TOC ILLEGAL REQUEST asc=0x24 ascq=0x00 acd0: FAILURE - WRITE_BIG MEDIUM ERROR asc=0x0c ascq=0x00 >How-To-Repeat: >Fix: >Release-Note: >Audit-Trail: >Unformatted:
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?200801052300.m05N08as087728>