Re[2]: 2 day GENERIC-current eat 2 CPU core at 100%

From: Andrey Smagin <samspeed_at_mail.ru>
Date: Thu, 09 Jun 2011 14:49:02 +0400
Hi, yesterday I tried switch  event timer on i8254 - it do nothing.
I disabled hyperthreading - now eat from 50% to 100%
All dmesg is lines:
(noperiph:ata3:0:-1:-1): rescan already queued
(noperiph:ata3:0:-1:-1): rescan already queued
(noperiph:ata2:0:-1:-1): rescan already queued
(noperiph:ata3:0:-1:-1): rescan already queued
(noperiph:ata3:0:-1:-1): rescan already queued
....
I  boot FreeBSD from USB with no ATA - may be it is.

%sysctl -a | grep event
kern.eventtimer.choice: HPET(450) HPET1(440) HPET2(440) LAPIC(400) i8254(100) RTC(0)
kern.eventtimer.et.LAPIC.flags: 15
kern.eventtimer.et.LAPIC.frequency: 0
kern.eventtimer.et.LAPIC.quality: 400
kern.eventtimer.et.HPET.flags: 3
kern.eventtimer.et.HPET.frequency: 14318180
kern.eventtimer.et.HPET.quality: 450
kern.eventtimer.et.HPET1.flags: 3
kern.eventtimer.et.HPET1.frequency: 14318180
kern.eventtimer.et.HPET1.quality: 440
kern.eventtimer.et.HPET2.flags: 3
kern.eventtimer.et.HPET2.frequency: 14318180
kern.eventtimer.et.HPET2.quality: 440
kern.eventtimer.et.RTC.flags: 17
kern.eventtimer.et.RTC.frequency: 32768
kern.eventtimer.et.RTC.quality: 0
kern.eventtimer.et.i8254.flags: 1
kern.eventtimer.et.i8254.frequency: 1193182
kern.eventtimer.et.i8254.quality: 100
kern.eventtimer.periodic: 1
kern.eventtimer.timer: i8254
kern.eventtimer.idletick: 0
kern.eventtimer.singlemul: 2
"ifnet_rw","eventhandler"
"eventhandler","eventhandler list"
"so_rcv","eventhandler"
"lle","eventhandler"
"Giant","intr event list"
"Giant","eventhandler"
"Giant","eventhandler list"
"Giant","intr event"
"proctree","clone events drain lock"
"clone events drain lock","cdev"
"clone events drain lock","eventhandler"
"clone events drain lock","eventhandler list"
"devfs","clone events drain lock"
"MD config lock","eventhandler"
hw.mfi.event_class: 0
hw.mfi.event_locale: 65535

CL\PU load is waves with period about 20sec.
_____________________________________________________________
%systat -vmstat
    2 users    Load  3,47  2,85  2,80                   9 июн 14:45

Mem:KB    REAL            VIRTUAL                       VN PAGER   SWAP PAGER
        Tot   Share      Tot    Share    Free           in   out     in   out
Act   16696    3772   285868     5120   51636  count
All   94204    5096  2449788    22376          pages
Proc:                                                            Interrupts
  r   p   d   s   w   Csw  Trp  Sys  Int  Sof  Flt        cow    2018 total
             29       137    1   25 2018  673             zfod        atkbd0 1
                                                          ozfod  1998 attimer0 0
50,2%Sys   0,9%Intr  0,1%User  0,0%Nice 48,7%Idle        %ozfod       hpet0 20
|    |    |    |    |    |    |    |    |    |    |       daefr     1 uhci0 ehci
=========================+                                prcfr    19 re0 256
                                         2 dtbuf          totfr
Namei     Name-cache   Dir-cache     68416 desvn          react
   Calls    hits   %    hits   %     58261 numvn          pdwak
       3       3 100                 17084 frevn          pdpgs
                                                          intrn
Disks   md8   da0 pass0                            121076 wire
KB/t   0,00  2,00  0,00                             32224 act
tps       0     0     0                            790704 inact
MB/s   0,00  0,00  0,00                              9560 cache
%busy     0     0     0                             42076 free
____________________________________________________________________

After half minute

_______________________________________________________________________
    2 users    Load  3,52  2,90  2,81                   9 июн 14:46

Mem:KB    REAL            VIRTUAL                       VN PAGER   SWAP PAGER
        Tot   Share      Tot    Share    Free           in   out     in   out
Act   16696    3772   285868     5120   51636  count
All   94204    5096  2449788    22376          pages
Proc:                                                            Interrupts
  r   p   d   s   w   Csw  Trp  Sys  Int  Sof  Flt        cow    2022 total
  5          24        80    1   18 2023  803             zfod        atkbd0 1
                                                          ozfod  2000 attimer0 0
57,8%Sys  26,0%Intr  0,0%User  0,0%Nice 16,2%Idle        %ozfod       hpet0 20
|    |    |    |    |    |    |    |    |    |    |       daefr       uhci0 ehci
=============================+++++++++++++                prcfr    22 re0 256
                                           dtbuf          totfr
Namei     Name-cache   Dir-cache     68416 desvn          react
   Calls    hits   %    hits   %     58261 numvn          pdwak
       3       3 100                 17084 frevn          pdpgs
                                                          intrn
Disks   md8   da0 pass0                            121076 wire
KB/t   0,00  0,00  0,00                             32228 act
tps       0     0     0                            790700 inact
MB/s   0,00  0,00  0,00                              9560 cache
%busy     0     0     0                             42076 free
____________________________________________________________________

Wed, 08 Jun 2011 20:34:42 +0300 письмо от Alexander Motin <mav_at_FreeBSD.org>:

> On 07.06.2011 20:12, Andrey Smagin wrote:
> > vmstat -i
> > interrupt total rate
> > irq16: uhci3   205  0
> > irq20: hpet0 147924380  1126
> > irq23: uhci0 ehci0   522517     3
> > total                    148447102   1130
> >
> > Tue, 7 Jun 2011 10:34:01 +0200 письмо от Hans Petter
> Selasky<hselasky_at_c2i.net>:
> >
> >> On Tuesday 07 June 2011 10:09:47 Andrey Smagin wrote:
> >>> I upgraded 2 day ago from 2010xxxx-current box on Intel D525MW.
> >>> System very slow down after that.
> >>> kern.hz=50
> >>> in systat -vmstat - 140hpet interrupts/s
> >>> at top 25% in interrupts 25% in system
> >>> because hyperthreading system found 4 cpu.
> >>
> >> What does vmstat -i output?
> 
> Send me please full verbose dmesg and output of the `sysctl 
> kern.eventtimer` and `sysctl kern.timecounter`.
> 
> Try to switch to another timer:
> sysctl kern.eventtimer.timer=LAPIC
> 
> Try to switch to periodic timers (instead):
> sysctl kern.eventtimer.periodic=1
> 
> -- 
> Alexander Motin
> _______________________________________________
> freebsd-current_at_freebsd.org mailing list
> http://lists.freebsd.org/mailman/listinfo/freebsd-current
> To unsubscribe, send any mail to "freebsd-current-unsubscribe_at_freebsd.org"
Received on Thu Jun 09 2011 - 08:49:04 UTC

This archive was generated by hypermail 2.4.0 : Wed May 19 2021 - 11:40:14 UTC