Hi,

Alan Stern wrote:
> with USB debugging and usb-storage debugging both configured on?  Also, be
> sure to capture the debugging messages -- either configure your syslog
> daemon or use dmesg.
>
OK, here's the debug output when I remove the keychain:

Oct  3 17:41:32 linux kernel: hub 1-1:1.0: port 1, status 100, change 1, 12 Mb/s
Oct  3 17:41:32 linux kernel: usb 1-1.1: USB disconnect, address 4
Oct  3 17:41:32 linux kernel: usb 1-1.1: usb_disable_device nuking all URBs
Oct  3 17:41:32 linux kernel: usb 1-1.1: unregistering interface 1-1.1:1.0
Oct  3 17:41:32 linux kernel: bus usb: remove device 1-1.1:1.0
Oct  3 17:41:32 linux kernel: usb-storage: storage_disconnect() called
Oct  3 17:41:32 linux kernel: usb-storage: usb_stor_stop_transport called
Oct  3 17:41:32 linux kernel: usb-storage: -- dissociate_dev
Oct  3 17:41:32 linux kernel: usb-storage: -- sending exit command to thread
Oct  3 17:41:32 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:32 linux kernel: usb-storage: -- exit command received
Oct  3 17:41:32 linux kernel: usb-storage: -- usb_stor_release_resources finished
Oct  3 17:41:32 linux kernel: drivers/usb/core/usb.c: usb_hotplug
Oct  3 17:41:32 linux kernel: usb 1-1.1: unregistering device
Oct  3 17:41:32 linux kernel: bus usb: remove device 1-1.1
Oct  3 17:41:32 linux kernel: drivers/usb/core/usb.c: usb_hotplug

/sbin/hotplug is called twice:

DEVPATH=/devices/pci0001:01/0001:01:18.0/usb1/1-1/1-1.1/1-1.1:1.0
PATH=/bin:/sbin:/usr/sbin:/usr/bin
ACTION=remove
PWD=/etc/hotplug
SHLVL=2
HOME=/
DEVICE=/proc/bus/usb/001/004
INTERFACE=8/6/80
PRODUCT=58f/9380/100
TYPE=0/0/0
SEQNUM=226

DEVPATH=/devices/pci0001:01/0001:01:18.0/usb1/1-1/1-1.1
PATH=/bin:/sbin:/usr/sbin:/usr/bin
ACTION=remove
PWD=/etc/hotplug
SHLVL=2
HOME=/
SEQNUM=227

I disabled the mount+unmount, which didn't make a difference.

For reference, here's the previous output from inserting it.
Oct  3 17:41:04 linux kernel: hub 1-1:1.0: port 1, status 101, change 1, 12 Mb/s
Oct  3 17:41:04 linux kernel: hub 1-1:1.0: debounce: port 1: delay 100ms stable 4 
status 0x101
Oct  3 17:41:04 linux kernel: hub 1-1:1.0: new USB device on port 1, assigned address 4
Oct  3 17:41:04 linux kernel: usb 1-1.1: new device strings: Mfr=1, Product=2, 
SerialNumber=0
Oct  3 17:41:04 linux kernel: drivers/usb/core/message.c: USB device number 4 default 
language ID 0x409
Oct  3 17:41:04 linux kernel: usb 1-1.1: Product: Mass Storage Device
Oct  3 17:41:04 linux kernel: usb 1-1.1: Manufacturer: Generic
Oct  3 17:41:04 linux kernel: drivers/usb/core/usb.c: usb_hotplug
Oct  3 17:41:04 linux kernel: bus usb: add device 1-1.1
Oct  3 17:41:04 linux kernel: bound device '1-1.1' to driver 'usb'
Oct  3 17:41:04 linux kernel: usb 1-1.1: registering 1-1.1:1.0 (config #1, interface 0)
Oct  3 17:41:04 linux kernel: drivers/usb/core/usb.c: usb_hotplug
Oct  3 17:41:04 linux kernel: bus usb: add device 1-1.1:1.0
Oct  3 17:41:04 linux kernel: usb-storage 1-1.1:1.0: usb_probe_interface
Oct  3 17:41:04 linux kernel: usb-storage 1-1.1:1.0: usb_probe_interface - got id
Oct  3 17:41:04 linux kernel: usb-storage: USB Mass Storage device detected
Oct  3 17:41:04 linux kernel: usb-storage: act_altsetting is 0, id_index is 101
Oct  3 17:41:04 linux kernel: usb-storage: -- associate_dev
Oct  3 17:41:05 linux kernel: usb-storage: Transport: Bulk
Oct  3 17:41:05 linux kernel: usb-storage: Protocol: Transparent SCSI
Oct  3 17:41:05 linux kernel: usb-storage: Endpoints: In: 0xd52fedb4 Out: 0xd52feda0 
Int: 0x00000000 (Period 0)
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_control_msg: rq=fe rqtype=a1 
value=0000 index=00 len=1
Oct  3 17:41:05 linux kernel: usb-storage: GetMaxLUN command result is -32, data is 0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: SLAB: cache with size 320 has lost its name
Oct  3 17:41:05 linux kernel: scsi0 : SCSI emulation for USB Mass Storage devices
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command INQUIRY (6 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  12 00 00 00 24 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x1 L 36 F 128 
Trg 0 LUN 0 CL 6
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 36 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 36/36
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk data transfer result 0x0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x1 R 0 Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel:   Vendor: TwinMOS   Model: Mobile Disk       Rev: 7.77
Oct  3 17:41:05 linux kernel:   Type:   Direct-Access                      ANSI SCSI 
revision: 02
Oct  3 17:41:05 linux kernel: bus scsi: add device 0:0:0:0
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command TEST_UNIT_READY (6 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  00 00 00 00 00 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x2 L 0 F 0 Trg 
0 LUN 0 CL 6
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x2 R 0 Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command READ_CAPACITY (10 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  25 00 00 00 00 00 00 00 00 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x3 L 8 F 128 
Trg 0 LUN 0 CL 10
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 8 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 8/8
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk data transfer result 0x0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x3 R 0 Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: SCSI device sda: 256000 512-byte hdwr sectors (131 MB)
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command MODE_SENSE_10 (10 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  5a 00 08 00 00 00 00 00 08 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x4 L 8 F 128 
Trg 0 LUN 0 CL 10
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 8 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 8/8
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk data transfer result 0x0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x4 R 0 Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command MODE_SENSE_10 (10 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  5a 00 08 00 00 00 00 00 10 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x5 L 16 F 128 
Trg 0 LUN 0 CL 10
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 16 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 8/16
Oct  3 17:41:05 linux kernel: usb-storage: -- short transfer
Oct  3 17:41:05 linux kernel: usb-storage: Bulk data transfer result 0x1
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: ohci-hcd 0001:01:18.0: urb d2e50720 path 1.1 ep2in 
40160000 cc 4 --> status -32
Oct  3 17:41:05 linux kernel: usb-storage: Status code -32; transferred 0/13
Oct  3 17:41:05 linux kernel: usb-storage: clearing endpoint halt for pipe 0xc0010480
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_control_msg: rq=01 rqtype=02 
value=0000 index=82 len=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_clear_halt: result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW (2nd try)...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x5 R 134217728 
Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: SCSI device sda: drive cache: write through
Oct  3 17:41:05 linux kernel:  /dev/scsi/host0/bus0/target0/lun0:<7>usb-storage: 
queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Command READ_10 (10 bytes)
Oct  3 17:41:05 linux kernel: usb-storage:  28 00 00 00 00 00 00 00 08 00
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Command S 0x43425355 T 0x6 L 4096 F 
128 Trg 0 LUN 0 CL 10
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 31/31
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk command transfer result=0
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 
bytes, 1 entries
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 4096/4096
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk data transfer result 0x0
Oct  3 17:41:05 linux kernel: usb-storage: Attempting to get CSW...
Oct  3 17:41:05 linux kernel: usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
Oct  3 17:41:05 linux kernel: usb-storage: Status code 0; transferred 13/13
Oct  3 17:41:05 linux kernel: usb-storage: -- transfer complete
Oct  3 17:41:05 linux kernel: usb-storage: Bulk status result = 0
Oct  3 17:41:05 linux kernel: usb-storage: Bulk Status S 0x53425355 T 0x6 R 0 Stat 0x0
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x0
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel:  p1 p2
Oct  3 17:41:05 linux kernel: Attached scsi disk sda at scsi0, channel 0, id 0, lun 0
Oct  3 17:41:05 linux kernel: bound device '0:0:0:0' to driver 'sd'
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (1:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (2:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (3:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (4:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (5:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (6:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: usb-storage: queuecommand called
Oct  3 17:41:05 linux kernel: usb-storage: *** thread awakened.
Oct  3 17:41:05 linux kernel: usb-storage: Bad target number (7:0)
Oct  3 17:41:05 linux kernel: usb-storage: scsi cmd done, result=0x40000
Oct  3 17:41:05 linux kernel: usb-storage: *** thread sleeping.
Oct  3 17:41:05 linux kernel: WARNING: USB Mass Storage data integrity not assured
Oct  3 17:41:05 linux kernel: USB Mass Storage device found at 4
Oct  3 17:41:05 linux kernel: bound device '1-1.1:1.0' to driver 'usb-storage'

-- 
Matthias Urlichs    |    {M:U} IT Design @ m-u-it.de     |    [EMAIL PROTECTED]
Disclaimer: The quote was selected randomly. Really. | http://smurf.debian.net
 - -
After the correction has been found to be in error, it will be impossible to
fit the original quantity back into the equation.



-------------------------------------------------------
This sf.net email is sponsored by:ThinkGeek
Welcome to geek heaven.
http://thinkgeek.com/sf
_______________________________________________
[EMAIL PROTECTED]
To unsubscribe, use the last form field at:
https://lists.sourceforge.net/lists/listinfo/linux-usb-devel

Reply via email to