[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

Re: i386/3548: ahc scsi errors when copying from cd to hard disk

The following reply was made to PR i386/3548; it has been noted by GNATS.

From: Marco Peereboom <slash_(_at_)_peereboom_(_dot_)_us>
To: drew_(_at_)_technteach_(_dot_)_com, gnats_(_at_)_openbsd_(_dot_)_org
Cc:  
Subject: Re: i386/3548: ahc scsi errors when copying from cd to hard disk
Date: Sun, 2 Nov 2003 22:56:01 +0000

 There is some sort of issue with the ahc driver. Try moving the disk to target 
 1 and try again.
 
 On Sunday 02 November 2003 04:34 pm, drew_(_at_)_technteach_(_dot_)_com wrote:
 > >Number:         3548
 > >Category:       i386
 > >Synopsis:       ahc scsi errors when copying from cd to hard disk
 > >Confidential:   yes
 > >Severity:       serious
 > >Priority:       low
 > >Responsible:    bugs
 > >State:          open
 > >Quarter:
 > >Keywords:
 > >Date-Required:
 > >Class:          sw-bug
 > >Submitter-Id:   net
 > >Arrival-Date:   Sun Nov 02 16:50:02 GMT 2003
 > >Closed-Date:
 > >Last-Modified:
 > >Originator:     Drew Einhorn
 > >Release:        3.4
 > >Organization:
 >
 > net
 >
 > >Environment:
 >
 > 	System      : OpenBSD 3.4
 > 	Architecture: OpenBSD.i386
 > 	Machine     : i386
 >
 > >Description:
 >
 > 	ahc scsi errors when copying from cd to hard disk
 >
 > >How-To-Repeat:
 >
 > I'm having scsi problems on a elderly Dell box with the release 3.4.
 >
 > It has a pci scsi host adapter: aha-2940u/uw dual scsi bios v1.33s2,
 > a single scsi hard drive: seagate st39204lw,
 > and a scsi cd-rom: teac cd-532s.
 >
 > Booted the cd34.iso cd without a problem.  First sign of problems was
 > errors while loading the install sets from cd.  I thought maybe I blew it
 > creating the install sets cd.  So I did an ftp install instead.  That
 > worked without problems.
 >
 > Then I optimistically added a line to /etc/fstab:
 >
 >   /dev/cd0a /mnt cd9660 ro,nodev,nosuid 1 2
 >
 > The I did a: mount /mnt
 >
 > Then I tried to copy a largefile from an old official obsd cd1 to
 > hard disk.  Lots of scsi errors.  Copied the dmesg and errors from
 > /var/log/messages to another system.  Will include them at the end
 > of this note.
 >
 > Had been running 3.3 on this box.  Re installed 3.3. Saw similar problems,
 > guess I just never used the cd when i was running 3.3 on the box.
 >
 > Put Redhat 9 on the box and was able to copy from cd to hard disk.
 > So it is not a hardware problem.
 >
 > Here'e the 3.4 release dmesg:
 >
 > OpenBSD 3.4 (GENERIC) #18: Wed Sep 17 03:34:47 MDT 2003
 >     deraadt_(_at_)_i386_(_dot_)_openbsd_(_dot_)_org:/usr/src/sys/arch/i386/compile/GENERIC
 > cpu0: Intel Pentium II ("GenuineIntel" 686-class, 512KB L2 cache) 397 MHz
 > cpu0:
 > FPU,V86,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR
 > real mem  = 335126528 (327272K)
 > avail mem = 304189440 (297060K)
 > using 4116 buffers containing 16859136 bytes (16464K) of memory
 > mainbus0 (root)
 > bios0 at mainbus0: AT/286+(00) BIOS, date 07/12/00, BIOS32 rev. 0 @ 0xffe90
 > apm0 at bios0: Power Management spec V1.2
 > apm0: AC on, battery charge unknown
 > pcibios0 at bios0: rev. 2.1 @ 0xf0000/0x10000
 > pcibios0: PCI IRQ Routing Table rev. 1.0 @ 0xfc670/176 (9 entries)
 > pcibios0: PCI Interrupt Router at 000:07:0 ("Intel 82371AB PIIX4 ISA" rev
 > 0x00) pcibios0: PCI bus #2 is the last bus
 > bios0: ROM list: 0xc0000/0x8000 0xc8000/0x4800 0xd0000/0x8000
 > pci0 at mainbus0 bus 0: configuration mode 1 (no bios)
 > pchb0 at pci0 dev 0 function 0 "Intel 82443BX PCI-AGP" rev 0x02
 > ppb0 at pci0 dev 1 function 0 "Intel 82443BX AGP" rev 0x02
 > pci1 at ppb0 bus 1
 > vga1 at pci1 dev 0 function 0 "ATI Rage Pro" rev 0x5c
 > wsdisplay0 at vga1: console (80x25, vt100 emulation)
 > wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
 > pcib0 at pci0 dev 7 function 0 "Intel 82371AB PIIX4 ISA" rev 0x02
 > pciide0 at pci0 dev 7 function 1 "Intel 82371AB IDE" rev 0x01: DMA, channel
 > 0 wired to compatibility, channel 1 wired to compatibility pciide0: channel
 > 0 ignored (disabled)
 > pciide0: channel 1 ignored (disabled)
 > uhci0 at pci0 dev 7 function 2 "Intel 82371AB USB" rev 0x01: irq 14
 > usb0 at uhci0: USB revision 1.0
 > uhub0 at usb0
 > uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
 > uhub0: 2 ports with 2 removable, self powered
 > "Intel 82371AB Power Mgmt" rev 0x02 at pci0 dev 7 function 3 not configured
 > ahc1 at pci0 dev 13 function 0 "Adaptec AIC-7895" rev 0x03: irq 11
 > ahc1: aic7895: Ultra Wide Channel A, SCSI Id=7, 32/255 SCBs
 > scsibus0 at ahc1: 16 targets
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using tagged queuing
 > sd0 at scsibus0 targ 0 lun 0: <SEAGATE, ST39204LW, 0002> SCSI3 0/direct
 > fixed sd0: 8750MB, 14384 cyl, 3 head, 415 sec, 512 bytes/sec, 17921835 sec
 > total ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 0 using asynchronous transfers
 > ahc1: target 0 synchronous at 20.0MHz, offset = 0x8
 > ahc1: target 3 synchronous at 20.0MHz, offset = 0xf
 > cd0 at scsibus0 targ 3 lun 0: <TEAC, CD-ROM CD-532S, 1.0A> SCSI2 5/cdrom
 > removable ahc2 at pci0 dev 13 function 1 "Adaptec AIC-7895" rev 0x03: irq
 > 10 ahc2: aic7895: Ultra Single Channel B, SCSI Id=7, 32/255 SCBs
 > scsibus1 at ahc2: 8 targets
 > ppb1 at pci0 dev 15 function 0 "DEC 21152 PCI-PCI" rev 0x03
 > pci2 at ppb1 bus 2
 > xl0 at pci0 dev 17 function 0 "3Com 3c905B 100Base-TX" rev 0x24: irq 14
 > address 00:c0:4f:7b:20:75 exphy0 at xl0 phy 24: 3Com internal media
 > interface
 > isa0 at pcib0
 > isadma0 at isa0
 > pckbc0 at isa0 port 0x60/5
 > pckbd0 at pckbc0 (kbd slot)
 > pckbc0: using irq 1 for kbd slot
 > wskbd0 at pckbd0: console keyboard, using wsdisplay0
 > pms0 at pckbc0 (aux slot)
 > pckbc0: using irq 12 for aux slot
 > wsmouse0 at pms0 mux 0
 > pcppi0 at isa0 port 0x61
 > midi0 at pcppi0: <PC speaker>
 > sysbeep0 at pcppi0
 > lpt0 at isa0 port 0x378/4 irq 7
 > npx0 at isa0 port 0xf0/16: using exception 16
 > fdc0 at isa0 port 0x3f0/6 irq 6 drq 2
 > fd0 at fdc0 drive 0: 1.44MB 80 cyl, 2 head, 18 sec
 > biomask 4c40 netmask 4c40 ttymask 5cc2
 > pctr: 686-class user-level performance counters enabled
 > mtrr: Pentium Pro MTRR support
 > dkcsum: sd0 matched BIOS disk 80
 > root on sd0a
 > rootdev=0x400 rrootdev=0xd00 rawdev=0xd02
 > WARNING: / was not properly unmounted
 >
 >
 > And here's the start of the error messages from /var/log/messages:
 >
 >
 > Nov  1 16:35:55 hermes2 /bsd: ahc1:A:0: no active SCB for reconnecting
 > target - issuing BUS DEVICE RESET Nov  1 16:35:59 hermes2 /bsd:
 > SAVED_SCSIID == 0x07, SAVED_LUN == 0x0, ARG_1 == 0x4 ACCUM = 0x0 Nov  1
 > 16:35:59 hermes2 /bsd: SEQ_FLAGS == 0x10, SCBPTR == 0xb, BTT == 0x0, SINDEX
 > == 0x31 Nov  1 16:35:59 hermes2 /bsd: SCSIID == 0x37, SCB_SCSIID == 0x37,
 > SCB_LUN == 0x0, SCB_TAG == 0xff, SCB_CONTROL == 0x48 Nov  1 16:35:59
 > hermes2 /bsd: SCSIBUSL == 0x80, SCSISIGI == 0xe6
 > Nov  1 16:35:59 hermes2 /bsd: SXFRCTL0 == 0x88
 > Nov  1 16:35:59 hermes2 /bsd: SEQCTL == 0x10
 > Nov  1 16:35:59 hermes2 /bsd: ahc1: Dumping Card State in Message-in phase,
 > at SEQADDR 0x1c3 Nov  1 16:35:59 hermes2 /bsd: ACCUM = 0x0, SINDEX = 0x31,
 > DINDEX = 0xe4, ARG_2 = 0x1 Nov  1 16:35:59 hermes2 /bsd: HCNT = 0x0
 > Nov  1 16:35:59 hermes2 /bsd: SCSISEQ = 0x12, SBLKCTL = 0x2
 > Nov  1 16:35:59 hermes2 /bsd:  DFCNTRL = 0x0, DFSTATUS = 0x28
 > Nov  1 16:35:59 hermes2 /bsd: LASTPHASE = 0xe0, SCSISIGI = 0xe6, SXFRCTL0 =
 > 0x88 Nov  1 16:35:59 hermes2 /bsd: SSTAT0 = 0x7, SSTAT1 = 0x3
 > Nov  1 16:35:59 hermes2 /bsd: STACK == 0x197, 0x181, 0x0, 0x15d
 > Nov  1 16:35:59 hermes2 /bsd: SCB count = 16
 > Nov  1 16:35:59 hermes2 /bsd: Kernel NEXTQSCB = 0
 > Nov  1 16:35:59 hermes2 /bsd: Card NEXTQSCB = 4
 > Nov  1 16:35:59 hermes2 /bsd: QINFIFO entries: 4
 > Nov  1 16:35:59 hermes2 /bsd: Waiting Queue entries:
 > Nov  1 16:35:59 hermes2 /bsd: Disconnected Queue entries: 13:13
 > Nov  1 16:35:59 hermes2 /bsd: QOUTFIFO entries:
 > Nov  1 16:35:59 hermes2 /bsd: Sequencer Free SCB List: 11 5 1 14 12 10 9 8
 > 3 7 0 6 4 2 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 Nov  1
 > 16:35:59 hermes2 /bsd: Pending list: 4, 13
 > Nov  1 16:35:59 hermes2 /bsd: Kernel Free SCB list: 1 3 11 2 5 9 7 6 15 12
 > 10 8 14 Nov  1 16:35:59 hermes2 /bsd: Untagged Q(3): 4
 > Nov  1 16:35:59 hermes2 /bsd: FEATURES = 0x16035, FLAGS = 0x485148, CHIP =
 > 0x408 BUGS =0x35 Nov  1 16:35:59 hermes2 /bsd: ahc1: target 0 using
 > asynchronous transfers Nov  1 16:35:59 hermes2 /bsd: ahc1: Bus Device Reset
 > on A:0. 1 SCBs aborted Nov  1 16:35:59 hermes2 /bsd: ahc1: target 0
 > synchronous at 20.0MHz, offset = 0x8 Nov  1 16:35:59 hermes2 /bsd: ahc1:
 > target 0 using asynchronous transfers Nov  1 16:35:59 hermes2 /bsd: ahc1:
 > target 0 synchronous at 20.0MHz, offset = 0x8 Nov  1 16:35:59 hermes2 /bsd:
 > ahc1:A:0: no active SCB for reconnecting target - issuing BUS DEVICE RESET
 > Nov  1 16:35:59 hermes2 /bsd: SAVED_SCSIID == 0x07, SAVED_LUN == 0x0, ARG_1
 > == 0xb ACCUM = 0x0 Nov  1 16:35:59 hermes2 /bsd: SEQ_FLAGS == 0x10, SCBPTR
 > == 0x1, BTT == 0xb, SINDEX == 0x31 Nov  1 16:35:59 hermes2 /bsd: SCSIID ==
 > 0x37, SCB_SCSIID == 0x37, SCB_LUN == 0x0, SCB_TAG == 0xff, SCB_CONTROL ==
 > 0x48 Nov  1 16:35:59 hermes2 /bsd: SCSIBUSL == 0x80, SCSISIGI == 0xe6
 > Nov  1 16:35:59 hermes2 /bsd: SXFRCTL0 == 0x88
 > Nov  1 16:35:59 hermes2 /bsd: SEQCTL == 0x10
 > Nov  1 16:35:59 hermes2 /bsd: ahc1: Dumping Card State in Message-in phase,
 > at SEQADDR 0x1c3 Nov  1 16:35:59 hermes2 /bsd: ACCUM = 0x0, SINDEX = 0x31,
 > DINDEX = 0xe4, ARG_2 = 0x2 Nov  1 16:35:59 hermes2 /bsd: HCNT = 0x0
 > Nov  1 16:35:59 hermes2 /bsd: SCSISEQ = 0x12, SBLKCTL = 0x2
 > Nov  1 16:35:59 hermes2 /bsd:  DFCNTRL = 0x0, DFSTATUS = 0x28
 > Nov  1 16:35:59 hermes2 /bsd: LASTPHASE = 0xe0, SCSISIGI = 0xe6, SXFRCTL0 =
 > 0x88 Nov  1 16:35:59 hermes2 /bsd: SSTAT0 = 0x7, SSTAT1 = 0x3
 > Nov  1 16:35:59 hermes2 /bsd: STACK == 0x197, 0x181, 0xf8, 0x15d
 > Nov  1 16:35:59 hermes2 /bsd: SCB count = 16
 > Nov  1 16:35:59 hermes2 /bsd: Kernel NEXTQSCB = 11
 > Nov  1 16:35:59 hermes2 /bsd: Card NEXTQSCB = 11
 > Nov  1 16:35:59 hermes2 /bsd: QINFIFO entries:
 > Nov  1 16:35:59 hermes2 /bsd: Waiting Queue entries: 14:2
 > Nov  1 16:35:59 hermes2 /bsd: Disconnected Queue entries: 13:0
 > Nov  1 16:35:59 hermes2 /bsd: QOUTFIFO entries:
 > Nov  1 16:35:59 hermes2 /bsd: Sequencer Free SCB List: 1 5 11 12 10 9 8 3 7
 > 0 6 4 2 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 Nov  1 16:35:59
 > hermes2 /bsd: Pending list: 2, 0
 > Nov  1 16:35:59 hermes2 /bsd: Kernel Free SCB list: 4 3 13 5 1 9 7 6 15 12
 > 10 8 14 Nov  1 16:35:59 hermes2 /bsd: Untagged Q(3): 2
 > Nov  1 16:35:59 hermes2 /bsd: FEATURES = 0x16035, FLAGS = 0x485148, CHIP =
 > 0x408 BUGS =0x35 Nov  1 16:35:59 hermes2 /bsd: ahc1: target 0 using
 > asynchronous transfers Nov  1 16:36:00 hermes2 /bsd: ahc1: Bus Device Reset
 > on A:0. 1 SCBs aborted Nov  1 16:36:00 hermes2 /bsd: ahc1: target 0
 > synchronous at 20.0MHz, offset = 0x8 Nov  1 16:36:00 hermes2 /bsd:
 > ahc1:A:0: no active SCB for reconnecting target - issuing BUS DEVICE RESET
 > Nov  1 16:36:00 hermes2 /bsd: SAVED_SCSIID == 0x07, SAVED_LUN == 0x0, ARG_1
 > == 0x8 ACCUM = 0x0 Nov  1 16:36:00 hermes2 /bsd: SEQ_FLAGS == 0x10, SCBPTR
 > == 0x11, BTT == 0x8, SINDEX == 0x31 Nov  1 16:36:00 hermes2 /bsd: SCSIID ==
 > 0x37, SCB_SCSIID == 0x37, SCB_LUN == 0x0, SCB_TAG == 0xff, SCB_CONTROL ==
 > 0x48 Nov  1 16:36:00 hermes2 /bsd: SCSIBUSL == 0x80, SCSISIGI == 0xe6
 > Nov  1 16:36:00 hermes2 /bsd: SXFRCTL0 == 0x88
 > Nov  1 16:36:00 hermes2 /bsd: SEQCTL == 0x10
 > Nov  1 16:36:00 hermes2 /bsd: ahc1: Dumping Card State in Message-in phase,
 > at SEQADDR 0x1c3 Nov  1 16:36:00 hermes2 /bsd: ACCUM = 0x0, SINDEX = 0x31,
 > DINDEX = 0xe4, ARG_2 = 0x2 Nov  1 16:36:00 hermes2 /bsd: HCNT = 0x0
 > Nov  1 16:36:00 hermes2 /bsd: SCSISEQ = 0x12, SBLKCTL = 0x2
 > Nov  1 16:36:00 hermes2 /bsd:  DFCNTRL = 0x0, DFSTATUS = 0x28
 > Nov  1 16:36:00 hermes2 /bsd: LASTPHASE = 0xe0, SCSISIGI = 0xe6, SXFRCTL0 =
 > 0x88 Nov  1 16:36:00 hermes2 /bsd: SSTAT0 = 0x7, SSTAT1 = 0x3
 > Nov  1 16:36:00 hermes2 /bsd: STACK == 0x197, 0x181, 0xf8, 0x15d
 > Nov  1 16:36:00 hermes2 /bsd: SCB count = 32
 > Nov  1 16:36:00 hermes2 /bsd: Kernel NEXTQSCB = 29
 > Nov  1 16:36:00 hermes2 /bsd: Card NEXTQSCB = 29
 > Nov  1 16:36:00 hermes2 /bsd: QINFIFO entries:
 > Nov  1 16:36:00 hermes2 /bsd: Waiting Queue entries: 16:30
 > Nov  1 16:36:00 hermes2 /bsd: Disconnected Queue entries: 15:31 2:10 4:14
 > 6:12 0:15 7:6 3:1 8:7 9:13 10:9 12:5 11:4 5:11 1:3 13:2 14:0 Nov  1
 > 16:36:00 hermes2 /bsd: QOUTFIFO entries:
 > Nov  1 16:36:00 hermes2 /bsd: Sequencer Free SCB List: 17 18 19 20 21 22 23
 > 24 25 26 27 28 29 30 31 Nov  1 16:36:00 hermes2 /bsd: Pending list: 8, 30,
 > 31, 10, 14, 12, 15, 6, 1, 7, 13, 9, 5, 4, 11, 3, 2, 0 Nov  1 16:36:00
 > hermes2 /bsd: Kernel Free SCB list: 28 27 26 25 24 23 22 21 20 19 18 17 16
 > Nov  1 16:36:00 hermes2 /bsd: Untagged Q(3): 30 8
 > Nov  1 16:36:00 hermes2 /bsd: FEATURES = 0x16035, FLAGS = 0x485148, CHIP =
 > 0x408 BUGS =0x35 Nov  1 16:36:00 hermes2 /bsd: ahc1: target 0 using
 > asynchronous transfers Nov  1 16:36:00 hermes2 /bsd: ahc1: Bus Device Reset
 > on A:0. 16 SCBs aborted Nov  1 16:36:00 hermes2 /bsd: ahc1: target 0
 > synchronous at 20.0MHz, offset = 0x8
 >
 > >Fix:
 > >
 > >
 > >Release-Note:
 > >Audit-Trail:
 > >Unformatted:
Visit your host, monkey.org