kern/73850: atapicam and Zip drive causes reboots upon write to /dev/pass0

[Joe Morris]

>Number:         73850
>Category:       kern
>Synopsis:       atapicam and Zip drive causes reboots upon write to /dev/pass0
>Confidential:   no
>Severity:       serious
>Priority:       high
>Responsible:    freebsd-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Fri Nov 12 03:30:22 GMT 2004
>Closed-Date:
>Last-Modified:
>Originator:     Joe Morris
>Release:        5.3
>Organization:
>Environment:
FreeBSD JoesBSDBox 5.3-RELEASE FreeBSD 5.3-RELEASE #1: Wed Nov 10 22:53:39 EST 2004     joe at JoesBSDBox:/usr/obj/usr/src/sys/JOESBSDBOX  i386
>Description:
      I use atapicam so that I can use my Sony CD burner with cdrecord. However, atapicam also attaches itself to my ATAPI Zip100 drive. All seems well until I start k3b to start burning CDs. When k3b starts "scanning for devices", the system locks, and then reboots (without going through the normal shutdown-procedure, just a hard reset). When disabling write support to /dev/pass0 (the Zip100's passthrough-device), k3b continues normally and detects my CD-Writer just fine. So, k3b must be writing to /dev/pass0, and somehow causing the system to reboot. My ATA devices are as follows: hard disk on primary master, zip drive on primary slave, DVD-ROM on secondary master, CD writer on secondary slave. I think this may be an issue with atapicam and the way it is handling commands with my Zip drive. I'll post my dmesg below. If you guys need anything more, just let me know! Thanks guys!

Joe

Copyright (c) 1992-2004 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 5.3-RELEASE #1: Wed Nov 10 22:53:39 EST 2004
    joe at JoesBSDBox:/usr/obj/usr/src/sys/JOESBSDBOX
Timecounter "i8254" frequency 1193182 Hz quality 0
CPU: AMD Athlon(tm) XP 2200+ (1799.80-MHz 686-class CPU)
  Origin = "AuthenticAMD"  Id = 0x680  Stepping = 0
  Features=0x383f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
  AMD Features=0xc0400000<AMIE,DSP,3DNow!>
real memory  = 536805376 (511 MB)
avail memory = 515620864 (491 MB)
npx0: [FAST]
npx0: <math processor> on motherboard
npx0: INT 16 interface
acpi0: <VIA694 AWRDACPI> on motherboard
acpi0: Power Button (fixed)
Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x4008-0x400b on acpi0
cpu0: <ACPI CPU (3 Cx states)> on acpi0
acpi_tz0: <Thermal Zone> on acpi0
acpi_button0: <Power Button> on acpi0
acpi_button1: <Sleep Button> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0x5000-0x500f,0x4080-0x40ff,0x4000-0x407f,0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <PCI-PCI bridge> at device 1.0 on pci0
pci1: <PCI bus> on pcib1
pci1: <display, VGA> at device 0.0 (no driver attached)
rl0: <D-Link DFE-530TX+ 10/100BaseTX> port 0xd000-0xd0ff mem 0xe6000000-0xe60000ff irq 10 at device 10.0 on pci0
miibus0: <MII bus> on rl0
rlphy0: <RealTek internal media interface> on miibus0
rlphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
rl0: Ethernet address: 00:0d:88:3d:6a:bc
rl1: <RealTek 8139 10/100BaseTX> port 0xd400-0xd4ff mem 0xe6001000-0xe60010ff irq 11 at device 13.0 on pci0
miibus1: <MII bus> on rl1
rlphy1: <RealTek internal media interface> on miibus1
rlphy1:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
rl1: Ethernet address: 00:50:2c:03:8f:2b
uhci0: <VIA 83C572 USB controller> port 0xd800-0xd81f irq 5 at device 14.0 on pci0
uhci0: [GIANT-LOCKED]
usb0: <VIA 83C572 USB controller> on uhci0
usb0: USB revision 1.0
uhub0: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 2 ports with 2 removable, self powered
uhci1: <VIA 83C572 USB controller> port 0xdc00-0xdc1f irq 10 at device14.1 on pci0
uhci1: [GIANT-LOCKED]
usb1: <VIA 83C572 USB controller> on uhci1
usb1: USB revision 1.0
uhub1: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub1: 2 ports with 2 removable, self powered
pci0: <serial bus, USB> at device 14.2 (no driver attached)
pcm0: <CMedia CMI8738> port 0xe000-0xe0ff irq 12 at device 16.0 on pci0
isab0: <PCI-ISA bridge> at device 17.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <VIA 8233A UDMA133 controller> port 0xe400-0xe40f,0x376,0x170-0x177,0x3f6,0x1f0-0x1f7 at device 17.1 on pci0
ata0: channel #0 on atapci0
ata1: channel #1 on atapci0
uhci2: <VIA 83C572 USB controller> port 0xe800-0xe81f irq 12 at device17.2 on pci0
uhci2: [GIANT-LOCKED]
usb2: <VIA 83C572 USB controller> on uhci2
usb2: USB revision 1.0
uhub2: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub2: 2 ports with 2 removable, self powered
ums0: Logitech USB Mouse, rev 1.10/6.b4, addr 2, iclass 3/1
ums0: 3 buttons and Z dir.
uhci3: <VIA 83C572 USB controller> port 0xec00-0xec1f irq 12 at device17.3 on pci0
uhci3: [GIANT-LOCKED]
usb3: <VIA 83C572 USB controller> on uhci3
usb3: USB revision 1.0
uhub3: VIA UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub3: 2 ports with 2 removable, self powered
fdc0: <floppy drive controller> port 0x3f7,0x3f0-0x3f5 irq 6 drq 2 on acpi0
fdc0: [FAST]
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
sio0: <16550A-compatible COM port> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
sio0: type 16550A
sio1: <16550A-compatible COM port> port 0x2f8-0x2ff irq 3 on acpi0
sio1: type 16550A
ppc0: <Standard parallel printer port> port 0x378-0x37f irq 7 on acpi0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
ppbus0: <Parallel port bus> on ppc0
plip0: <PLIP network interface> on ppbus0
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
atkbdc0: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
orm0: <ISA Option ROM> at iomem 0xd0000-0xd3fff on isa0
pmtimer0 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 1799803253 Hz quality 800
Timecounters tick every 10.000 msec
ata0-slave: FAILURE - SETFEATURES SET TRANSFER MODE status=1<ERROR> error=4<ABORTED>
ad0: 58644MB <Maxtor 5T060H6/TAH71DP0> [119150/16/63] at ata0-master UDMA100
afd0: REMOVABLE <IOMEGA ZIP 100 ATAPI/14.A> at ata0-slave BIOSPIO
acd0: DVDROM <TOSHIBA DVD-ROM SD-M1212/1R14> at ata1-master UDMA33
acd1: CDRW <SONY CD-RW CRX215E1/SYS2> at ata1-slave UDMA33
cd0 at ata1 bus 0 target 0 lun 0
cd0: <TOSHIBA DVD-ROM SD-M1212 1R14> Removable CD-ROM SCSI-0 device
cd0: 33.000MB/s transfers
cd0: Attempt to query device size failed: NOT READY, Medium not present
da0 at ata0 bus 0 target 1 lun 0
da0: <IOMEGA ZIP 100 14.A> Removable Direct Access SCSI-0 device
da0: 3.300MB/s transfers
da0: Attempt to query device size failed: NOT READY, Medium not present
cd1 at ata1 bus 0 target 1 lun 0
cd1: <SONY CD-RW  CRX215E1 SYS2> Removable CD-ROM SCSI-0 device
cd1: 33.000MB/s transfers
cd1: Attempt to query device size failed: NOT READY, Medium not present
(da0:ata0:0:1:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ata0:0:1:0): CAM Status: SCSI Status Error
(da0:ata0:0:1:0): SCSI Status: Check Condition
(da0:ata0:0:1:0): NOT READY asc:3a,0
(da0:ata0:0:1:0): Medium not present
(da0:ata0:0:1:0): Unretryable error
Opened disk da0 -> 6
(da0:ata0:0:1:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ata0:0:1:0): CAM Status: SCSI Status Error
(da0:ata0:0:1:0): SCSI Status: Check Condition
(da0:ata0:0:1:0): NOT READY asc:3a,0
(da0:ata0:0:1:0): Medium not present
(da0:ata0:0:1:0): Unretryable error
Opened disk da0 -> 6
(da0:ata0:0:1:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ata0:0:1:0): CAM Status: SCSI Status Error
(da0:ata0:0:1:0): SCSI Status: Check Condition
(da0:ata0:0:1:0): NOT READY asc:3a,0
(da0:ata0:0:1:0): Medium not present
(da0:ata0:0:1:0): Unretryable error
Opened disk da0 -> 6
Mounting root from ufs:/dev/ad0s2a
WARNING: / was not properly dismounted
WARNING: /home was not properly dismounted
/home: mount pending error: blocks 160 files 12
/home: superblock summary recomputed
WARNING: /tmp was not properly dismounted
/tmp: mount pending error: blocks 8 files 3
/tmp: superblock summary recomputed
WARNING: /usr was not properly dismounted
/usr: mount pending error: blocks 16 files 1
WARNING: /var was not properly dismounted
/var: mount pending error: blocks 192 files 17
pid 555 (xfce-mcs-manager), uid 1001: exited on signal 11 (core dumped)
pid 560 (xfce-mcs-manager), uid 1001: exited on signal 11 (core dumped)
pid 566 (xfce-mcs-manager), uid 1001: exited on signal 11 (core dumped)
pid 567 (xfce-mcs-manager), uid 1001: exited on signal 11 (core dumped)
(da0:ata0:0:1:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0
(da0:ata0:0:1:0): CAM Status: SCSI Status Error
(da0:ata0:0:1:0): SCSI Status: Check Condition
(da0:ata0:0:1:0): UNIT ATTENTION asc:28,0
(da0:ata0:0:1:0): Not ready to ready change, medium may have changed
(da0:ata0:0:1:0): Retrying Command (per Sense Data)
nvidia0: <GeForce FX 5600> mem 0xd0000000-0xdfffffff,0xe4000000-0xe4ffffff irq 11 at device 0.0 on pci1
nvidia0: [GIANT-LOCKED]
>How-To-Repeat:
      Use an ATAPI Zip100 drive with atapicam, and start k3b with write permission to /dev/passX.
>Fix:
No fix, just avoid setting write permission to the pass-through device associated with the Zip drive.
>Release-Note:
>Audit-Trail:
>Unformatted: