110589 – Plugging in USB hard drive results in Oops

Bug 110589 - Plugging in USB hard drive results in Oops

Summary: Plugging in USB hard drive results in Oops

Status:	RESOLVED INVALID

Alias:	None

Product:	Gentoo Linux
Classification:	Unclassified
Component:	[OLD] Core system (show other bugs)
Hardware:	x86 Linux

Importance:	High critical (vote)
Assignee:	Gentoo Kernel Bug Wranglers and Kernel Maintainers

URL:
Whiteboard:
Keywords:

Depends on:
Blocks:

Reported:	2005-10-26 17:51 UTC by Paul Hartman
Modified:	2005-10-27 21:18 UTC (History)
CC List:	0 users

See Also:
Package list:
Runtime testing required:	---

Attachments
Add an attachment (proposed patch, testcase, etc.)

Note You need to log in before you can comment on or make changes to this bug.

Description Paul Hartman 2005-10-26 17:51:58 UTC

Hi,

I have an IDE to USB adapter. so far have tried to use it with 6 hard drives. 2
of them work, the other 4 result in an "oops" message in the syslog and USB in
general dies after trying to plug it in (even after unplugging).

I just got this device, and have not tried it on older kernels. I have seen a
few other reports of the same problem on gentoo forums without a solution, but
have not been able to find a bug, so I am submitting this. Please let me know if
there is any other info I can provide. Thanks.

Reproducible: Always
Steps to Reproduce:
1. Plug USB hard drive in to PC


Actual Results:  
Oct 26 19:32:10 black usb 1-6: new high speed USB device using ehci_hcd and
address 3
Oct 26 19:32:10 black Initializing USB Mass Storage driver...
Oct 26 19:32:10 black scsi0 : SCSI emulation for USB Mass Storage devices
Oct 26 19:32:10 black usb-storage: device found at 3
Oct 26 19:32:10 black usb-storage: waiting for device to settle before scanning
Oct 26 19:32:10 black usbcore: registered new driver usb-storage
Oct 26 19:32:10 black USB Mass Storage support registered.
Oct 26 19:32:21 black usb 1-6: USB disconnect, address 3
Oct 26 19:32:21 black scsi: Device offlined - not ready after error recovery:
host 0 channel 0 id 0 lun 0
Oct 26 19:32:21 black usb-storage: device scan complete
Oct 26 19:32:21 black Unable to handle kernel NULL pointer dereference at
virtual address 00000010
Oct 26 19:32:21 black printing eip:
Oct 26 19:32:21 black c019bb20
Oct 26 19:32:21 black *pde = 00000000
Oct 26 19:32:21 black Oops: 0000 [#1]
Oct 26 19:32:21 black PREEMPT SMP
Oct 26 19:32:21 black Modules linked in: usb_storage cisco_ipsec snd_pcm_oss
snd_mixer_oss snd_seq_oss snd_seq_midi_event snd_seq snd_seq_device nvidia
snd_intel8x0 snd_ac97_codec snd_pcm snd_timer snd snd_page_alloc kqemu w83627hf
i2c_sensor i2c_isa
Oct 26 19:32:21 black CPU:    1
Oct 26 19:32:21 black EIP:    0060:[<c019bb20>]    Tainted: P      VLI
Oct 26 19:32:21 black EFLAGS: 00010292   (2.6.13-gentoo-r5)
Oct 26 19:32:21 black EIP is at sysfs_hash_and_remove+0x17/0x111
Oct 26 19:32:21 black eax: 00000000   ebx: f7daaacc   ecx: 00000003   edx: c0361d13
Oct 26 19:32:21 black esi: f7daaac4   edi: f7daa998   ebp: c0541d40   esp: c1be9dbc
Oct 26 19:32:21 black ds: 007b   es: 007b   ss: 0068
Oct 26 19:32:21 black Process khubd (pid: 91, threadinfo=c1be8000 task=c19c1a60)
Oct 26 19:32:21 black Stack: c0442404 f7daa800 f7daaacc f7daaac4 f7daa998
c0541d40 c0312374 00000000
Oct 26 19:32:21 black c048d17d f7daaac4 f7daa998 f7432400 f5009a00 c0312389
f7daaac4 f7daa800
Oct 26 19:32:21 black c035a227 f7daaac4 00000003 f7daa800 f7432400 f74323f8
c035a31e f7daa800
Oct 26 19:32:21 black Call Trace:
Oct 26 19:32:21 black [<c0442404>] __down+0xcc/0xdb
Oct 26 19:32:21 black [<c0312374>] class_device_del+0xed/0xf2
Oct 26 19:32:21 black [<c0312389>] class_device_unregister+0x10/0x1d
Oct 26 19:32:21 black [<c035a227>] scsi_remove_device+0x47/0xbd
Oct 26 19:32:21 black [<c035a31e>] __scsi_remove_target+0x81/0xa9
Oct 26 19:32:21 black [<c03592ca>] scsi_forget_host+0x3b/0x61
Oct 26 19:32:21 black [<c0351cc6>] scsi_remove_host+0x17/0x74
Oct 26 19:32:21 black [<f89f7a81>] storage_disconnect+0x60/0x7e [usb_storage]
Oct 26 19:32:21 black [<c0369d06>] usb_unbind_interface+0x7e/0x80
Oct 26 19:32:21 black [<c03112fc>] __device_release_driver+0xa0/0xc2
Oct 26 19:32:21 black [<c031133b>] device_release_driver+0x1d/0x2f
Oct 26 19:32:21 black [<c0310aa7>] bus_remove_device+0x6f/0x82
Oct 26 19:32:21 black [<c030fc5b>] device_del+0x2c/0x6e
Oct 26 19:32:21 black [<c037187b>] usb_disable_device+0xb2/0x125
Oct 26 19:32:21 black [<c036c189>] usb_disconnect+0xb5/0x156
Oct 26 19:32:21 black [<c036d55d>] hub_port_connect_change+0x31f/0x3fa
Oct 26 19:32:21 black [<c036c5c6>] hub_port_status+0x23/0x8f
Oct 26 19:32:21 black [<c036d868>] hub_events+0x230/0x410
Oct 26 19:32:21 black [<c036da61>] hub_thread+0x19/0xe9
Oct 26 19:32:21 black [<c01376d6>] autoremove_wake_function+0x0/0x57
Oct 26 19:32:21 black [<c01376d6>] autoremove_wake_function+0x0/0x57
Oct 26 19:32:21 black [<c036da48>] hub_thread+0x0/0xe9
Oct 26 19:32:21 black [<c0137210>] kthread+0xba/0xf0
Oct 26 19:32:21 black [<c0137156>] kthread+0x0/0xf0
Oct 26 19:32:21 black [<c01010f1>] kernel_thread_helper+0x5/0xb
Oct 26 19:32:21 black Code: c0 89 02 74 03 89 50 04 c7 41 04 00 02 20 00 e9 7c
ff ff ff 83 ec 18 89 5c 24 08 89 74 24 0c 89 7c 24 10 89 6c 24 14 8b 44 24 1c
<8b> 50 10 8b 48 50 85 d2 0f 84 b6 00 00 00 f0 ff 4a 78 0f 88 e2


Expected Results:  
Hard drive should be available as /dev/sda and so on

Portage 2.0.53_rc6 (default-linux/x86/2005.1, gcc-3.4.4, glibc-2.3.5-r2,
2.6.13-gentoo-r5 i686)
=================================================================
System uname: 2.6.13-gentoo-r5 i686 Intel(R) Pentium(R) 4 CPU 2.80GHz
Gentoo Base System version 1.12.0_pre9
distcc 2.18.3 i686-pc-linux-gnu (protocols 1 and 2) (default port 3632) [disabled]
ccache version 2.4 [enabled]
dev-lang/python:     2.2.3-r6, 2.3.5, 2.4.2
sys-apps/sandbox:    1.2.13
sys-devel/autoconf:  2.13, 2.59-r7
sys-devel/automake:  1.4_p6, 1.5, 1.6.3, 1.7.9-r1, 1.8.5-r3, 1.9.6-r1
sys-devel/binutils:  2.16.1
sys-devel/libtool:   1.5.20
virtual/os-headers:  2.6.11-r2
ACCEPT_KEYWORDS="x86 ~x86"
AUTOCLEAN="yes"
CBUILD="i686-pc-linux-gnu"
CFLAGS="-O3 -march=pentium4 -funroll-loops -fprefetch-loop-arrays -pipe"
CHOST="i686-pc-linux-gnu"
CONFIG_PROTECT="/etc /usr/NX/etc /usr/kde/2/share/config /usr/kde/3.4/env
/usr/kde/3.4/share/config /usr/kde/3.4/shutdown /usr/kde/3/share/config
/usr/lib/X11/xkb /usr/lib/mozilla/defaults/pref /usr/share/config
/var/qmail/control"
CONFIG_PROTECT_MASK="/etc/gconf /etc/terminfo /etc/env.d"
CXXFLAGS="-O3 -march=pentium4 -funroll-loops -fprefetch-loop-arrays -pipe"
DISTDIR="/usr/portage/distfiles"
FEATURES="autoconfig ccache distlocks fixpackages sandbox sfperms strict"
GENTOO_MIRRORS="http://distfiles.gentoo.org
http://distro.ibiblio.org/pub/linux/distributions/gentoo"
MAKEOPTS="-j3"
PKGDIR="/usr/portage/packages"
PORTAGE_TMPDIR="/var/tmp"
PORTDIR="/usr/portage"
PORTDIR_OVERLAY="/usr/local/portage"
SYNC="rsync://rsync.us.gentoo.org/gentoo-portage/"
USE="x86 X aalib aim alsa apache2 apm arts audiofile avi berkdb bitmap-fonts
cdparanoia cdr codecs crypt cups curl curlwrappers directfb dvd dvdr dvdread eds
emboss encode esd ethereal evo exif fam flac flash foomaticdb fortran ftp gd
gdbm gif gpm gstreamer gtk gtk2 guile imagemagick imap imlib innodb jabber jack
java joystick jpeg kde kdeenablefinal libg++ libwww mad mikmod mime mmx mng
motif mozilla mp3 mpeg msn ncurses network nls nptl nvidia offensive ogg
oggvorbis opengl oscar oss pam pdflib perl png python qt readline samba scanner
sdl slang sndfile spell sse sse2 ssl svg svga tcltk tcpd tidy tiff truetype
truetype-fonts type1-fonts udev usb videos vorbis wmf xine xml xml2 xmms xpm xv
xvid yahoo zlib video_cards_nvidia userland_GNU kernel_linux elibc_glibc"
Unset:  ASFLAGS, CTARGET, LANG, LC_ALL, LDFLAGS, LINGUAS

Comment 1 Daniel Drake (RETIRED) gentoo-dev

2005-10-27 09:48:45 UTC

Please try and reproduce on the latest development kernel (currently
vanilla-sources-2.6.14_rc5)

Comment 2 Paul Hartman 2005-10-27 17:45:17 UTC

(In reply to comment #1)
> Please try and reproduce on the latest development kernel (currently
> vanilla-sources-2.6.14_rc5)

With vanilla-sources-2.6.14_rc5 it does not Oops, but still does not work. I
turned on verbose logging for USB and usb-storage, here is what it shows:

Oct 27 19:41:51 black hub 1-0:1.0: state 5 ports 6 chg 0000 evt 0040
Oct 27 19:41:51 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 001803
POWER sig=j CSC CONNECT
Oct 27 19:41:51 black hub 1-0:1.0: port 6, status 0501, change 0001, 480 Mb/s
Oct 27 19:41:51 black hub 1-0:1.0: debounce: port 6: total 100ms stable 100ms
status 0x501
Oct 27 19:41:51 black ehci_hcd 0000:00:1d.7: port 6 high speed
Oct 27 19:41:51 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 001005
POWER sig=se0 PE CONNECT
Oct 27 19:41:51 black usb 1-6: new high speed USB device using ehci_hcd and
address 2
Oct 27 19:41:51 black ehci_hcd 0000:00:1d.7: port 6 high speed
Oct 27 19:41:51 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 001005
POWER sig=se0 PE CONNECT
Oct 27 19:41:51 black usb 1-6: default language 0x0409
Oct 27 19:41:51 black usb 1-6: new device strings: Mfr=0, Product=1, SerialNumber=0
Oct 27 19:41:51 black usb 1-6: Product: USB TO IDE
Oct 27 19:41:51 black usb 1-6: hotplug
Oct 27 19:41:51 black usb 1-6: adding 1-6:1.0 (config #1, interface 0)
Oct 27 19:41:51 black usb 1-6:1.0: hotplug
Oct 27 19:41:52 black Initializing USB Mass Storage driver...
Oct 27 19:41:52 black usb-storage 1-6:1.0: usb_probe_interface
Oct 27 19:41:52 black usb-storage 1-6:1.0: usb_probe_interface - got id
Oct 27 19:41:52 black usb-storage: USB Mass Storage device detected
Oct 27 19:41:52 black usb-storage: -- associate_dev
Oct 27 19:41:52 black usb-storage: Vendor: 0x05e3, Product: 0x0702, Revision: 0x0033
Oct 27 19:41:52 black usb-storage: Interface Subclass: 0x06, Protocol: 0x50
Oct 27 19:41:52 black usb-storage: Transport: Bulk
Oct 27 19:41:52 black usb-storage: Protocol: Transparent SCSI
Oct 27 19:41:52 black usb-storage: usb_stor_control_msg: rq=fe rqtype=a1
value=0000 index=00 len=1
Oct 27 19:41:52 black usb-storage: GetMaxLUN command result is 1, data is 0
Oct 27 19:41:52 black usb-storage: *** thread sleeping.
Oct 27 19:41:52 black scsi0 : SCSI emulation for USB Mass Storage devices
Oct 27 19:41:52 black usb-storage: device found at 2
Oct 27 19:41:52 black usb-storage: waiting for device to settle before scanning
Oct 27 19:41:52 black usbcore: registered new driver usb-storage
Oct 27 19:41:52 black USB Mass Storage support registered.
Oct 27 19:41:57 black usb-storage: queuecommand called
Oct 27 19:41:57 black usb-storage: *** thread awakened.
Oct 27 19:41:57 black usb-storage: Command INQUIRY (6 bytes)
Oct 27 19:41:57 black usb-storage:  12 00 00 00 24 00
Oct 27 19:41:57 black usb-storage: Bulk Command S 0x43425355 T 0x1 L 36 F 128
Trg 0 LUN 0 CL 6
Oct 27 19:41:57 black usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 27 19:41:57 black usb-storage: Status code 0; transferred 31/31
Oct 27 19:41:57 black usb-storage: -- transfer complete
Oct 27 19:41:57 black usb-storage: Bulk command transfer result=0
Oct 27 19:41:57 black usb-storage: usb_stor_bulk_transfer_sglist: xfer 36 bytes,
1 entries
Oct 27 19:42:02 black usb-storage: command_abort called
Oct 27 19:42:02 black usb-storage: usb_stor_stop_transport called
Oct 27 19:42:02 black usb-storage: -- cancelling sg request
Oct 27 19:42:02 black usb-storage: Status code -104; transferred 0/36
Oct 27 19:42:02 black usb-storage: -- transfer cancelled
Oct 27 19:42:02 black usb-storage: Bulk data transfer result 0x4
Oct 27 19:42:02 black usb-storage: -- command was aborted
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: port 6 full speed --> companion
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 003001
POWER OWNER sig=se0 CONNECT
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: port 6 full speed --> companion
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 003001
POWER OWNER sig=se0 CONNECT
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: port 6 full speed --> companion
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 003001
POWER OWNER sig=se0 CONNECT
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: port 6 full speed --> companion
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 003001
POWER OWNER sig=se0 CONNECT
Oct 27 19:42:02 black hub 1-0:1.0: logical disconnect on port 6
Oct 27 19:42:02 black usb-storage: usb_reset_device returns -19
Oct 27 19:42:02 black hub 1-0:1.0: state 5 ports 6 chg 0040 evt 0000
Oct 27 19:42:02 black usb-storage: usb_stor_Bulk_reset called
Oct 27 19:42:02 black usb-storage: usb_stor_control_msg: rq=ff rqtype=21
value=0000 index=00 len=0
Oct 27 19:42:02 black usb-storage: Soft reset failed: -19
Oct 27 19:42:02 black usb-storage: scsi command aborted
Oct 27 19:42:02 black hub 1-0:1.0: port 6, status 0501, change 0000, 480 Mb/s
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb 1-6: USB disconnect, address 2
Oct 27 19:42:02 black usb-storage: *** thread sleeping.
Oct 27 19:42:02 black usb-storage: *** thread awakened.
Oct 27 19:42:02 black usb-storage: Command TEST_UNIT_READY (6 bytes)
Oct 27 19:42:02 black usb 1-6: usb_disable_device nuking all URBs
Oct 27 19:42:02 black usb-storage:  00 00 00 00<7>usb 1-6: unregistering
interface 1-6:1.0
Oct 27 19:42:02 black 00 00
Oct 27 19:42:02 black usb-storage: Bulk Command S 0x43425355 T 0x2 L 0 F 0 Trg 0
LUN 0 CL 6
Oct 27 19:42:02 black usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct 27 19:42:02 black usb-storage: Status code -19; transferred 0/31
Oct 27 19:42:02 black usb-storage: -- unknown error
Oct 27 19:42:02 black usb-storage: Bulk command transfer result=4
Oct 27 19:42:02 black usb-storage: -- transport indicates error, resetting
Oct 27 19:42:02 black usb-storage: unable to lock device for reset: -19
Oct 27 19:42:02 black usb-storage: usb_stor_Bulk_reset called
Oct 27 19:42:02 black usb-storage: usb_stor_control_msg: rq=ff rqtype=21
value=0000 index=00 len=0
Oct 27 19:42:02 black usb-storage: storage_disconnect() called
Oct 27 19:42:02 black usb-storage: Soft reset failed: -19
Oct 27 19:42:02 black usb-storage: scsi cmd done, result=0x70000
Oct 27 19:42:02 black usb-storage: usb_stor_stop_transport called
Oct 27 19:42:02 black usb-storage: device_reset called
Oct 27 19:42:02 black usb-storage: *** thread sleeping.
Oct 27 19:42:02 black usb-storage: usb_stor_Bulk_reset called
Oct 27 19:42:02 black usb-storage: No reset during disconnect
Oct 27 19:42:02 black usb-storage: bus_reset called
Oct 27 19:42:02 black usb-storage: No reset during disconnect
Oct 27 19:42:02 black scsi: Device offlined - not ready after error recovery:
host 0 channel 0 id 0 lun 0
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: queuecommand called
Oct 27 19:42:02 black usb-storage: Fail command during disconnect
Oct 27 19:42:02 black usb-storage: device scan complete
Oct 27 19:42:02 black usb-storage: -- usb_stor_release_resources
Oct 27 19:42:02 black usb-storage: -- sending exit command to thread
Oct 27 19:42:02 black usb-storage: -- dissociate_dev
Oct 27 19:42:02 black usb 1-6:1.0: hotplug
Oct 27 19:42:02 black usb 1-6: unregistering device
Oct 27 19:42:02 black usb 1-6: hotplug
Oct 27 19:42:02 black usb-storage: *** thread awakened.
Oct 27 19:42:02 black usb-storage: -- exiting
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: port 6 full speed --> companion
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 003001
POWER OWNER sig=se0 CONNECT
Oct 27 19:42:02 black hub 1-0:1.0: state 5 ports 6 chg 0000 evt 0040
Oct 27 19:42:02 black ehci_hcd 0000:00:1d.7: GetStatus port 6 status 001002
POWER sig=se0 CSC
Oct 27 19:42:02 black hub 1-0:1.0: port 6, status 0100, change 0001, 12 Mb/s
Oct 27 19:42:03 black hub 1-0:1.0: debounce: port 6: total 100ms stable 100ms
status 0x100

Comment 3 Paul Hartman 2005-10-27 21:18:26 UTC

Sorry!!! It turns out the hard drive will ONLY work if it's jumper is set to
MASTER, not slave or cable select. The adapter did not come with any
documentation at all. My apologies.