Skip site navigation (1)Skip section navigation (2)
Date:      Sun, 30 May 1999 20:46:36 +0200 (MET DST)
From:      Juergen Lock <nox@jelal.kn-bremen.de>
To:        FreeBSD-gnats-submit@freebsd.org
Subject:   kern/11945: tape problems on -stable, mt bl(ocksize), mt erase and hanging SCSI bus
Message-ID:  <199905301846.UAA87993@saturn.kn-bremen.de>

next in thread | raw e-mail | index | archive | help

>Number:         11945
>Category:       kern
>Synopsis:       tape problems on -stable, mt bl(ocksize), mt erase and hanging SCSI bus
>Confidential:   no
>Severity:       non-critical
>Priority:       low
>Responsible:    freebsd-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Sun May 30 12:00:01 PDT 1999
>Closed-Date:
>Last-Modified:
>Originator:     Juergen Lock
>Release:        FreeBSD 3.2-STABLE i386
>Organization:
me? organized?
>Environment:

	FreeBSD 3.2-STABLE i386, and a

sa0 at ncr0 bus 0 target 5 lun 0
sa0: <WANGTEK 5525ES SCSI 73Y1> Removable Sequential Access SCSI-2 device 
sa0: 4.901MB/s transfers (4.901MHz, offset 8)

        tape drive on a NCR PCI SCSI host.  I'll append a boot -v
        dmesg below.

>Description:

	1.  mt bl(ocksize) stopped working, regardless what blocksize
        i try i only get

mt: /dev/nrsa0: blocksize: Invalid argument

        and on the console:

Apr 27 16:00:47 saturn /kernel: (sa0:ncr0:0:5:0): MODE SELECT(06). CDB: 15 0 0 0
 c 0 
Apr 27 16:00:47 saturn /kernel: (sa0:ncr0:0:5:0): ILLEGAL REQUEST asc:26,0
Apr 27 16:00:47 saturn /kernel: (sa0:ncr0:0:5:0): Invalid field in parameter lis
t sks:8f,4

        2.  mt erase fails similarly (I don't have the syslog right
	now, sorry)

        3.  depending on factors i haven't found out, trying to read
        after a BLANK CHECK on some tapes ends up hanging the entire
        SCSI bus, printing this on the console:

ncr0: SCSI phase error fixup: CCB already dequeued (0xf07e1200)

        followed by several of

ncr0: timeout nccb=0xf0xxxxxx (skip)

        and

vm_fault: pager read error, pid xxx (process)

        CAMDEBUG tells me on the tapes where it hangs it does
        five LOAD UNLOAD commands (the first rewinds the tape) while
        normally it does only one LOAD UNLOAD.  I can send the full
        CAMDEBUG output of the working case if that helps...

>How-To-Repeat:

	1.

<load any tape>

$ mt bl <anything>

        2.

<load scratch tape>

$ mt erase

        3.

<load problem tape>

$ mt eom
$ dd bs=5k </dev/nrsa0 >/dev/null 
dd: stdin: Input/output error
0+0 records in
0+0 records out
0 bytes transferred in 0.010533 secs (0 bytes/sec)

<console prints:
May 13 22:50:12 saturn /kernel: (sa0:ncr0:0:5:0): READ(06). CDB: 8 1 0 0 a 0 
May 13 22:50:12 saturn /kernel: (sa0:ncr0:0:5:0): BLANK CHECK req sz: 10 (decimal)
May 13 22:50:12 saturn /kernel: (sa0:ncr0:0:5:0): READ(06). CDB: 8 1 0 0 a 0 
May 13 22:50:12 saturn /kernel: (sa0:ncr0:0:5:0): BLANK CHECK req sz: 10 (decimal) asc:2c,0
May 13 22:50:12 saturn /kernel: (sa0:ncr0:0:5:0): Command sequence error
>

$ dd bs=5k </dev/nrsa0 >/dev/null 

<tape rewinds, then it hangs the SCSI bus like explained above>

>Fix:
	
	???  FWIW, all this worked on 2.1-stable...
	(case 3 didn't rewind automatically, just repeated the
	BLANK CHECK error; I don't know if that is/was a feature)

	Here is the dmesg,

Copyright (c) 1992-1999 FreeBSD Inc.
Copyright (c) 1982, 1986, 1989, 1991, 1993
	The Regents of the University of California. All rights reserved.
FreeBSD 3.2-STABLE #44: Sat May 22 23:14:35 MET DST 1999
    nox@saturn:/www/w/usr/home5/cvs/src31/src/sys/compile/SP3G.3I
Calibrating clock(s) ... i8254 clock: 1228963 Hz
1228963 Hz differs from default of 1193182 Hz by more than 1%
Timecounter "i8254"  frequency 1193182 Hz
CPU: i486 DX4 (486-class CPU)
  Origin = "GenuineIntel"  Id = 0x480  Stepping=0
  Features=0x3<FPU,VME>
real memory  = 33554432 (32768K bytes)
Physical memory chunk(s):
0x00001000 - 0x0009efff, 647168 bytes (158 pages)
0x002f2000 - 0x01febfff, 30384128 bytes (7418 pages)
avail memory = 29749248 (29052K bytes)
Found BIOS32 Service Directory header at 0xc00fc310
Entry = 0xfc740 (0xc00fc740)  Rev = 0  Len = 1
PCI BIOS entry at 0xc770
Other BIOS signatures found:
ACPI: 00000000
$PnP: 00000000
Preloaded elf kernel "kernel" at 0xc02e1000.
VESA: information block
56 45 53 41 02 01 3a 4f 00 c0 00 00 00 00 57 4f 
00 c0 20 00 00 00 00 00 00 00 00 00 00 00 00 00 
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 
VESA: 20 mode(s) found
Math emulator present
pci_open(1):	mode 1 addr port (0x0cf8) is 0x00000000
pci_open(1a):	mode1res=0x00000000 (0x80000000)
pci_open(1b):	mode1res=0x00000000 (0xff000001)
pci_open(2):	mode 2 enable port (0x0cf8) is 0x00
pci_open(2a):	mode2res=0x0e (0x0e)
pci_open(2a):	now trying mechanism 2
pci_cfgcheck:	device 0 [class=000000] 1 [class=000000] 2 [class=000000] 3 4 5 6 [class=030000] [hdr=00] is there (id=88115333)
Probing for devices on PCI bus 0:
found->	vendor=0x8086, dev=0x0483, revid=0x04
	class=00-00-00, hdrtype=0x00, mfdev=0
	subordinatebus=0 	secondarybus=0
i4b_pci_probe: unknown PCI type 75726982l!
chip0: <Intel 82424ZX (Saturn) cache DRAM controller> rev 0x04 on pci0.0.0
	CPU: 486DX, bus=33MHz, CPU->Memory posting ON
	Warning: NO DRAM parity!
	Cache: 256KB writeback, cache clocks=2-1-1-1
	DRAM: page mode code fetch, read and write, memory clocks=X-2-2-2
	CPU->PCI: posting ON, burst mode ON
	PCI->Memory: posting OFF
found->	vendor=0x1000, dev=0x0001, revid=0x01
	class=00-00-00, hdrtype=0x00, mfdev=0
	subordinatebus=0 	secondarybus=0
	intpin=a, irq=9
	map[0]: type 4, range 32, base 0000e800, size  8
	map[1]: type 1, range 32, base fbfef000, size  8
ncr0: <ncr 53c810 fast10 scsi> rev 0x01 int a irq 9 on pci0.1.0
ncr0: minsync=25, maxsync=206, maxoffs=8, 16 dwords burst, normal dma fifo
ncr0: single-ended, open drain IRQ driver
found->	vendor=0x8086, dev=0x0484, revid=0x03
	class=00-00-00, hdrtype=0x00, mfdev=0
	subordinatebus=0 	secondarybus=0
i4b_pci_probe: unknown PCI type 75792518l!
chip1: <Intel 82378ZB PCI to ISA bridge> rev 0x03 on pci0.2.0
	Bus Modes: Bus Park, Bus Lock,
	Coprocessor errors enabled
	Keyboard controller: 60h,62h,64h,66h
	RTC: 70h-77h
found->	vendor=0x5333, dev=0x8811, revid=0x00
	class=03-00-00, hdrtype=0x00, mfdev=0
	subordinatebus=0 	secondarybus=0
	intpin=a, irq=0
	map[0]: type 1, range 32, base fb000000, size 23
vga0: <S3 Trio graphics accelerator> rev 0x00 int a irq 0 on pci0.6.0
Probing for devices on the ISA bus:
atkbd: the current kbd controller command byte 0045
atkbd: keyboard ID 0x41ab (2)
kbdc: RESET_KBD return code:00fa
kbdc: RESET_KBD status:00aa
sc0 on isa
sc0: fb0 kbd0
sc0: VGA color <16 virtual consoles, flags=0x0>
atkbdc0 at 0x60-0x6f on motherboard
atkbd0 irq 1 on isa
kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x3d0000
psm0: disabled, not probed.
sio0: disabled, not probed.
sio1: irq maps: 0x1 0x9 0x1 0x1
sio1 at 0x2f8-0x2ff irq 3 on isa
sio1: type 16550A
sio2: disabled, not probed.
pca0 on motherboard
pca0: PC speaker audio driver
fdc0 at 0x3f0-0x3f7 irq 6 drq 2 on isa
fdc0: FIFO enabled, 8 bytes threshold
fd0: 1.44MB 3.5in
wdc0 at 0x1f0-0x1f7 irq 14 on isa
wdc0: unit 0 (wd0): <QUANTUM FIREBALL ST6.4A>
wd0: 6149MB (12594960 sectors), 13328 cyls, 15 heads, 63 S/T, 512 B/S
wd0: ATA INQUIRE valid = 0007, dmamword = 0407, apio = 0003, udma = 0007
ppc: parallel port found at 0x378
PC873xx FER=0x4f FAR=0x10 PTR=0x8 FCR=0x0 PCR=0x0 PMC=0x0 TUP=0x0 SID=0x1a PNP0=0xff PNP1=0xff LPTBA=0xff
PC873xx irq 7 at 0x378
PC873xx irq set to 0
PC873xx unlocked, NIBBLE
ppc0 at 0x378 irq 7 flags 0x20 on isa
ppc0: PC87332 chipset (NIBBLE-only) in COMPATIBLE mode
ppi0: <generic parallel i/o> on ppbus 0
isic0 at 0xd80 irq 12 flags 0x3 on isa
isic0: Teles S0/16.3
isic0: ISAC 2085 Version A1/A2 or 2086/2186 Version 1.1 (IOM-2) (Addr=0x960)
isic0: HSCX 82525 or 21525 Version 2.1 (AddrA=0x160, AddrB=0x560)
vga0 at 0x3b0-0x3df maddr 0xa0000 msize 131072 on isa
fb0: vga0, vga, type:VGA (5), flags:0x700ff
fb0: port:0x3b0-0x3df, crtc:0x3d4, mem:0xa0000 0x20000
fb0: init mode:24, bios mode:3, current mode:24
fb0: window:0xc00b8000 size:32k gran:32k, buf:0x0 size:0k
VGA parameters upon power-up
50 18 10 00 00 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0e 0f 00 00 07 80 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
VGA parameters in BIOS for mode 24
50 18 10 00 10 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0d 0e 00 00 00 00 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
EGA/VGA parameters to be used for mode 24
50 18 10 00 10 00 03 00 02 67 5f 4f 50 82 55 81 
bf 1f 00 4f 0d 0e 00 00 00 00 9c 8e 8f 28 1f 96 
b9 a3 ff 00 01 02 03 04 05 14 07 38 39 3a 3b 3c 
3d 3e 3f 0c 00 0f 08 00 00 00 00 00 10 0e 00 ff 
VESA: v1.2, 2048k memory, flags:0x0, mode table:0xc00c4f57 (c0004f57)
VESA: ELSA WINNER 1000TRIO
npx0 on motherboard
npx0: INT 16 interface
apm0: disabled, not probed.
uartsio0 at 0x3f8 irq 4 on isa
uartsio0: <uart 16550A Midi Interface>
imasks: bio c0084040, tty c003000a, net c0061080
BIOS Geometries:
 0:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 1:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 2:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 3:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 4:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 5:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 6:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 7:00000000 0..0=1 cylinders, 0..0=1 heads, 1..0=0 sectors
 0 accounted for
Device configuration finished.
IP packet filtering initialized, divert disabled, rule-based forwarding disabled, unlimited logging
bpf: tun0 attached
bpf: lo0 attached
i4b: ISDN call control device attached
i4bisppp: 4 ISDN SyncPPP device(s) attached
bpf: isp0 attached
bpf: isp1 attached
bpf: isp2 attached
bpf: isp3 attached
i4bctl: ISDN system control port attached
i4bipr: 4 IP over raw HDLC ISDN device(s) attached (VJ header compression)
bpf: ipr0 attached
bpf: ipr1 attached
bpf: ipr2 attached
bpf: ipr3 attached
i4btel: 2 ISDN telephony interface device(s) attached
i4brbch: 4 raw B channel access device(s) attached
i4btrc: 4 ISDN trace device(s) attached
Linux-ELF exec handler installed
Waiting 5 seconds for SCSI devices to settle
(xpt0:ncr0:0:-1:-1): xpt_compile_path
(xpt0:ncr0:0:-1:-1): xpt_setup_ccb
(xpt0:ncr0:0:-1:-1): xpt_action
(xpt0:ncr0:0:-1:-1): xpt_done
(xpt0:ncr0:0:-1:-1): xpt_setup_ccb
(xpt0:ncr0:0:-1:-1): xpt_action
ncr0: restart (scsi reset).
(noperiph:ncr0:0:-1:-1): xpt_async
(noperiph:ncr0:0:-1:-1): xpt_compile_path
(noperiph:ncr0:0:-1:-1): xpt_release_path
(xpt0:ncr0:0:-1:-1): xpt_done
(xpt0:ncr0:0:-1:-1): xpt_finishconfig
(xpt0:ncr0:0:-1:-1): xpt_action
(xpt0:ncr0:0:-1:-1): xpt_scan_bus
(xpt0:ncr0:0:-1:-1): xpt_setup_ccb
(xpt0:ncr0:0:-1:-1): xpt_action
(xpt0:ncr0:0:-1:-1): xpt_done
(probe6:ncr0:0:6:0): INQUIRY. CDB: 12 1 80 0 ff 0 
(probe6:ncr0:0:6:0): ILLEGAL REQUEST asc:24,0
(probe6:ncr0:0:6:0): Invalid field in CDB
(probe5:ncr0:0:5:0): INQUIRY. CDB: 12 1 80 0 ff 0 
(probe5:ncr0:0:5:0): ILLEGAL REQUEST asc:24,0
(probe5:ncr0:0:5:0): Invalid field in CDB sks:c8,1
(xpt0:ncr0:0:-1:-1): xpt_done
(xpt0:ncr0:0:-1:-1): camisr(xpt0:ncr0:0:-1:-1): xpt_finishconfig
(xpt0:ncr0:0:-1:-1): xpt_free_path
(xpt0:ncr0:0:-1:-1): xpt_release_path
(noperiph:xpt0:0:-1:-1): xpt_compile_path
(noperiph:xpt0:0:-1:-1): xpt_setup_ccb
(noperiph:xpt0:0:-1:-1): xpt_action
(noperiph:xpt0:0:-1:-1): xpt_free_path
(noperiph:xpt0:0:-1:-1): xpt_release_path
(noperiph:xpt0:0:-1:-1): xpt_compile_path
(noperiph:xpt0:0:-1:-1): xpt_setup_ccb
(noperiph:xpt0:0:-1:-1): xpt_action
(sa0:ncr0:0:5:0): found quirk entry 11
sa0 at ncr0 bus 0 target 5 lun 0
sa0: <WANGTEK 5525ES SCSI 73Y1> Removable Sequential Access SCSI-2 device 
sa0: 4.901MB/s transfers (4.901MHz, offset 8)
(noperiph:xpt0:0:-1:-1): xpt_free_path
(noperiph:xpt0:0:-1:-1): xpt_release_path
(noperiph:xpt0:0:-1:-1): xpt_compile_path
(noperiph:xpt0:0:-1:-1): xpt_setup_ccb
(noperiph:xpt0:0:-1:-1): xpt_action
(noperiph:xpt0:0:-1:-1): xpt_free_path
(noperiph:xpt0:0:-1:-1): xpt_release_path
(noperiph:xpt0:0:-1:-1): xpt_compile_path
(noperiph:xpt0:0:-1:-1): xpt_setup_ccb
(noperiph:xpt0:0:-1:-1): xpt_action
pass0 at ncr0 bus 0 target 0 lun 0
pass0: <IBM DPES-31080 S31K> Fixed Direct Access SCSI-2 device 
pass0: Serial Number 1C176285        
pass0: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
pass1 at ncr0 bus 0 target 1 lun 0
pass1: <CONNER CFP2105S  2.14GB 2B4B> Fixed Direct Access SCSI-2 device 
pass1: Serial Number EF90YAE 
pass1: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
pass2 at ncr0 bus 0 target 2 lun 0
pass2: <IBM DORS-32160W WA6A> Fixed Direct Access SCSI-2 device 
pass2: Serial Number 5U2R4677        
pass2: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
pass3 at ncr0 bus 0 target 3 lun 0
pass3: <IBM DPES-31080 S31K> Fixed Direct Access SCSI-2 device 
pass3: Serial Number 1C071239        
pass3: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
pass4 at ncr0 bus 0 target 5 lun 0
pass4: <WANGTEK 5525ES SCSI 73Y1> Removable Sequential Access SCSI-2 device 
pass4: 4.901MB/s transfers (4.901MHz, offset 8)
pass5 at ncr0 bus 0 target 6 lun 0
pass5: <YAMAHA CRW4416S 1.0g> Removable CD-ROM SCSI-2 device 
pass5: 8.333MB/s transfers (8.333MHz, offset 8)
(noperiph:xpt0:0:-1:-1): xpt_free_path
(noperiph:xpt0:0:-1:-1): xpt_release_path
da0 at ncr0 bus 0 target 0 lun 0
da0: <IBM DPES-31080 S31K> Fixed Direct Access SCSI-2 device 
da0: Serial Number 1C176285        
da0: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
da0: 1034MB (2118144 512 byte sectors: 255H 63S/T 131C)
da1 at ncr0 bus 0 target 1 lun 0
da1: <CONNER CFP2105S  2.14GB 2B4B> Fixed Direct Access SCSI-2 device 
da1: Serial Number EF90YAE 
da1: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
da1: 2048MB (4194304 512 byte sectors: 255H 63S/T 261C)
da3 at ncr0 bus 0 target 3 lun 0
da3: <IBM DPES-31080 S31K> Fixed Direct Access SCSI-2 device 
da3: Serial Number 1C071239        
da3: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
da3: 1034MB (2118144 512 byte sectors: 255H 63S/T 131C)
da2 at ncr0 bus 0 target 2 lun 0
da2: <IBM DORS-32160W WA6A> Fixed Direct Access SCSI-2 device 
da2: Serial Number 5U2R4677        
da2: 10.000MB/s transfers (10.000MHz, offset 8), Tagged Queueing Enabled
da2: 2063MB (4226725 512 byte sectors: 255H 63S/T 263C)
Considering MFS root f/s.
No MFS image available as root f/s.
Considering FFS root f/s.
changing root device to da2s1a
da2s1: type 0xa5, start 63, end = 4224527, size 4224465 : OK
Start pid=2 <pagedaemon>
Start pid=3 <vmdaemon>
Start pid=4 <syncer>
wd0s1: type 0x6, start 63, end = 2056319, size 2056257 : OK
wd0s2: type 0xa5, start 2056320, end = 12594959, size 10538640 : OK
da3s1: type 0xa5, start 63, end = 2104514, size 2104452 : OK
da1s1: type 0xa5, start 261954, end = 4191263, size 3929310 : OK
da1s4: type 0x6, start 63, end = 261953, size 261891 : OK
da0s1: type 0x5, start 261954, end = 523907, size 261954 : OK
da0s3: type 0xa5, start 523908, end = 2118143, size 1594236 : OK
da0s4: type 0x6, start 63, end = 261953, size 261891 : OK
da3s1: type 0xa5, start 63, end = 2104514, size 2104452 : OK
da0s1: type 0x5, start 261954, end = 523907, size 261954 : OK
da0s3: type 0xa5, start 523908, end = 2118143, size 1594236 : OK
da0s4: type 0x6, start 63, end = 261953, size 261891 : OK
da1s1: type 0xa5, start 261954, end = 4191263, size 3929310 : OK
da1s4: type 0x6, start 63, end = 261953, size 261891 : OK
da0s1: type 0x5, start 261954, end = 523907, size 261954 : OK
da0s3: type 0xa5, start 523908, end = 2118143, size 1594236 : OK
da0s4: type 0x6, start 63, end = 261953, size 261891 : OK
da3s1: type 0xa5, start 63, end = 2104514, size 2104452 : OK
ffs_mountfs: superblock updated for soft updates
ffs_mountfs: superblock updated for soft updates
ffs_mountfs: superblock updated for soft updates
da1s1: type 0xa5, start 261954, end = 4191263, size 3929310 : OK
da1s4: type 0x6, start 63, end = 261953, size 261891 : OK
ffs_mountfs: superblock updated for soft updates
da0s1: type 0x5, start 261954, end = 523907, size 261954 : OK
da0s3: type 0xa5, start 523908, end = 2118143, size 1594236 : OK
da0s4: type 0x6, start 63, end = 261953, size 261891 : OK
ffs_mountfs: superblock updated for soft updates
ffs_mountfs: superblock updated for soft updates
splash: image decoder found: green_saver
(cd0:ncr0:0:6:0): READ CD RECORDED CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
(cd0:ncr0:0:6:0): NOT READY asc:3a,1
(cd0:ncr0:0:6:0): Medium not present - tray closed
cd0 at ncr0 bus 0 target 6 lun 0
cd0: <YAMAHA CRW4416S 1.0g> Removable CD-ROM SCSI-2 device 
cd0: 8.333MB/s transfers (8.333MHz, offset 8)
cd0: Attempt to query device size failed: NOT READY, Medium not present - tray closed

>Release-Note:
>Audit-Trail:
>Unformatted:


To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-bugs" in the body of the message




Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?199905301846.UAA87993>