usb/172199: high interrupts load xhci

[Hans Petter Selasky]

On Monday 01 October 2012 10:15:48 Aleksei Reytsman wrote:
> >Number:         172199
> >Category:       usb
> >Synopsis:       high interrupts load xhci
> >Confidential:   no
> >Severity:       non-critical
> >Priority:       low
> >Responsible:    freebsd-usb
> >State:          open
> >Quarter:
> >Keywords:
> >Date-Required:
> >Class:          sw-bug
> >Submitter-Id:   current-users
> >Arrival-Date:   Mon Oct 01 08:20:03 UTC 2012
> >Closed-Date:
> >Last-Modified:
> >Originator:     Aleksei Reytsman
> >Release:        9.0
> 
> >Organization:
> Solvex-Tourne ltd
> 
> >Environment:
> # uname -a
> FreeBSD servergate 9.0-RELEASE FreeBSD 9.0-RELEASE #0: Wed Mar 28 15:00:36
> MSK 2012     root at servergate:/usr/src/sys/amd64/compile/MYKERNEL  amd64
> 
> >Description:
> Hello.
> I have a very high interrupts load on my FreeBSD machine. It happens when i
> plug any USB device (like a keyboard), and the load is still high after
> disconnecting the device. It becomes normal after reboot. My system based
> on ASUS P8Z68-V Pro/Gen3 motherboard.
> MYKERNEL is the GENERIC kernel with ipfw support.
> Sorry for bad English.
> Some debug information below:
> 
> # vmstat -i
> interrupt                          total       rate
> irq16: xhci1                 10760525071      17776
> irq23: ehci0 ehci1               1826517          3
> cpu0:timer                     619928626       1024
> irq256: em0:rx 0                54277776         89
> irq257: em0:tx 0                42013316         69
> irq258: em0:link                       2          0
> irq262: em2:rx 0               541775211        895
> irq263: em2:tx 0               498677204        823
> irq264: em2:link                       1          0
> irq265: em3:rx 0               300580772        496
> irq266: em3:tx 0               593156009        979
> irq268: ahci0                    5757554          9
> cpu1:timer                     123236782        203
> cpu3:timer                     100504666        166
> cpu2:timer                      58767827         97
> Total                        13701027334      22634
> 
> # systat -vmstat
>     1 users    Load  0.32  0.51  0.50                  Oct  1 11:52
> 
> Mem:KB    REAL            VIRTUAL                       VN PAGER   SWAP
> PAGER Tot   Share      Tot    Share    Free           in   out     in  
> out Act 1481080  158408  5595688   175752 2913052  count
> All 1581028  164260 1079516k   209568          pages
> Proc:                                                            Interrupts
>   r   p   d   s   w   Csw  Trp  Sys  Int  Sof  Flt        cow    173k total
>             137      349k   24  122 171k 1055    3        zfod   166k xhci1
> 16 ozfod     3 ehci0 ehci 0.1%Sys  18.0%Intr  0.0%User  0.0%Nice 81.9%Idle
>        %ozfod  1128 cpu0:timer
> 
> |    |    |    |    |    |    |    |    |    |    |       daefr    76 em0:rx
> |    |    |    |    |    |    |    |    |    |    |       0
> 
> +++++++++                                                 prcfr    72
> em0:tx 0 17 dtbuf        3 totfr       em0:link Namei     Name-cache  
> Dir-cache    204931 desvn          react  1216 em2:rx 0 Calls    hits   % 
>   hits   %    179871 numvn          pdwak  1146 em2:tx 0 353     353 100  
>               49693 frevn          pdpgs       em2:link intrn   933 em3:rx
> 0 Disks  ada0  ada1 pass0 pass1                      731484 wire   1312
> em3:tx 0 KB/t  30.98 30.98  0.00  0.00                     1123916 act    
>  24 ahci0 268 tps      12    12     0     0                     3233464
> inact   914 cpu1:timer MB/s   0.35  0.35  0.00  0.00                      
>   276 cache   139 cpu3:timer %busy     0     0     0     0                
>     2912776 free     72 cpu2:timer 837152 buf
> # pciconf -lv
> hostb0 at pci0:0:0:0:      class=0x060000 card=0x844d1043 chip=0x01008086
> rev=0x09 hdr=0x00 vendor     = 'Intel Corporation'
>     device     = '2nd Generation Core Processor Family DRAM Controller'
>     class      = bridge
>     subclass   = HOST-PCI
> - - - - -
> xhci0 at pci0:4:0:0:       class=0x0c0330 card=0x84881043 chip=0x10421b21
> rev=0x00 hdr=0x00 vendor     = 'ASMedia Technology Inc.'
>     device     = 'ASM1042 SuperSpeed USB Host Controller'
>     class      = serial bus
>     subclass   = USB
> - - - - -
> xhci1 at pci0:7:0:0:       class=0x0c0330 card=0x84881043 chip=0x10421b21
> rev=0x00 hdr=0x00 vendor     = 'ASMedia Technology Inc.'
>     device     = 'ASM1042 SuperSpeed USB Host Controller'
>     class      = serial bus
>     subclass   = USB
> 
> >How-To-Repeat:
> Plug any USB device.
> 
> >Fix:
> >
> >
> >Release-Note:
> >Audit-Trail:
> 
> >Unformatted:

Hi,

Can you collect some dmesg?

sysctl hw.usb.xhci.debug=16 ; sleep 1; sysctl hw.usb.xhci.debug=0

--HPS