NetBSD-Bugs archive

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index][Old Index]

Re: kern/40945: system process locked at 100% CPU



The following reply was made to PR kern/40945; it has been noted by GNATS.

From: okay_awright <okayawright%gmail.com@localhost>
To: gnats-bugs%NetBSD.org@localhost
Cc: 
Subject: Re: kern/40945: system process locked at 100% CPU
Date: Mon, 02 Mar 2009 23:49:25 +0100

 Thanks for your help.
 
 Regarding your last question, raidframe is not used.
 
 Please note that I have moved on to a CVS (-current) from february 23
 since I first submitted the report on port-amd64, and the setup is a bit
 different, but the problem remains unchanged though. It is also worth
 noting that it does not always happen (usually on boot). I was not able
 to pinpoint when this glitch appears.
 
 Here is part of the result of the requested commands with the GENERIC
 kernel from this specific CVS.
 Unfortunately, I decided to shut down for a few minutes the machine
 after these two steps (because it was getting really hot inside the tiny
 case hosting the motherboard) and after several unsuccessful attempts I
 wasn't able to get a single CPU maxed-up this time. I'll post the
 debugger output as soon as I can repeat this odd behaviour.
 
 BEFORE REBOOT:
 [root@XXX dummy]# top -t
 load averages:  0.02,  0.01,  0.00;               up
 0+00:04:11                                                                     
 
 21:51:35
 75 threads: 18 idle, 53 sleeping, 4 on CPU
 CPU0 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt, 
 100% idle
 CPU1 states:  0.0% user,  0.0% nice,  0.2% system,  0.0% interrupt,
 99.8% idle
 CPU2 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt, 
 100% idle
 CPU3 states:  0.0% user,  0.0% nice,  100% system,  0.0% interrupt, 
 0.0% idle
 Memory: 54M Act, 6340K Wired, 10M Exec, 8280K File, 1878M Free
 Swap: 4097M Total, 4097M Free
 
   PID   LID USERNAME PRI STATE      TIME   WCPU    CPU COMMAND      NAME
     0    13 root      96 CPU/3      3:41 99.02% 99.02% [system]     sysmon
     0    18 root     223 IDLE/1     0:00  0.00%  0.00% [system]    
 softser/1
     0    30 root     223 IDLE/3     0:00  0.00%  0.00% [system]    
 softser/3
     0    24 root     223 IDLE/2     0:00  0.00%  0.00% [system]    
 softser/2
     0     6 root     223 IDLE/0     0:00  0.00%  0.00% [system]    
 softser/0
     0    21 root     222 IDLE/2     0:00  0.00%  0.00% [system]    
 softnet/2
     0    27 root     222 IDLE/3     0:00  0.00%  0.00% [system]    
 softnet/3
     0    15 root     222 IDLE/1     0:00  0.00%  0.00% [system]    
 softnet/1
     0     3 root     222 IDLE/0     0:00  0.00%  0.00% [system]    
 softnet/0
     0    16 root     221 IDLE/1     0:00  0.00%  0.00% [system]    
 softbio/1
     0    28 root     221 IDLE/3     0:00  0.00%  0.00% [system]    
 softbio/3
     0     4 root     221 IDLE/0     0:00  0.00%  0.00% [system]    
 softbio/0
     0    22 root     221 IDLE/2     0:00  0.00%  0.00% [system]    
 softbio/2
     0     5 root     220 IDLE/0     0:00  0.00%  0.00% [system]    
 softclk/0
     0    23 root     220 IDLE/2     0:00  0.00%  0.00% [system]    
 softclk/2
     0    17 root     220 IDLE/1     0:00  0.00%  0.00% [system]    
 softclk/1
     0    29 root     220 IDLE/3     0:00  0.00%  0.00% [system]    
 softclk/3
     0    26 root       0 IDLE/3     0:00  0.00%  0.00% [system]     idle/3
     0     2 root       0 IDLE/0     0:00  0.00%  0.00% [system]     idle/0
   458     1 root      43 CPU/0      0:00  0.00%  0.00% top          -
     0    14 root       0 CPU/1      0:00  0.00%  0.00% [system]     idle/1
     0    20 root       0 CPU/2      0:00  0.00%  0.00% [system]     idle/2
     0    31 root     127 xcall/3    0:00  0.00%  0.00% [system]     xcall/3
     0     7 root     127 xcall/0    0:00  0.00%  0.00% [system]     xcall/0
     0    19 root     127 xcall/1    0:00  0.00%  0.00% [system]     xcall/1
     0    25 root     127 xcall/2    0:00  0.00%  0.00% [system]     xcall/2
     0    54 root     126 pgdaem/1   0:00  0.00%  0.00% [system]     pgdaemon
     0     1 root     125 schedu/1   0:00  0.00%  0.00% [system]     swapper
     0    57 root     125 vmem_r/1   0:00  0.00%  0.00% [system]    
 vmem_rehash
     0    56 root     125 aiodon/0   0:00  0.00%  0.00% [system]     aiodoned
     0    10 root     125 cacheg/0   0:00  0.00%  0.00% [system]     cachegc
     0     9 root     125 vrele/2    0:00  0.00%  0.00% [system]     vrele
     0     8 root     125 modunl/0   0:00  0.00%  0.00% [system]    
 modunload
     0    55 root     124 syncer/1   0:00  0.00%  0.00% [system]     ioflush
     0    58 root     123 physio/1   0:00  0.00%  0.00% [system]     physiod
     0    48 root      96 usbevt/1   0:00  0.00%  0.00% [system]     usb1
     0    47 root      96 usbevt/1   0:00  0.00%  0.00% [system]     usb2
     0    46 root      96 usbtsk/1   0:00  0.00%  0.00% [system]    
 usbtask-dr
     0    45 root      96 usbtsk/1   0:00  0.00%  0.00% [system]    
 usbtask-hc
     0    44 root      96 usbevt/1   0:00  0.00%  0.00% [system]     usb0
     0    35 root      96 iicint/3   0:00  0.00%  0.00% [system]     iic0
     0    34 root      96 atath/1    0:00  0.00%  0.00% [system]     atabus2
     0    33 root      96 atath/1    0:00  0.00%  0.00% [system]     atabus1
     0    50 root      96 usbevt/1   0:00  0.00%  0.00% [system]     usb3
     0    32 root      96 atath/0    0:00  0.00%  0.00% [system]     atabus0
     0    49 root      96 usbevt/1   0:00  0.00%  0.00% [system]     usb4
     0    12 root      96 pmfeve/0   0:00  0.00%  0.00% [system]     pmfevent
     0    11 root      96 nfssil/0   0:00  0.00%  0.00% [system]     nfssilly
     0    53 root      96 crypto/1   0:00  0.00%  0.00% [system]    
 cryptoret
 
 
 [root@XXX dummy]# vmstat -e
 event                                         total     rate type
 bus_dma loads                                  1749        6 misc
 vmcmd kills                                     186        0 misc
 vmcmd extends                                    18        0 misc
 vmcmd calls                                    1602        6 misc
 cpu0 runqueue pull                               13        0 misc
 cpu0 runqueue push                               32        0 misc
 cpu0 runqueue stay                             1173        4 misc
 cpu0 runqueue localize                           24        0 misc
 softint net/0                                   237        0 misc
 softint bio/0                                  1708        6 misc
 softint bio block/0                               3        0 misc
 softint clk/0                                  4426       16 misc
 crosscall unicast                                 8        0 misc
 namecache entries collected                      58        0 misc
 namecache under scan target                     271        1 misc
 cpu0 timer                                    27004      101 misc
 global TLB IPI                                 3895       14 intr
 cpu0 TLB IPI                                      4        0 misc
 cpu1 runqueue pull                                6        0 misc
 cpu1 runqueue push                               17        0 misc
 cpu1 runqueue stay                             3046       11 misc
 cpu1 runqueue localize                          347        1 misc
 softint net/1                                     3        0 misc
 softint clk/1                                  2929       10 misc
 callout late/1                                    2        0 misc
 cpu1 timer                                    27004      101 misc
 cpu2 runqueue pull                                1        0 misc
 cpu2 runqueue push                                5        0 misc
 cpu2 runqueue stay                              808        3 misc
 cpu2 runqueue localize                            8        0 misc
 softint clk/2                                   549        2 misc
 cpu2 timer                                    27004      101 misc
 cpu2 TLB IPI                                      1        0 misc
 cpu3 runqueue push                                1        0 misc
 cpu3 runqueue stay                              405        1 misc
 softint clk/3                                   541        2 misc
 cpu3 timer                                    27004      101 misc
 ioapic0 pin 16                                  495        1 intr
 ioapic0 pin 19                                 1774        6 intr
 kpreempt defer: kernel_lock                       1        0 misc
 kpreempt immediate                             2705       10 misc
 
 AFTER REBOOT:
 [root@XXX dummy]# top -t
 load averages:  0.99,  0.88,  0.53;               up 0+00:12:56       
 22:41:24
 92 threads: 17 idle, 71 sleeping, 4 on CPU
 CPU0 states:  0.0% user,  0.0% nice,  0.0% system,  0.4% interrupt,
 99.6% idle
 CPU1 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt, 
 100% idle
 CPU2 states:  0.0% user,  0.0% nice,  0.0% system,  0.0% interrupt, 
 100% idle
 CPU3 states: 24.2% user,  0.0% nice, 19.0% system,  0.0% interrupt,
 56.9% idle
 Memory: 145M Act, 6700K Wired, 10M Exec, 90M File, 1701M Free
 Swap: 4097M Total, 4097M Free
 
   PID   LID USERNAME PRI STATE      TIME   WCPU    CPU COMMAND      NAME
     0     6 root     223 IDLE/0     0:00  0.00%  0.00% [system]    
 softser/0
     0    24 root     223 IDLE/2     0:00  0.00%  0.00% [system]    
 softser/2
     0    30 root     223 IDLE/3     0:00  0.00%  0.00% [system]    
 softser/3
     0    18 root     223 IDLE/1     0:00  0.00%  0.00% [system]    
 softser/1
     0    27 root     222 IDLE/3     0:00  0.00%  0.00% [system]    
 softnet/3
     0     3 root     222 IDLE/0     0:00  0.00%  0.00% [system]    
 softnet/0
     0    15 root     222 IDLE/1     0:00  0.00%  0.00% [system]    
 softnet/1
     0    21 root     222 IDLE/2     0:00  0.00%  0.00% [system]    
 softnet/2
     0    22 root     221 IDLE/2     0:00  0.00%  0.00% [system]    
 softbio/2
     0    16 root     221 IDLE/1     0:00  0.00%  0.00% [system]    
 softbio/1
     0     4 root     221 IDLE/0     0:00  0.00%  0.00% [system]    
 softbio/0
     0    28 root     221 IDLE/3     0:00  0.00%  0.00% [system]    
 softbio/3
     0    29 root     220 IDLE/3     0:00  0.00%  0.00% [system]    
 softclk/3
     0     5 root     220 IDLE/0     0:00  0.00%  0.00% [system]    
 softclk/0
     0    17 root     220 IDLE/1     0:00  0.00%  0.00% [system]    
 softclk/1
     0    23 root     220 IDLE/2     0:00  0.00%  0.00% [system]    
 softclk/2
     0    20 root       0 IDLE/2     0:00  0.00%  0.00% [system]     idle/2
 17052     1 root      43 CPU/2      0:00  0.00%  0.00% top          -
     0     2 root       0 CPU/0      0:00  0.00%  0.00% [system]     idle/0
     0    26 root       0 CPU/3      0:00  0.00%  0.00% [system]     idle/3
     0    14 root       0 CPU/1      0:00  0.00%  0.00% [system]     idle/1
     0     7 root     127 xcall/0    0:00  0.00%  0.00% [system]     xcall/0
     0    25 root     127 xcall/2    0:00  0.00%  0.00% [system]     xcall/2
     0    31 root     127 xcall/3    0:00  0.00%  0.00% [system]     xcall/3
     0    19 root     127 xcall/1    0:00  0.00%  0.00% [system]     xcall/1
     0    58 root     126 pgdaem/3   0:00  0.00%  0.00% [system]     pgdaemon
     0    61 root     125 vmem_r/3   0:00  0.00%  0.00% [system]    
 vmem_rehash
     0     1 root     125 schedu/3   0:00  0.00%  0.00% [system]     swapper
     0     8 root     125 modunl/0   0:00  0.00%  0.00% [system]    
 modunload
     0     9 root     125 vrele/3    0:00  0.00%  0.00% [system]     vrele
     0    10 root     125 cacheg/2   0:00  0.00%  0.00% [system]     cachegc
     0    60 root     125 aiodon/2   0:00  0.00%  0.00% [system]     aiodoned
     0    59 root     124 syncer/0   0:00  0.00%  0.00% [system]     ioflush
     0    62 root     123 physio/3   0:00  0.00%  0.00% [system]     physiod
     0    35 root      96 iicint/1   0:00  0.00%  0.00% [system]     iic0
     0    57 root      96 crypto/3   0:00  0.00%  0.00% [system]    
 cryptoret
     0    54 root      96 usbevt/3   0:00  0.00%  0.00% [system]     usb4
     0    53 root      96 usbevt/3   0:00  0.00%  0.00% [system]     usb3
     0    52 root      96 usbevt/3   0:00  0.00%  0.00% [system]     usb2
     0    51 root      96 usbevt/3   0:00  0.00%  0.00% [system]     usb1
     0    50 root      96 usbtsk/3   0:00  0.00%  0.00% [system]    
 usbtask-dr
     0    49 root      96 usbtsk/3   0:00  0.00%  0.00% [system]    
 usbtask-hc
     0    48 root      96 usbevt/3   0:00  0.00%  0.00% [system]     usb0
     0    47 root      96 corete/3   0:00  0.00%  0.00% [system]    
 coretemp3
     0    46 root      96 corete/0   0:00  0.00%  0.00% [system]    
 coretemp2
     0    45 root      96 corete/2   0:00  0.00%  0.00% [system]    
 coretemp1
     0    44 root      96 corete/1   0:00  0.00%  0.00% [system]    
 coretemp0
     0    34 root      96 atath/3    0:00  0.00%  0.00% [system]     atabus2
 
 


Home | Main Index | Thread Index | Old Index