Modify

Opened 6 years ago

Closed 5 years ago

Last modified 4 years ago

#11275 closed defect (invalid)

USB hub reset

Reported by: Intaki Owned by: developers
Priority: normal Milestone: Barrier Breaker 14.07
Component: kernel Version: Trunk
Keywords: USB hub reset ehci Cc:

Description

Any USB device resets if connected through USB HUB on TL-WR1043ND.
I try usb HDD and printer. If the device is connected without hub it works, if it is connected through hub, the reset error appears when I write on the device.
Read operation doesn't reset. Also there may be small write ops which don't reset the device. But printing documents or writing a big file resets the device.

Kernel 3.2.5, build from trunk snapshot r30753.

HUB USB 2.0:

device ID: 0x6254
vendor ID: 0x058f (Alcor Micro, Corp.)

I built the same kernel version on gentoo amd64 and it worked fine with and without hub. I think it's a kernel problem with MIPS architecture. The problem is not with power, because the hub has external adapter.

Simular report posts in bug 6779, but I think it's a new bug.
/ticket/6779.html

[322691.970000] EXT4-fs (sda5): mounted filesystem with ordered data mode. Opts: (null)
[322978.030000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322980.630000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322982.830000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322984.660000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322986.790000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322988.800000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322988.930000] sd 6:0:0:0: [sda] Unhandled error code
[322988.930000] sd 6:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[322988.940000] sd 6:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 76 85 8b d0 00 00 08 00
[322988.940000] end_request: I/O error, dev sda, sector 1988463568
[322988.950000] Aborting journal on device sda5-8.
[322991.020000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322993.070000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322995.020000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322996.830000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[322998.450000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[323000.620000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci
[323000.750000] sd 6:0:0:0: [sda] Unhandled error code
[323000.750000] sd 6:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[323000.760000] sd 6:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 76 84 6b 58 00 00 08 00
[323000.760000] end_request: I/O error, dev sda, sector 1988389720
[323000.770000] Buffer I/O error on device sda5, logical block 239632384
[323000.780000] lost page write due to I/O error on sda5
[323000.780000] JBD2: I/O error detected when updating journal superblock for sda5-8.
[323000.790000] journal commit I/O error
[323002.860000] usb 1-1.4: reset high-speed USB device number 12 using ath79-ehci

Attachments (0)

Change History (6)

comment:1 follow-up: Changed 6 years ago by anonymous

You overloaded the power output on the USB Hub.

comment:2 in reply to: ↑ 1 Changed 6 years ago by Intaki

Replying to anonymous:

You overloaded the power output on the USB Hub.

The error occurs also without external power adapter.

I try to compare error log with and without power adapter.

comment:3 Changed 6 years ago by Intaki

This log without external power adapter.
USB HDD has it's own power and it required only 2ma.

$ cat /proc/bus/usb/devices 

T:  Bus=01 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=480  MxCh= 1
B:  Alloc=  0/800 us ( 0%), #Int=  1, #Iso=  0
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=01 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0002 Rev= 3.02
S:  Manufacturer=Linux 3.2.5 ehci_hcd
S:  Product=Atheros built-in EHCI controller
S:  SerialNumber=ar913x-ehci
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#= 21 Spd=480  MxCh= 4
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=01 MxPS=64 #Cfgs=  1
P:  Vendor=058f ProdID=6254 Rev= 1.00
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=100mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   1 Ivl=256ms

T:  Bus=01 Lev=02 Prnt=21 Port=02 Cnt=01 Dev#= 22 Spd=480  MxCh= 0
D:  Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=13fd ProdID=1240 Rev= 2.10
S:  Manufacturer=PI-238  
S:  Product=USB20/SATA Drive
S:  SerialNumber=57442D574D415A4131343437
C:* #Ifs= 1 Cfg#= 1 Atr=c0 MxPwr=  2mA
I:* If#= 0 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=usb-storage
E:  Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=02(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms
[1552788.120000] usb 1-1: new high-speed USB device number 21 using ath79-ehci
[1552788.270000] hub 1-1:1.0: USB hub found
[1552788.270000] hub 1-1:1.0: 4 ports detected
[1552796.320000] usb 1-1.3: new high-speed USB device number 22 using ath79-ehci
[1552796.450000] scsi12 : usb-storage 1-1.3:1.0
[1552797.460000] scsi 12:0:0:0: Direct-Access     PI-238   USB20/SATA Drive 2.10 PQ: 0 ANSI: 4
[1552797.470000] sd 12:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB)
[1552797.480000] sd 12:0:0:0: [sda] Write Protect is off
[1552797.480000] sd 12:0:0:0: [sda] Mode Sense: 21 00 00 00
[1552797.490000] sd 12:0:0:0: [sda] No Caching mode page present
[1552797.490000] sd 12:0:0:0: [sda] Assuming drive cache: write through
[1552797.500000] sd 12:0:0:0: [sda] No Caching mode page present
[1552797.510000] sd 12:0:0:0: [sda] Assuming drive cache: write through
[1552797.540000]  sda: sda1 sda2 sda3 < sda5 >
[1552797.550000] sd 12:0:0:0: [sda] No Caching mode page present
[1552797.550000] sd 12:0:0:0: [sda] Assuming drive cache: write through
[1552797.560000] sd 12:0:0:0: [sda] Attached SCSI disk
[1552798.370000] Adding 2097148k swap on /dev/sda2.  Priority:-1 extents:1 across:2097148k 
[1552799.140000] attempt to access beyond end of device
[1552799.150000] sda3: rw=0, want=4, limit=2
[1552799.150000] EXT4-fs (sda3): unable to read superblock
[1552799.160000] attempt to access beyond end of device
[1552799.160000] sda3: rw=0, want=4, limit=2
[1552799.170000] EXT4-fs (sda3): unable to read superblock
[1552799.170000] attempt to access beyond end of device
[1552799.180000] sda3: rw=0, want=4, limit=2
[1552799.180000] EXT4-fs (sda3): unable to read superblock
[1552800.290000] EXT4-fs (sda5): mounted filesystem with ordered data mode. Opts: (null)
[1552908.890000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552911.670000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552914.310000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552917.420000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552919.890000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552922.280000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552922.410000] sd 12:0:0:0: [sda] Unhandled error code
[1552922.410000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1552922.420000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 76 84 88 28 00 00 28 00
[1552922.430000] end_request: I/O error, dev sda, sector 1988397096
[1552922.430000] Aborting journal on device sda5-8.
[1552924.840000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552926.960000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552929.740000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552932.320000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552934.730000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552937.080000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552937.210000] sd 12:0:0:0: [sda] Unhandled error code
[1552937.210000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1552937.220000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 03 c0 2f 3d 00 00 08 00
[1552937.230000] end_request: I/O error, dev sda, sector 62926653
[1552937.230000] Write-error on swap-device (8:0:62926661)
[1552940.150000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552943.090000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552945.710000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552948.210000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552950.660000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552953.330000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552953.460000] sd 12:0:0:0: [sda] Unhandled error code
[1552953.460000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1552953.470000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 03 c0 2f 45 00 00 08 00
[1552953.480000] end_request: I/O error, dev sda, sector 62926661
[1552953.480000] Write-error on swap-device (8:0:62926669)
[1552956.470000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552959.200000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552961.570000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552963.930000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552966.340000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552968.860000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552968.990000] sd 12:0:0:0: [sda] Unhandled error code
[1552968.990000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1552969.000000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 76 84 6b 58 00 00 08 00
[1552969.010000] end_request: I/O error, dev sda, sector 1988389720
[1552969.010000] Buffer I/O error on device sda5, logical block 239632384
[1552969.020000] lost page write due to I/O error on sda5
[1552969.020000] JBD2: I/O error detected when updating journal superblock for sda5-8.
[1552969.030000] journal commit I/O error
[1552971.720000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552974.460000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552977.230000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552979.770000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552982.580000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552985.230000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552985.360000] sd 12:0:0:0: [sda] Unhandled error code
[1552985.360000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1552985.370000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 6b 60 00 00 08 00
[1552985.380000] end_request: I/O error, dev sda, sector 71330656
[1552985.380000] Buffer I/O error on device sda5, logical block 1
[1552985.390000] lost page write due to I/O error on sda5
[1552987.850000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552990.550000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552993.350000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552996.300000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1552998.980000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553001.390000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553001.520000] sd 12:0:0:0: [sda] Unhandled error code
[1553001.520000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553001.530000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 6c f8 00 00 08 00
[1553001.540000] end_request: I/O error, dev sda, sector 71331064
[1553001.540000] Buffer I/O error on device sda5, logical block 52
[1553001.550000] lost page write due to I/O error on sda5
[1553003.520000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553006.200000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553009.090000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553011.990000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553014.870000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553017.410000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553017.540000] sd 12:0:0:0: [sda] Unhandled error code
[1553017.540000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553017.550000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 8b 68 00 00 08 00
[1553017.560000] end_request: I/O error, dev sda, sector 71338856
[1553017.560000] Buffer I/O error on device sda5, logical block 1026
[1553017.570000] lost page write due to I/O error on sda5
[1553019.630000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553022.270000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553024.980000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553027.490000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553029.970000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553032.870000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553033.000000] sd 12:0:0:0: [sda] Unhandled error code
[1553033.000000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553033.010000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 8b 78 00 00 08 00
[1553033.020000] end_request: I/O error, dev sda, sector 71338872
[1553033.020000] Buffer I/O error on device sda5, logical block 1028
[1553033.030000] lost page write due to I/O error on sda5
[1553035.680000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553038.130000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553040.500000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553042.870000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553045.740000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553048.220000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553048.350000] sd 12:0:0:0: [sda] Unhandled error code
[1553048.350000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553048.360000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 80 6b a0 00 00 08 00
[1553048.370000] end_request: I/O error, dev sda, sector 75525024
[1553048.370000] Buffer I/O error on device sda5, logical block 524297
[1553048.380000] lost page write due to I/O error on sda5
[1553050.930000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553053.750000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553056.040000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553058.480000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553061.410000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553063.900000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553064.030000] sd 12:0:0:0: [sda] Unhandled error code
[1553064.030000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553064.040000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 6a c0 6b 60 00 00 08 00
[1553064.050000] end_request: I/O error, dev sda, sector 1790995296
[1553064.050000] Buffer I/O error on device sda5, logical block 214958081
[1553064.060000] lost page write due to I/O error on sda5
[1553066.210000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553068.530000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553071.340000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553074.600000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553078.130000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553080.220000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553080.350000] sd 12:0:0:0: [sda] Unhandled error code
[1553080.350000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553080.360000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 6b 58 00 00 08 00
[1553080.370000] end_request: I/O error, dev sda, sector 71330648
[1553080.370000] Buffer I/O error on device sda5, logical block 0
[1553080.380000] lost page write due to I/O error on sda5
[1553080.380000] EXT4-fs error (device sda5): ext4_journal_start_sb:327: Detected aborted journal
[1553080.390000] EXT4-fs (sda5): Remounting filesystem read-only
[1553080.400000] EXT4-fs (sda5): previous I/O error to superblock detected
[1553082.720000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553085.560000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553088.310000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553090.980000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553094.080000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553096.450000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553096.580000] sd 12:0:0:0: [sda] Unhandled error code
[1553096.580000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553096.590000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 03 c0 2f 4d 00 00 08 00
[1553096.600000] end_request: I/O error, dev sda, sector 62926669
[1553096.600000] Write-error on swap-device (8:0:62926677)
[1553099.340000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553101.280000] EXT4-fs (sda5): error count: 8
[1553101.280000] EXT4-fs (sda5): initial error at 1333011228: ext4_journal_start_sb:327
[1553101.290000] EXT4-fs (sda5): last error at 1334241307: ext4_journal_start_sb:327
[1553102.290000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553105.060000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553107.880000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553110.600000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553113.260000] usb 1-1.3: reset high-speed USB device number 22 using ath79-ehci
[1553113.390000] sd 12:0:0:0: [sda] Unhandled error code
[1553113.390000] sd 12:0:0:0: [sda]  Result: hostbyte=0x07 driverbyte=0x00
[1553113.400000] sd 12:0:0:0: [sda] CDB: cdb[0]=0x2a: 2a 00 04 40 6b 58 00 00 08 00
[1553113.410000] end_request: I/O error, dev sda, sector 71330648
[1553113.410000] Buffer I/O error on device sda5, logical block 0
[1553113.420000] lost page write due to I/O error on sda5

comment:4 Changed 5 years ago by Intaki

USB works with other HUB. I think this was hardware bug. Close issue.

comment:5 Changed 5 years ago by jogo

  • Resolution set to invalid
  • Status changed from new to closed

comment:6 Changed 4 years ago by jow

  • Milestone changed from Attitude Adjustment 12.09 to Barrier Breaker 14.07

Milestone Attitude Adjustment 12.09 deleted

Add Comment

Modify Ticket

Action
as closed .
The resolution will be deleted. Next status will be 'reopened'.
Author


E-mail address and user name can be saved in the Preferences.

 
Note: See TracTickets for help on using tickets.