lkml.org 
[lkml]   [2007]   [Dec]   [17]   [last100]   RSS Feed
Views: [wrap][no wrap]   [headers]  [forward] 
 
Messages in this thread
/
Date
From
SubjectRe: 2.6.24-rc5: tape drive not responding
>>>>> "Andrew" == Andrew Morton <akpm@linux-foundation.org> writes:

Andrew> On Mon, 17 Dec 2007 11:25:51 +0900 FUJITA Tomonori <fujita.tomonori@lab.ntt.co.jp> wrote:
>> On Sun, 16 Dec 2007 20:05:51 -0500
>> "John Stoffel" <john@stoffel.org> wrote:
>>
>> > [ 215.007701] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.008145] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.008678] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.009122] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.009598] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.010042] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.010516] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.010959] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.011403] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 215.011850] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > .
>> > .
>> > .
>> > [ 232.954629] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 233.035902] scsi 3:0:3:0: DEVICE RESET operation started
>> > [ 233.099514] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > .
>> > .
>> > .
>> >
>> > These repeat for about 15 seconds or so. They're really annoying and
>> > I'd love to see some sort of rate limiting put in here. The messages
>> > and end with:
>> > .
>> > .
>> > .
>> > [ 238.084175] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 238.165887] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 238.247157] scsi 3:0:3:0: DEVICE RESET operation timed-out.
>> > [ 238.313892] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 238.395192] scsi 3:0:3:0: BUS RESET operation started
>> > [ 238.455690] sym1: SCSI parity error detected: SCR1=1 DBC=11000028 SBCL=ae
>> > [ 238.539216] sym1: SCSI BUS reset detected.
>> > [ 238.592552] sym1: SCSI BUS has been reset.
>> > [ 238.641576] scsi 3:0:3:0: BUS RESET operation complete.
>> > [ 248.700373] target3:0:3: wide asynchronous
>> > [ 248.752026] target3:0:3: Wide Transfers Fail
>> > [ 248.805220] target3:0:3: FAST-10 SCSI 10.0 MB/s ST (100 ns, offset 15)
>> > [ 248.886729] target3:0:3: Domain Validation skipping write tests
>> > [ 248.958666] target3:0:3: Ending Domain Validation
>> > [ 252.264086] scsi 3:0:0:0: Attached scsi generic sg2 type 8
>> > [ 252.331257] st 3:0:2:0: Attached scsi tape st0
>> > [ 252.384549] st 3:0:2:0: st0: try direct i/o: yes (alignment 512 B)
>> > [ 252.458875] st 3:0:2:0: Attached scsi generic sg3 type 1
>> > [ 252.523963] st 3:0:3:0: Attached scsi tape st1
>> > [ 252.577184] st 3:0:3:0: st1: try direct i/o: yes (alignment 512 B)
>> > [ 252.651484] st 3:0:3:0: Attached scsi generic sg4 type 1
>> >
>> >
>> > I've also got an ATL P1000 SCSI tape library hooked up to this same
>> > controller and port, and I can manipulate it properly using the 'mtx'
>> > program pointed to the /dev/changer alias, which points to the correct
>> > /dev/sg# device.
>> >
>> > Here's my /proc/scsi/scsi output, as you can see, I've got a bunch of
>> > devices on this system:
>> >
>> > # cat /proc/scsi/scsi
>> > Attached devices:
>> > Host: scsi0 Channel: 00 Id: 00 Lun: 00
>> > Vendor: COMPAQ Model: HC01841729 Rev: 3208
>> > Type: Direct-Access ANSI SCSI revision: 02
>> > Host: scsi0 Channel: 00 Id: 01 Lun: 00
>> > Vendor: COMPAQ Model: BD018222CA Rev: B016
>> > Type: Direct-Access ANSI SCSI revision: 02
>> > Host: scsi3 Channel: 00 Id: 00 Lun: 00
>> > Vendor: ATL Model: P1000 6220051 Rev: 1.20
>> > Type: Medium Changer ANSI SCSI revision: 02
>> > Host: scsi3 Channel: 00 Id: 02 Lun: 00
>> > Vendor: QUANTUM Model: DLT7000 Rev: 2565
>> > Type: Sequential-Access ANSI SCSI revision: 02
>> > Host: scsi3 Channel: 00 Id: 03 Lun: 00
>> > Vendor: QUANTUM Model: DLT7000 Rev: 2565
>> > Type: Sequential-Access ANSI SCSI revision: 02
>> > Host: scsi4 Channel: 00 Id: 00 Lun: 00
>> > Vendor: SAMSUNG Model: CDRW/DVD SM-352B Rev: T806
>> > Type: CD-ROM ANSI SCSI revision: 05
>> > Host: scsi6 Channel: 00 Id: 00 Lun: 00
>> > Vendor: ATA Model: ST3320620AS Rev: 3.AA
>> > Type: Direct-Access ANSI SCSI revision: 05
>> > Host: scsi7 Channel: 00 Id: 00 Lun: 00
>> > Vendor: ATA Model: WDC WD3200AAKS-0 Rev: 12.0
>> > Type: Direct-Access ANSI SCSI revision: 05
>> > Host: scsi10 Channel: 00 Id: 00 Lun: 00
>> > Vendor: ATA Model: WDC WD1200JB-00C Rev: 17.0
>> > Type: Direct-Access ANSI SCSI revision: 05
>> > Host: scsi11 Channel: 00 Id: 00 Lun: 00
>> > Vendor: ATA Model: WDC WD1200JB-00E Rev: 15.0
>> > Type: Direct-Access ANSI SCSI revision: 05
>> > Host: scsi12 Channel: 00 Id: 00 Lun: 00
>> > Vendor: Generic Model: STORAGE DEVICE Rev: 0001
>> > Type: Direct-Access ANSI SCSI revision: 00
>> > Host: scsi12 Channel: 00 Id: 00 Lun: 01
>> > Vendor: Generic Model: STORAGE DEVICE Rev: 0001
>> > Type: Direct-Access ANSI SCSI revision: 00
>> > Host: scsi12 Channel: 00 Id: 00 Lun: 02
>> > Vendor: Generic Model: STORAGE DEVICE Rev: 0001
>> > Type: Direct-Access ANSI SCSI revision: 00
>> > Host: scsi12 Channel: 00 Id: 00 Lun: 03
>> > Vendor: Generic Model: STORAGE DEVICE Rev: 0001
>> > Type: Direct-Access ANSI SCSI revision: 00
>> >
>> >
>> > When I try to access my tape devices, I get the following:
>> >
>> > # mt -f /dev/st0 status
>> > /dev/st0: Device or resource busy
>> >
>> > But lsof doesn't show any other processes accessing this device, and
>> > I've stopped my backup software since it keeps hanging on tape device
>> > access.
>> >
>> > Here's the output of dmesg where I get the OOPS:
>> >
>> > [ 273.382057] sd 12:0:0:3: Attached scsi generic sg13 type 0
>> > [ 276.244872] ------------[ cut here ]------------
>> > [ 276.300215] kernel BUG at include/linux/scatterlist.h:59!
>> > [ 276.364873] invalid opcode: 0000 [#1] SMP
>> > [ 276.414346] Modules linked in:
>> > [ 276.451148]
>> > [ 276.469036] Pid: 1824, comm: stinit Not tainted (2.6.24-rc5 #2)
>> > [ 276.539940] EIP: 0060:[<c0343c30>] EFLAGS: 00010213 CPU: 0
>> > [ 276.605651] EIP is at st_do_scsi+0x2e0/0x340
>> > [ 276.656788] EAX: 00000000 EBX: 00000000 ECX: c16ef780 EDX: f7c4f050
>> > [ 276.731847] ESI: f7c4f7d0 EDI: 00001000 EBP: f7c4f000 ESP: f712bdf8
>> > [ 276.806904] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
>> > [ 276.871568] Process stinit (pid: 1824, ti=f712b000 task=f750a030 task.ti=f712b000)
>> > [ 276.960139] Stack: 00000003 f7c4f050 00000000 00000000 00d59f80 00000000 f776fe20 c03468a0
>> > [ 277.062012] 000000d0 f712be9c f7d2a000 f776fe20 f7d2a018 00000000 00000006 f712be9c
>> > [ 277.163890] f7d2a000 f712beac f7c4f000 c0345790 00000006 00000002 000dbba0 00000000
>> > [ 277.265771] Call Trace:
>> > [ 277.297383] [<c03468a0>] st_sleep_done+0x0/0x70
>> > [ 277.352894] [<c0345790>] check_tape+0x510/0x640
>> > [ 277.408414] [<c0346cfb>] st_open+0x18b/0x220
>> > [ 277.460803] [<c01707e0>] exact_match+0x0/0x10
>> > [ 277.514237] [<c0346b70>] st_open+0x0/0x220
>> > [ 277.564553] [<c0170ebf>] chrdev_open+0x9f/0x190
>> > [ 277.620069] [<c0170e20>] chrdev_open+0x0/0x190
>> > [ 277.674543] [<c016c86f>] __dentry_open+0xaf/0x1b0
>> > [ 277.732136] [<c016ca25>] nameidata_to_filp+0x35/0x40
>> > [ 277.792847] [<c016ca7b>] do_filp_open+0x4b/0x60
>> > [ 277.848364] [<c016c732>] get_unused_fd_flags+0x52/0xd0
>> > [ 277.911153] [<c016cadc>] do_sys_open+0x4c/0xe0
>> > [ 277.965629] [<c016cbac>] sys_open+0x1c/0x20
>>
>> I think that you need the following patch for the scatterlist problem:
>>
>> http://marc.info/?l=linux-scsi&m=119770154127770&w=2

Andrew> err, you sent that patch to John a day earlier too.

Andrew> John, can you please apply, test and report?

I didn't see the reply for some reason. I'm applying the patch now to
2.6.24-rc5-mm1 and I'll reboot and test. My git bisection has been a
failure too, since I found a situation where I thought what was a bad
kernel now works.

Sigh... might be an issue with Bacula interactions, since I've now
turned it off on startup for testing.

More in a bit.
John


\
 
 \ /
  Last update: 2007-12-17 20:03    [W:1.055 / U:0.736 seconds]
©2003-2020 Jasper Spaans|hosted at Digital Ocean and TransIP|Read the blog|Advertise on this site