Hi All,
we're experiencing ehci stalls on AMD SB710 based systems with a SD
cardreader (AU63xx) behind a SMSC hub + a usblp on the same ehci root hub.
Transfers off the SD card abort like this:
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb f31e4800 ep2in status 0 len 8192/8192
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4.5 urb f454d500 ep2in len 13, qtd f52b9a20 [qh f3149cc0]
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb f454d500 ep2in status 0 len 13/13
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4.5 urb f454d500 ep1out len 31, qtd f52b9360 [qh f5c07480]
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb f454d500 ep1out status 0 len 31/31
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4.5 urb f31e4f00 ep2in len 122880, qtd f52b9420 [qh f3149cc0]
Nov 14 19:19:09 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
[stall - no more irq's in debug/ehci/../registers]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb f31e4f00 ep2in status -115 len 54784/122880
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 0, qtd f52b9000 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0out status 0 len 0/0
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 4, qtd f52b93c0 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0in status 0 len 4/4
Nov 14 19:19:39 (none) user.debug kernel: hub 1-4:1.0: port 5 not reset
yet, waiting 10ms
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 4, qtd f52b9960 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0in status 0 len 4/4
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 0, qtd f52b9000 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0out status 0 len 0/0
Nov 14 19:19:39 (none) user.info kernel: usb 1-4.5: reset high speed USB
device number 40 using ehci_hcd
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4.5 urb e50c4e00 ep0out len 64, qtd f52b9ea0 [qh (null)]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb e50c4e00 ep0in status 0 len 18/64
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 0, qtd f52b93c0 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0out status 0 len 0/0
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 4, qtd f52b9960 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0in status 0 len 4/4
Nov 14 19:19:39 (none) user.debug kernel: hub 1-4:1.0: port 5 not reset
yet, waiting 10ms
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 4, qtd f52b9660 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0in status 0 len 4/4
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e028 Async Periodic Recl IAA FLR
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4 urb e50c4e00 ep0out len 0, qtd f52b93c0 [qh f317ff40]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4 urb e50c4e00 ep0out status 0 len 0/0
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
submit_async 4.5 urb e50c4e00 ep0out len 0, qtd f52b9000 [qh f528b7c0]
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2: irq
status e009 Async Periodic Recl FLR INT
Nov 14 19:19:39 (none) user.debug kernel: ehci_hcd 0000:00:12.2:
ehci_urb_done 4.5 urb e50c4e00 ep0out status 0 len 0/0
#cat /sys/kernel/debug/usb/ehci/0000\:00\:12.2/registers
bus pci, device 0000:00:12.2
EHCI Host Controller
EHCI 1.00, hcd state 1
ownership 00000001
SMI sts/enable 0x40080000
structural params 0x00102306
capability params 0x0000a072
status e008 Async Periodic Recl FLR
command 0010035 (park)=0 ithresh=1 Async Periodic period=512 RUN
intrenable 37 IAA FATAL PCD ERR INT
uframe 22ef
port:1 status 001000 0 ACK POWER sig=se0
port:2 status 001000 0 ACK POWER sig=se0
port:3 status 001005 0 ACK POWER sig=se0 PE CONNECT
port:4 status 001005 0 ACK POWER sig=se0 PE CONNECT
port:5 status 001000 0 ACK POWER sig=se0
port:6 status 003000 0 ACK POWER OWNER sig=se0
irq normal 263667 err 432 reclaim 116795 (lost 0)
complete 263885 unlink 83
There is a usblp device connected to port 3. hub+sd reader on port 4.
This is on 2.6.39-4.
We've tried 3.2-next20111114. Tried to remove the amd_pll_quirk.
Also cross checked the AMD SB Eratta (made sure that the async park mode
is disabled).
Problem also occurs when ohci is unloaded.
Problem is gone with a NEC PCI ehci in the same system. A couple of
nforce ehci's didn't show the problem either.
SMSC 2504 (older) seem ok. SMSC 2507, 2514, 2517 are having problems.
A Cypress hub was also ok - an older philips hub also showed the same
problem.
Any pointers ?
thanks,
- sda
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
