USB Mass Storage - Kernel Bug?
Greetings,
I am having trouble using an external USB 2.0 to IDE converter box with
recent 2.6 kernels. The box houses a 200GB IDE drive. When I try to
perform large transfers (eg 500MB files) to the box it aborts after a
variable proportion of the file/s have been transferred.
The dmesg output calls it a kernel bug... Google is unhelpful, does
anybody know what this is or where I could go for further assistance.
All the recent kernels versions that I've tried seem affected, from
2.6.4 through to 2.6.9-rc2.
Note that the drive works under Windows 2k/XP. Dmesg output is attached,
with the most relevant section directly below.
Warm regards,
Damien
------------[ cut here ]------------
kernel BUG at drivers/block/as-iosched.c:1853!
invalid operand: 0000 [#1]
Modules linked in: visor usbserial yenta_socket ds pcmcia_core
usb_storage
CPU: 0
EIP: 0060:[<c021d777>] Not tainted VLI
EFLAGS: 00010293 (2.6.9-rc2damo)
EIP is at as_exit+0x65/0x79
eax: df79968c ebx: df799680 ecx: d1e42aa0 edx: d030be74
esi: c15ac0b4 edi: 00000292 ebp: c151ceb4 esp: d030beb0
ds: 007b es: 007b ss: 0068
Process scsi_eh_0 (pid: 2082, threadinfo=d030a000 task=d1e42aa0)
Stack: df799708 c15ac028 c0214b10 c15ac028 c15ac034 c02169e2 c15ac028
00000001
dea71824 dea71800 c0245fac c15ac028 dea719a8 c03d7248 c03d7260
c151ced8
c0210b94 dea71984 00cec98a 00cec98a ffffffff c019ca63 dea719a8
dea719c0
Call Trace:
[<c0214b10>] elevator_exit+0x1e/0x20
[<c02169e2>] blk_cleanup_queue+0x36/0x81
[<c0245fac>] scsi_device_dev_release+0xd9/0xeb
[<c0210b94>] device_release+0x58/0x5c
[<c019ca63>] kobject_cleanup+0x98/0x9a
[<c019ca65>] kobject_release+0x0/0xa
[<c019cdae>] kref_put+0x39/0x93
[<c0119d2e>] vprintk+0xfe/0x12f
[<c019ca8d>] kobject_put+0x1e/0x22
[<c019ca65>] kobject_release+0x0/0xa
[<c023fd87>] __scsi_iterate_devices+0x4f/0x59
[<c024219b>] scsi_eh_stu+0x92/0xf4
[<c02428a6>] scsi_eh_ready_devs+0x2b/0x93
[<c0242a4e>] scsi_unjam_host+0xb7/0xb9
[<c0242aee>] scsi_error_handler+0x9e/0xc6
[<c0242a50>] scsi_error_handler+0x0/0xc6
[<c010225d>] kernel_thread_helper+0x5/0xb
Code: f1 ff 8b 83 d8 00 00 00 89 04 24 e8 67 b0 ff ff 8b 43 38 89 04 24
e8 69 cb f1 ff 89 5c 24 0c 8b 5c 24 04 83 c4 08 e9 59 cb f1 ff <0f> 0b
3d 07 fd f1 34 c0 eb c2 0f 0b 3c 07 fd f1 34 c0 eb b0 55
00 38 00
usb-storage: Bulk Command S 0x43425355 T 0x3475 L 28672 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665415
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e c9 00 00 36 00
usb-storage: Bulk Command S 0x43425355 T 0x3476 L 27648 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665417
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e cb 00 00 34 00
usb-storage: Bulk Command S 0x43425355 T 0x3477 L 26624 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665419
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e cd 00 00 32 00
usb-storage: Bulk Command S 0x43425355 T 0x3478 L 25600 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665421
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e cf 00 00 30 00
usb-storage: Bulk Command S 0x43425355 T 0x3479 L 24576 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665423
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e d1 00 00 2e 00
usb-storage: Bulk Command S 0x43425355 T 0x347a L 23552 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665425
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e d3 00 00 2c 00
usb-storage: Bulk Command S 0x43425355 T 0x347b L 22528 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665427
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e d5 00 00 2a 00
usb-storage: Bulk Command S 0x43425355 T 0x347c L 21504 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665429
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e d7 00 00 28 00
usb-storage: Bulk Command S 0x43425355 T 0x347d L 20480 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665431
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e d9 00 00 26 00
usb-storage: Bulk Command S 0x43425355 T 0x347e L 19456 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665433
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e db 00 00 24 00
usb-storage: Bulk Command S 0x43425355 T 0x347f L 18432 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665435
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e dd 00 00 22 00
usb-storage: Bulk Command S 0x43425355 T 0x3480 L 17408 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665437
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e df 00 00 20 00
usb-storage: Bulk Command S 0x43425355 T 0x3481 L 16384 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665439
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e e1 00 00 1e 00
usb-storage: Bulk Command S 0x43425355 T 0x3482 L 15360 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665441
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e e3 00 00 1c 00
usb-storage: Bulk Command S 0x43425355 T 0x3483 L 14336 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665443
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: Command WRITE_10 (10 bytes)
usb-storage: 2a 00 02 c8 0e e5 00 00 1a 00
usb-storage: Bulk Command S 0x43425355 T 0x3484 L 13312 F 0 Trg 0 LUN 0 CL 10
usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
usb-storage: Status code -19; transferred 0/31
usb-storage: -- unknown error
usb-storage: Bulk command transfer result=4
usb-storage: -- transport indicates error, resetting
usb-storage: usb_stor_Bulk_reset called
usb-storage: usb_stor_control_msg: rq=ff rqtype=21 value=0000 index=00 len=0
usb-storage: Soft reset failed: -19
usb-storage: scsi cmd done, result=0x70000
usb-storage: *** thread sleeping.
usb-storage: storage_disconnect() called
usb-storage: usb_stor_stop_transport called
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665445
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: No command during disconnect
usb-storage: *** thread sleeping.
usb-storage: command_abort called
usb-storage: -- nothing to abort
usb-storage: device_reset called
usb-storage: No reset during disconnect
usb-storage: bus_reset called
usb-storage: No reset during disconnect
scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 0 lun 0
sd 0:0:0:0: Illegal state transition cancel->offline
Badness in scsi_device_set_state at drivers/scsi/scsi_lib.c:1688
[<c0244520>] scsi_device_set_state+0xc4/0x112
[<c02425ed>] scsi_eh_offline_sdevs+0x64/0x80
[<c0242a4e>] scsi_unjam_host+0xb7/0xb9
[<c0242aee>] scsi_error_handler+0x9e/0xc6
[<c0242a50>] scsi_error_handler+0x0/0xc6
[<c010225d>] kernel_thread_helper+0x5/0xb
SCSI error : <0 0 0 0> return code = 0x70000
end_request: I/O error, dev sda, sector 46665447
printk: 426 messages suppressed.
Buffer I/O error on device sda1, logical block 23332692
lost page write due to I/O error on sda1
usb-storage: queuecommand called
usb-storage: *** thread awakened.
usb-storage: No command during disconnect
usb-storage: *** thread sleeping.
usb-storage: command_abort called
usb-storage: -- nothing to abort
------------[ cut here ]------------
kernel BUG at drivers/block/as-iosched.c:1853!
invalid operand: 0000 [#1]
Modules linked in: visor usbserial yenta_socket ds pcmcia_core usb_storage
CPU: 0
EIP: 0060:[<c021d777>] Not tainted VLI
EFLAGS: 00010293 (2.6.9-rc2damo)
EIP is at as_exit+0x65/0x79
eax: df79968c ebx: df799680 ecx: d1e42aa0 edx: d030be74
esi: c15ac0b4 edi: 00000292 ebp: c151ceb4 esp: d030beb0
ds: 007b es: 007b ss: 0068
Process scsi_eh_0 (pid: 2082, threadinfo=d030a000 task=d1e42aa0)
Stack: df799708 c15ac028 c0214b10 c15ac028 c15ac034 c02169e2 c15ac028 00000001
dea71824 dea71800 c0245fac c15ac028 dea719a8 c03d7248 c03d7260 c151ced8
c0210b94 dea71984 00cec98a 00cec98a ffffffff c019ca63 dea719a8 dea719c0
Call Trace:
[<c0214b10>] elevator_exit+0x1e/0x20
[<c02169e2>] blk_cleanup_queue+0x36/0x81
[<c0245fac>] scsi_device_dev_release+0xd9/0xeb
[<c0210b94>] device_release+0x58/0x5c
[<c019ca63>] kobject_cleanup+0x98/0x9a
[<c019ca65>] kobject_release+0x0/0xa
[<c019cdae>] kref_put+0x39/0x93
[<c0119d2e>] vprintk+0xfe/0x12f
[<c019ca8d>] kobject_put+0x1e/0x22
[<c019ca65>] kobject_release+0x0/0xa
[<c023fd87>] __scsi_iterate_devices+0x4f/0x59
[<c024219b>] scsi_eh_stu+0x92/0xf4
[<c02428a6>] scsi_eh_ready_devs+0x2b/0x93
[<c0242a4e>] scsi_unjam_host+0xb7/0xb9
[<c0242aee>] scsi_error_handler+0x9e/0xc6
[<c0242a50>] scsi_error_handler+0x0/0xc6
[<c010225d>] kernel_thread_helper+0x5/0xb
Code: f1 ff 8b 83 d8 00 00 00 89 04 24 e8 67 b0 ff ff 8b 43 38 89 04 24 e8 69 cb f1 ff 89 5c 24 0c 8b 5c 24 04 83 c4 08 e9 59 cb f1 ff <0f> 0b 3d 07 fd f1 34 c0 eb c2 0f 0b 3c 07 fd f1 34 c0 eb b0 55
Reply to: