Dear All
I am running kernel 2.6.29-rc3 on a board with OMAP 3503 with OTG and EHCI controller enabled, and using USB port 2 on OMAP.
The issue that I see is that USB flash drive detection succeeds but when I try to mount the filesystem on flash drive , the usb hub reset and disconnects and does not come up again until I reboot the system . Below is the detailed log of this issue which show the error messages and along with other debug messages
As anyone faced this problem or similar problem ?
Any help on debugging this issue is greatly appreciated
--------------------------- usb log ------------------------------------------------------
root@12:/# lsusb
Bus 001 Device 002: ID 0409:005a NEC Corp. HighSpeed Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
root@12:/#
root@12:/#
root@12:/# lsusb
Bus 001 Device 002: ID 0409:005a NEC Corp. HighSpeed Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
root@12:/#
<7>hub 1-2:1.0: state 7 ports 4 chg 0000 evt 0002
<7>hub 1-2:1.0: port 1, status 0101, change 0001, 12 Mb/s
<7>hub 1-2:1.0: debounce: port 1: total 100ms stable 100ms status 0x101
<7>hub 1-2:1.0: port 1 not reset yet, waiting 10ms
<6>usb 1-2.1: new high speed USB device using ehci-omap and address 3
<7>hub 1-2:1.0: port 1 not reset yet, waiting 10ms
<7>usb 1-2.1: default language 0x0409
<6>usb 1-2.1: New USB device found, idVendor=0781, idProduct=5567
<6>usb 1-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
<6>usb 1-2.1: Product: Cruzer Blade
<6>usb 1-2.1: Manufacturer: SanDisk
<6>usb 1-2.1: SerialNumber: 324843030160C938
<7>device: '1-2.1': device_add
<7>bus: 'usb': add device 1-2.1
<7>PM: Adding info for usb:1-2.1
<7>usb 1-2.1: uevent
<7>bus: 'usb': driver_probe_device: matched device 1-2.1 with driver usb
<7>bus: 'usb': really_probe: probing driver usb with device 1-2.1
<7>usb 1-2.1: usb_probe_device
<6>usb 1-2.1: configuration #1 chosen from 1 choice
<7>usb 1-2.1: adding 1-2.1:1.0 (config #1, interface 0)
<7>device: '1-2.1:1.0': device_add
<7>bus: 'usb': add device 1-2.1:1.0
<7>PM: Adding info for usb:1-2.1:1.0
<7>usb 1-2.1:1.0: uevent
<7>bus: 'usb': driver_probe_device: matched device 1-2.1:1.0 with driver usb-storage
<7>bus: 'usb': really_probe: probing driver usb-storage with device 1-2.1:1.0
<7>usb-storage 1-2.1:1.0: usb_probe_interface
<7>usb-storage 1-2.1:1.0: usb_probe_interface - got id
<6>scsi0 : SCSI emulation for USB Mass Storage devices
<7>device: 'host0': device_add
<7>PM: Adding info for No Bus:host0
<7>device: 'host0': device_add
<7>PM: Adding info for No Bus:host0
<7>driver: '1-2.1:1.0': driver_bound: bound to device 'usb-storage'
<7>bus: 'usb': really_probe: bound device 1-2.1:1.0 to driver usb-storage
<7>device: 'usbdev1.3_ep81': device_add
<7>PM: Adding info for No Bus:usbdev1.3_ep81
<7>device: 'usbdev1.3_ep02': device_add
<7>PM: Adding info for No Bus:usbdev1.3_ep02
<7>drivers/usb/core/inode.c: creating file '003'
<7>driver: '1-2.1': driver_bound: bound to device 'usb'
<7>bus: 'usb': really_probe: bound device 1-2.1 to driver usb
<7>device: 'usbdev1.3_ep00': device_add
<7>PM: Adding info for No Bus:usbdev1.3_ep00
<7>hub 1-2:1.0: state 7 ports 4 chg 0000 evt 0002
<7>usb-storage: device found at 3
<7>usb-storage: waiting for device to settle before scanning
root@12:/# <5>scsi 0:0:0:0: Direct-Access SanDisk Cruzer Blade 8.02 PQ: 0 ANSI: 0 CCS
<7>device: 'target0:0:0': device_add
<7>PM: Adding info for No Bus:target0:0:0
<7>device: '0:0:0:0': device_add
<7>bus: 'scsi': add device 0:0:0:0
<7>PM: Adding info for scsi:0:0:0:0
<7>bus: 'scsi': driver_probe_device: matched device 0:0:0:0 with driver sd
<7>bus: 'scsi': really_probe: probing driver sd with device 0:0:0:0
<7>device: '0:0:0:0': device_add
<7>PM: Adding info for No Bus:0:0:0:0
<5>sd 0:0:0:0: [sda] 3907583 512-byte hardware sectors: (2.00 GB/1.86 GiB)
<5>sd 0:0:0:0: [sda] Write Protect is off
<7>sd 0:0:0:0: [sda] Mode Sense: 45 00 00 08
<3>sd 0:0:0:0: [sda] Assuming drive cache: write through
<7>device: 'sda': device_add
<7>PM: Adding info for No Bus:sda
<5>sd 0:0:0:0: [sda] 3907583 512-byte hardware sectors: (2.00 GB/1.86 GiB)
<5>sd 0:0:0:0: [sda] Write Protect is off
<7>sd 0:0:0:0: [sda] Mode Sense: 45 00 00 08
<3>sd 0:0:0:0: [sda] Assuming drive cache: write through
<6> sda: sda1
<7>device: 'sda1': device_add
<7>PM: Adding info for No Bus:sda1
<7>device: '8:0': device_add
<7>PM: Adding info for No Bus:8:0
<5>sd 0:0:0:0: [sda] Attached SCSI removable disk
<7>driver: '0:0:0:0': driver_bound: bound to device 'sd'
<7>bus: 'scsi': really_probe: bound device 0:0:0:0 to driver sd
<7>device: '0:0:0:0': device_add
<7>PM: Adding info for No Bus:0:0:0:0
<7>usb-storage: device scan complete
root@12:/#
root@12:/# root@12:/# mount /dev/sda
sda sda1
root@12:/# mount /dev/sda1 /mnt/
<7>ehci-omap ehci-omap.0: devpath 2.1 ep2out 3strikes
<7>hub 1-2:1.0: port 1 not reset yet, waiting 10ms
<6>usb 1-2.1: reset high speed USB device using ehci-omap and address 3
<7>ehci-omap ehci-omap.0: devpath 2.1 ep0in 3strikes
<7>ehci-omap ehci-omap.0: devpath 2.1 ep0in 3strikes
<7>hub 1-0:1.0: state 7 ports 3 chg 0000 evt 0004
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001809 POWER sig=j PEC CONNECT
<7>hub 1-0:1.0: port 2 enable change, status 00000501
<3>hub 1-0:1.0: port 2 disabled by hub (EMI?), re-enabling...
<7>hub 1-0:1.0: port 2, status 0501, change 0002, 480 Mb/s
<6>usb 1-2: USB disconnect, address 2
<6>usb 1-2.1: USB disconnect, address 0
<3>hub 1-2:1.0: cannot reset port 1 (err = -19)
<3>hub 1-2:1.0: cannot disable port 1 (err = -19)
<7>hub 1-2:1.0: logical disconnect on port 1
<3>hub 1-2:1.0: cannot disable port 1 (err = -19)
<6>sd 0:0:0:0: [sda] Unhandled error code
<6>sd 0:0:0:0: [sda] Result: hostbyte=0x07 driverbyte=0x00
<3>end_request: I/O error, dev sda, sector 608
<3>FAT: Directory bread(block 479) failed
<6>sd 0:0:0:0: [sda] Unhandled error code
<6>sd 0:0:0:0: [sda] Result: hostbyte=0x07 driverbyte=0x00
<3>end_request: I/O error, dev sda, sector 609
<3>FAT: Directory bread(block 480) failed
<7>usb 1-2.1: unregistering device
<7>usb 1-2.1: usb_disable_device nuking all URBs
<7>usb 1-2.1: unregistering interface 1-2.1:1.0
<7>device: 'usbdev1.3_ep81': device_unregister
<7>PM: Removing info for No Bus:usbdev1.3_ep81
<7>device: 'usbdev1.3_ep02': device_unregister
<7>PM: Removing info for No Bus:usbdev1.3_ep02
<7>PM: Removing info for usb:1-2.1:1.0
<7>bus: 'usb': remove device 1-2.1:1.0
<7>device: '0:0:0:0': device_unregister
<7>PM: Removing info for No Bus:0:0:0:0
<7>PM: Removing info for scsi:0:0:0:0
<7>bus: 'scsi': remove device 0:0:0:0
<7>PM: Removing info for No Bus:0:0:0:0
<6>sd 0:0:0:0: [sda] Unhandled error code
<6>sd 0:0:0:0: [sda] Result: hostbyte=0x01 driverbyte=0x00
<3>end_request: I/O error, dev sda, sector 610
<3>FAT: Directory bread(block 481) failed
<3>FAT: Directory bread(block 482) failed
<3>FAT: Directory bread(block 483) failed
<3>FAT: Directory bread(block 484) failed
<3>FAT: Directory bread(block 485) failed
<3>FAT: Directory bread(block 486) failed
<3>FAT: Directory bread(block 487) failed
<3>FAT: Directory bread(block 488) failed
<3>FAT: Directory bread(block 489) failed
<3>FAT: Directory bread(block 490) failed
<3>FAT: Directory bread(block 491) failed
<3>FAT: Directory bread(block 492) failed
<3>FAT: Directory bread(block 493) failed
<3>FAT: Directory bread(block 494) failed
<3>FAT: Directory bread(block 495) failed
<3>FAT: Directory bread(block 496) failed
<3>FAT: Directory bread(block 497) failed
<3>FAT: Directory bread(block 498) failed
<3>FAT: Directory bread(block 499) failed
<3>FAT: Directory bread(block 500) failed
<3>FAT: Directory bread(block 501) failed
<3>FAT: Directory bread(block 502) failed
<3>FAT: Directory bread(block 503) failed
<3>FAT: Directory bread(block 504) failed
<3>FAT: Directory bread(block 505) failed
<3>FAT: Directory bread(block 506) failed
<3>FAT: Directory bread(block 507) failed
<3>FAT: Directory bread(block 508) failed
<3>FAT: Directory bread(block 509) failed
<3>FAT: Directory bread(block 510) failed
<7>PM: Removing info for No Bus:sda1
<7>device: '8:0': device_unregister
<7>PM: Removing info for No Bus:8:0
<7>device: '8:0': device_create_release
<7>PM: Removing info for No Bus:sda
<7>device: 'host0': device_unregister
<7>PM: Removing info for No Bus:host0
<7>PM: Removing info for No Bus:host0
root@12:/# <7>usb 1-2.1:1.0: uevent
<7>device: 'usbdev1.3_ep00': device_unregister
<7>PM: Removing info for No Bus:usbdev1.3_ep00
<7>PM: Removing info for usb:1-2.1
<7>bus: 'usb': remove device 1-2.1
<7>usb 1-2.1: uevent
<7>usb 1-2: unregistering device
<7>usb 1-2: usb_disable_device nuking all URBs
<7>usb 1-2: unlink qh256-0001/ff201100 start 255 [1/0 us]
<7>ehci-omap ehci-omap.0: shutdown urb 9f53d640 ep1in-intr
<7>usb 1-2: unregistering interface 1-2:1.0
<7>device: 'usbdev1.2_ep81': device_unregister
<7>PM: Removing info for No Bus:usbdev1.2_ep81
<7>PM: Removing info for usb:1-2:1.0
<7>bus: 'usb': remove device 1-2:1.0
<7>usb 1-2:1.0: uevent
<7>device: 'usbdev1.2_ep00': device_unregister
<7>PM: Removing info for No Bus:usbdev1.2_ep00
<7>PM: Removing info for usb:1-2
<7>bus: 'usb': remove device 1-2
<7>usb 1-2: uevent
<7>hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms status 0x501
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 50ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<3>hub 1-0:1.0: Cannot enable port 2. Maybe the USB cable is bad?
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 50ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<3>hub 1-0:1.0: Cannot enable port 2. Maybe the USB cable is bad?
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 50ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<3>hub 1-0:1.0: Cannot enable port 2. Maybe the USB cable is bad?
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 50ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<7>ehci-omap ehci-omap.0: port 2 full speed --> companion
<7>ehci-omap ehci-omap.0: GetStatus port 2 status 001801 POWER sig=j CONNECT
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port 2 not reset yet, waiting 200ms
<7>hub 1-0:1.0: port_wait_reset: err = -16
<7>hub 1-0:1.0: port 2 not enabled, trying reset again...
<3>hub 1-0:1.0: Cannot enable port 2. Maybe the USB cable is bad?
<3>hub 1-0:1.0: unable to enumerate USB device on port 2
root@12:/# lsusb
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
root@12:/#
root@12:/#
--------------------------- usb log ------------------------------------------------------
Thanks
Pads