[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"
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"
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"
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: usbus2 regs: cmd=0080, sts
[Bug 208959] UHCI interrupt storm with "uhci_interrupt: uhci_interrupt: host controller halted"
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"
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&action=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=