[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"

2016-08-08 Thread bugzilla-noreply 
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=208959

--- Comment #4 from Jamie Ivanov  ---
Bueller?

-- 
You are receiving this mail because:
You are the assignee for the bug.
___
freebsd-usb@freebsd.org mailing list
https://lists.freebsd.org/mailman/listinfo/freebsd-usb
To unsubscribe, send any mail to "freebsd-usb-unsubscr...@freebsd.org"

[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"

2016-04-22 Thread bugzilla-noreply 
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=208959

--- Comment #3 from Hans Petter Selasky  ---
In sys/dev/usb/controller/uhci.c try to change:

/* get acknowledge bits */
status &= (UHCI_STS_USBINT |
UHCI_STS_USBEI |
UHCI_STS_RD |
UHCI_STS_HSE |
UHCI_STS_HCPE |
UHCI_STS_HCH);

Into:

/* get acknowledge bits */
status &= (UHCI_STS_USBINT |
UHCI_STS_USBEI |
UHCI_STS_RD |
UHCI_STS_HSE |
UHCI_STS_HCPE);

I'm not sure if it helps.

--HPS

-- 
You are receiving this mail because:
You are the assignee for the bug.
___
freebsd-usb@freebsd.org mailing list
https://lists.freebsd.org/mailman/listinfo/freebsd-usb
To unsubscribe, send any mail to "freebsd-usb-unsubscr...@freebsd.org"

[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"

2016-04-21 Thread bugzilla-noreply 
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=208959

--- Comment #2 from Jamie Ivanov  ---
I didn't let this run very long but this is what I kicked-up:

$ sudo sysctl hw.usb.uhci.debug=16; tail -f /var/log/messages
hw.usb.uhci.debug: 0 -> 16
Apr 21 20:28:12 irony kernel: uhci_interrupt: real interrupt
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_interrupt: uhci_interrupt: host controller
halted
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046844f000) at
0x07a4f002: h_next=0x07a50002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046845) at
0x07a50002: h_next=0x07a51002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468451000) at
0x07a51002: h_next=0x07a52002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468452000) at
0x07a52002: h_next=0x0001 e_next=0x07a53000
# ^^^ spamming
...
Apr 21 20:28:12 irony kernel: uhci_interrupt: real interrupt
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_interrupt: uhci_interrupt: host controller
halted
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046844f000) at
0x07a4f002: h_next=0x07a50002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046845) at
0x07a50002: h_next=0x07a51002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468451000) at
0x07a51002: h_next=0x07a52002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468452000) at
0x07a52002: h_next=0x0001 e_next=0x07a53000
Apr 21 20:28:12 irony kernel: uhci_interrupt: real interrupt
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: 
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: 
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: Some USB transfer is active on
unit 0.
Apr 21 20:28:12 irony kernel: uhci_interrupt: uhci_interrupt: host controller
halted
Apr 21 20:28:12 irony kernel: uhci_restart: Already started
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_roothub_exec: type=0xa3 request=0x00
wLen=0x0004 wValue=0x wIndex=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046844f000) at
0x07a4f002: h_next=0x07a50002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_roothub_exec: type=0xa3 request=0x00
wLen=0x0004 wValue=0x wIndex=0x0002
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046845) at
0x07a50002: h_next=0x07a51002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468451000) at
0x07a51002: h_next=0x07a52002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: Power save on unit 1.
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468452000) at
0x07a52002: h_next=0x0001 e_next=0x07a53000
Apr 21 20:28:12 irony kernel: uhci_roothub_exec: type=0xa3 request=0x00
wLen=0x0004 wValue=0x wIndex=0x0001
Apr 21 20:28:12 irony kernel: uhci_interrupt: real interrupt
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: 
Apr 21 20:28:12 irony kernel: uhci_roothub_exec: type=0xa3 request=0x00
wLen=0x0004 wValue=0x wIndex=0x0002
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_interrupt: uhci_interrupt: host controller
halted
Apr 21 20:28:12 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046844f000) at
0x07a4f002: h_next=0x07a50002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe046845) at
0x07a50002: h_next=0x07a51002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468451000) at
0x07a51002: h_next=0x07a52002 e_next=0x0001
Apr 21 20:28:12 irony kernel: uhci_dump_qh: QH(0xfe0468452000) at
0x07a52002: h_next=0x0001 e_next=0x07a53000
Apr 21 20:28:12 irony kernel: uhci_set_hw_power: Power save on unit 2.
Apr 21 20:28:12 irony kernel: uhci_interrupt: real interrupt
Apr 21 20:28:12 irony kernel: uhci_dumpregs:

[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"

2016-04-21 Thread bugzilla-noreply 
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=208959

Hans Petter Selasky  changed:

   What|Removed |Added

 CC||hsela...@freebsd.org

--- Comment #1 from Hans Petter Selasky  ---
Can you set the UHCI debug to 16 and find out which interrupts are triggered?

--HPS

-- 
You are receiving this mail because:
You are the assignee for the bug.
___
freebsd-usb@freebsd.org mailing list
https://lists.freebsd.org/mailman/listinfo/freebsd-usb
To unsubscribe, send any mail to "freebsd-usb-unsubscr...@freebsd.org"

[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"

2016-04-21 Thread bugzilla-noreply 
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=208959

Bug ID: 208959
   Summary: UHCI interrupt storm with "uhci_interrupt:
uhci_interrupt: host controller halted"
   Product: Base System
   Version: 10.3-RELEASE
  Hardware: amd64
OS: Any
Status: New
  Severity: Affects Only Me
  Priority: ---
 Component: usb
  Assignee: freebsd-usb@FreeBSD.org
  Reporter: jamie.iva...@gmail.com
CC: freebsd-am...@freebsd.org
CC: freebsd-am...@freebsd.org

Created attachment 169528
  --> https://bugs.freebsd.org/bugzilla/attachment.cgi?id=169528=edit
dmesg.today

After noticing unusual interrupt load, I did some investigating and ended up
both confused and concerned. The only USB device plugged in to the server is a
keyboard but it's plugged in to a different USB device than the one which is
hogging the interrupts.

I will continue looking into this but otherwise feel free to chime in with any
additional information you would like me to collect. 

$ uname -a
FreeBSD irony 10.3-RELEASE FreeBSD 10.3-RELEASE #0 r297264: Fri Mar 25 02:10:02
UTC 2016 r...@releng1.nyi.freebsd.org:/usr/obj/usr/src/sys/GENERIC  amd64


$ vmstat -i
interrupt  total   rate
irq1: atkbd0   6  0
irq14: ata0  175  0
irq17: uhci0 ehci029  0
irq18: uhci2 85293579481 263953
cpu0:timer  14857259 45
irq256: em021006650
irq258: mpt020452356 63
cpu5:timer  15795381 48
cpu7:timer 364040490   1126
cpu1:timer  27906242 86
cpu3:timer   8760608 27
cpu2:timer   7602596 23
cpu6:timer  15839120 49
cpu4:timer  15563089 48
Total85994461276 266122


$ systat -v
2 usersLoad  0.62  0.60  0.53  Apr 21 15:52

Mem:KBREALVIRTUAL   VN PAGER   SWAP PAGER
Tot   Share  TotShareFree   in   out in   out
Act  193620   26768  269546871372  490820  count
All  213368   34804  2913604   205836  pages
Proc:Interrupts
  r   p   d   s   w   Csw  Trp  Sys  Int  Sof  Fltioflt  272k total
127   3  534k 6826 3588 267k   64 2127cow atkbd0 1
 2127 zfodata0 14
12.5%Sys   3.1%Intr  0.0%User  0.0%Nice 84.4%Idle ozfod   uhci0
ehci
||||||||||   %ozfod  269k uhci2 18
==++  daefr  1080
cpu0:timer
   dtbuf  prcfr   127 em0 256
Namei Name-cache   Dir-cache350179 desvn  totfr   mpt0 258
   Callshits   %hits   %122969 numvn  react64
cpu5:timer
   8   8 100 87543 frevn  pdwak  1175
cpu7:timer
  pdpgs  
cpu1:timer
Disks  ada0   da0   da1   da2   da3   da4   da5   intrn  
cpu3:timer
KB/t   0.00  0.00  0.00  0.00  0.00  0.00  0.00  15174496 wire   
cpu2:timer
tps   0 0 0 0 0 0 0  5852 act  64
cpu6:timer
MB/s   0.00  0.00  0.00  0.00  0.00  0.00  0.00629748 inact64
cpu4:timer
%busy 0 0 0 0 0 0 0   cache
   490904 free 
  buf


$ sudo sysctl hw.usb.uhci.debug=15
$ sudo tail -f /var/log/messages
...
Apr 21 14:26:11 irony kernel: uhci_dump_qh: QH(0xfe046844f000) at
0x07a4f002: h_next=0x07a50002 e_next=0x0001
Apr 21 14:26:11 irony kernel: uhci_dump_qh: QH(0xfe046845) at
0x07a50002: h_next=0x07a51002 e_next=0x0001
Apr 21 14:26:11 irony kernel: uhci_dump_qh: QH(0xfe0468451000) at
0x07a51002: h_next=0x07a52002 e_next=0x0001
Apr 21 14:26:11 irony kernel: uhci_dump_qh: QH(0xfe0468452000) at
0x07a52002: h_next=0x0001 e_next=0x07a53000
Apr 21 14:26:11 irony kernel: uhci_interrupt: uhci_interrupt: host controller
halted
Apr 21 14:26:11 irony kernel: uhci_dumpregs: usbus2 regs: cmd=0080, sts=0020,
intr=000f, frnum=01b6, flbase=07a4e6d8, sof=0040, portsc1=0080, portsc2=0080
...
# ^^^ spamming
$ sudo sysctl hw.usb.uhci.debug=0
hw.usb.uhci.debug: 15 -> 0


$ sudo sysctl hw.usb.debug=15; tail -f /var/log/messages
...
Apr 21 15:22:41 irony kernel: usbd_do_request_flags: udev=0xf80030eb4000
bmRequestType=0xa3 bRequest=0x00 wValue=0x wIndex=0x0001