Moyenne de charge élevée avec une utilisation modérée du processeur et presque pas d'E / S

17

L'explication habituelle pour une moyenne de charge élevée avec peu d'utilisation de processeur sous linux est trop d'E / S (ou plus correctement de sommeil sans interruption ).

J'ai un service exécuté sur un cluster de machines virtuelles à 2 cœurs qui présente une utilisation modérée du processeur (~ 55-70% inactif) mais supérieure à 2 moyennes de charge tout en subissant des E / S presque nulles, des changements de contexte modestes et aucun échange. Interroger avec psje ne vois jamais Ddans la colonne d'état du processus.

Le service est ruby ​​1.9 fonctionnant sous licorne. Il se connecte à deux bases de données postgres en amont qui fournissent des exécutions d'instructions avg très rapides (~ 0,5 ms). Le service enregistre les durées de demande écoulées environ deux fois plus élevées en production qu'il l'a démontré sous une charge de stress plus élevée sur notre réseau de tests de performances. Le seul signal de surveillance qui semble hors de contrôle est la charge moyenne (et bien sûr la durée de réponse moyenne), tout le reste (cpu, mémoire, io, réseau, cswitch, intr) est nominal et correspond aux projections.

Le système est Ubuntu 10.04.4 LTS "Lucid". uname est Linux dirsvc0 2.6.32-32-server #62-Ubuntu SMP Wed Apr 20 22:07:43 UTC 2011 x86_64 GNU/Linux. L'hyperviseur est VMWare ESX 5.1.

MISE À JOUR: Plus d'informations demandées par @ewwhite. Le stockage est un périphérique de disque virtuel mappé à un montage NFS sur l'hôte vm attaché à un NetApp. Je soulignerai que toutes les indications indiquent qu'il n'y a pas d'E / S de disque significatif. Le service lit et écrit sur les sockets réseau (~ 200 Ko / s) et effectue un accès ordinaire et une journalisation des erreurs (à un taux d'environ 20 Ko / s). L'hôte vm possède une paire de ports gigabit allant vers deux commutateurs supérieurs de rack, chacun ayant relié quatre ports gigabit à un routeur principal, tous en cuivre. Chaque hôte vm possède 24 (4x6) cœurs physiques et 150 Go de mémoire et héberge généralement environ 30 invités vm de taille similaire exécutant une variété de services différents. En production, ces hôtes ne sont jamais sur-engagés sur la mémoire et seulement légèrement sur-engagés sur le processeur.

J'accueillerais volontiers des idées pour expliquer la charge élevée.

Voici quelques extraits de données SAR à partir d'une fenêtre de deux heures aujourd'hui à midi:

sar -q # moyenne de charge

              runq-sz  plist-sz   ldavg-1   ldavg-5  ldavg-15
12:05:01 PM         1       173      1.15      2.41      2.48
12:15:01 PM         0       173      0.96      1.56      1.99
12:25:01 PM         2       173      2.60      2.49      2.21
12:35:01 PM         1       173      1.44      2.10      2.06
12:45:01 PM         0       173      3.66      3.31      2.56
12:55:01 PM         0       173      3.05      2.66      2.43
01:05:01 PM         0       174      1.37      2.35      2.36
01:15:01 PM         0       173      3.06      3.07      2.60
01:25:01 PM         2       173      5.03      6.50      4.50
01:35:01 PM         0       173      4.26      5.61      4.98
01:45:01 PM         8       173      4.61      4.46      4.48
01:55:01 PM         0       173      3.30      3.60      3.92
02:05:01 PM         1       173      2.51      2.62      3.15

sar # cpu

                CPU     %user     %nice   %system   %iowait    %steal     %idle
12:05:01 PM     all     31.31      0.60      2.18      0.02      0.00     65.89
12:15:01 PM     all     27.51      0.60      2.07      0.02      0.00     69.79
12:25:01 PM     all     28.09      0.61      1.90      0.03      0.00     69.36
12:35:01 PM     all     32.04      0.67      2.26      0.02      0.00     65.02
12:45:01 PM     all     33.44      0.69      2.61      0.02      0.00     63.24
12:55:01 PM     all     30.62      0.63      2.14      0.02      0.00     66.59
01:05:01 PM     all     29.42      0.61      2.07      0.03      0.00     67.87
01:15:01 PM     all     31.93      0.62      2.39      0.02      0.00     65.05
01:25:01 PM     all     41.60      0.82      3.65      0.03      0.00     53.90
01:35:01 PM     all     43.14      0.88      3.68      0.03      0.00     52.28
01:45:01 PM     all     38.38      0.79      3.43      0.02      0.00     57.39
01:55:01 PM     all     30.65      0.61      2.23      0.03      0.00     66.49
02:05:01 PM     all     29.17      0.58      2.10      0.03      0.00     68.12

sar -d # disk

                  DEV       tps  rd_sec/s  wr_sec/s  avgrq-sz  avgqu-sz     await     svctm     %util 
12:05:01 PM    dev8-0      1.37      0.00     35.94     26.14      0.00      3.09      1.98      0.27
12:15:01 PM    dev8-0      1.65      0.00     39.89     24.23      0.00      2.96      1.98      0.33
12:25:01 PM    dev8-0      1.26      0.00     33.39     26.57      0.00      2.89      1.79      0.22
12:35:01 PM    dev8-0      1.33      0.00     35.23     26.52      0.00      3.15      1.82      0.24
12:45:01 PM    dev8-0      1.68      0.00     42.31     25.23      0.00      2.95      1.89      0.32
12:55:01 PM    dev8-0      1.44      0.00     35.76     24.86      0.00      3.20      1.88      0.27
01:05:01 PM    dev8-0      1.43      0.00     35.57     24.93      0.00      2.17      1.46      0.21
01:15:01 PM    dev8-0      1.74      0.00     43.13     24.74      0.01      3.88      2.15      0.37
01:25:01 PM    dev8-0      1.39      0.00     35.36     25.44      0.01      3.65      2.42      0.34
01:35:01 PM    dev8-0      1.32      0.00     33.74     25.65      0.00      3.39      2.09      0.28
01:45:01 PM    dev8-0      1.48      0.00     37.20     25.20      0.01      3.92      2.26      0.33
01:55:01 PM    dev8-0      1.62      0.00     39.36     24.35      0.01      3.27      1.70      0.27
02:05:01 PM    dev8-0      1.42      0.00     34.72     24.51      0.00      3.28      2.13      0.30

réseau sar -n #

                IFACE   rxpck/s   txpck/s    rxkB/s    txkB/s   rxcmp/s   txcmp/s  rxmcst/s
12:05:01 PM      eth0    365.52    359.86    236.91    227.35      0.00      0.00      0.00
12:15:01 PM      eth0    344.55    337.10    221.20    206.47      0.00      0.00      0.00
12:25:01 PM      eth0    357.81    352.76    229.83    216.22      0.00      0.00      0.00
12:35:01 PM      eth0    372.62    366.34    239.95    227.99      0.00      0.00      0.00
12:45:01 PM      eth0    388.65    378.51    252.11    235.81      0.00      0.00      0.00
12:55:01 PM      eth0    364.50    359.19    233.63    222.82      0.00      0.00      0.00
01:05:01 PM      eth0    361.08    353.88    231.75    218.89      0.00      0.00      0.00
01:15:01 PM      eth0    370.41    363.19    240.53    224.16      0.00      0.00      0.00
01:25:01 PM      eth0    357.67    352.20    230.37    213.57      0.00      0.00      0.00
01:35:01 PM      eth0    354.89    348.58    226.29    214.61      0.00      0.00      0.00
01:45:01 PM      eth0    355.49    344.98    228.41    211.27      0.00      0.00      0.00
01:55:01 PM      eth0    335.96    331.13    213.85    204.26      0.00      0.00      0.00
02:05:01 PM      eth0    323.03    314.49    208.12    194.81      0.00      0.00      0.00

sar -w # commutateurs de contexte

               proc/s   cswch/s
12:05:01 PM      0.97   2382.38
12:15:01 PM      2.58   2415.16
12:25:01 PM      0.84   2406.79
12:35:01 PM      0.84   2371.04
12:45:01 PM      2.70   2414.09
12:55:01 PM      0.84   2385.57
01:05:01 PM      1.20   2419.94
01:15:01 PM      2.57   2387.75
01:25:01 PM      0.85   2164.65
01:35:01 PM      0.84   2156.29
01:45:01 PM      2.53   2251.43
01:55:01 PM      1.01   2331.93
02:05:01 PM      0.96   2323.19

sar -B # paging

             pgpgin/s pgpgout/s   fault/s  majflt/s  pgfree/s pgscank/s pgscand/s pgsteal/s    %vmeff
12:05:01 PM      0.00     17.97    549.43      0.00    289.21      0.00      0.00      0.00      0.00
12:15:01 PM      0.00     19.95   1179.08      0.00    405.61      0.00      0.00      0.00      0.00
12:25:01 PM      0.00     16.69    456.71      0.00    217.63      0.00      0.00      0.00      0.00
12:35:01 PM      0.00     17.61    480.42      0.00    240.01      0.00      0.00      0.00      0.00
12:45:01 PM      0.00     21.15   1210.09      0.00    424.96      0.00      0.00      0.00      0.00
12:55:01 PM      0.00     17.88    489.83      0.00    256.39      0.00      0.00      0.00      0.00
01:05:01 PM      0.00     17.79    624.89      0.00    387.26      0.00      0.00      0.00      0.00
01:15:01 PM      0.00     21.57   1168.87      0.00    393.34      0.00      0.00      0.00      0.00
01:25:01 PM      0.00     17.68    466.03      0.00    235.07      0.00      0.00      0.00      0.00
01:35:01 PM      0.00     16.87    435.24      0.00    199.43      0.00      0.00      0.00      0.00
01:45:01 PM      0.00     18.60   1125.69      0.00    432.85      0.00      0.00      0.00      0.00
01:55:01 PM      0.00     19.68    596.62      0.00    272.75      0.00      0.00      0.00      0.00
02:05:01 PM      0.00     17.36    511.80      0.00    243.83      0.00      0.00      0.00      0.00

sar -r # mémoire

            kbmemfree kbmemused  %memused kbbuffers  kbcached  kbcommit   %commit
12:05:01 PM   1017364   3041608     74.94    225564   1773324   1194728     16.64
12:15:01 PM   1014992   3043980     74.99    225564   1777268   1193688     16.63
12:25:01 PM   1009504   3049468     75.13    225564   1781360   1194504     16.64
12:35:01 PM    999484   3059488     75.38    225564   1785652   1194520     16.64
12:45:01 PM    994764   3064208     75.49    225564   1790136   1194864     16.65
12:55:01 PM    993772   3065200     75.52    225564   1794288   1194296     16.64
01:05:01 PM    993868   3065104     75.51    225564   1798584   1193428     16.63
01:15:01 PM    985016   3073956     75.73    225564   1802708   1194388     16.64
01:25:01 PM    992316   3066656     75.55    225564   1806804   1192996     16.62
01:35:01 PM    971732   3087240     76.06    225564   1810784   1194272     16.64
01:45:01 PM    968816   3090156     76.13    225564   1815036   1194556     16.64
01:55:01 PM    967968   3091004     76.15    225564   1818716   1194924     16.65
02:05:01 PM    966324   3092648     76.19    225564   1822452   1194516     16.64

ps aufx

USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
root         2  0.0  0.0      0     0 ?        S    Jan28   0:00 [kthreadd]
root         3  0.0  0.0      0     0 ?        S    Jan28   0:01  \_ [migration/0]
root         4  0.0  0.0      0     0 ?        S    Jan28   1:01  \_ [ksoftirqd/0]
root         5  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [watchdog/0]
root         6  0.0  0.0      0     0 ?        S    Jan28   0:01  \_ [migration/1]
root         7  0.0  0.0      0     0 ?        S    Jan28   0:27  \_ [ksoftirqd/1]
root         8  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [watchdog/1]
root         9  0.0  0.0      0     0 ?        S    Jan28   0:37  \_ [events/0]
root        10  0.0  0.0      0     0 ?        S    Jan28   0:33  \_ [events/1]
root        11  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [cpuset]
root        12  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [khelper]
root        13  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [async/mgr]
root        14  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [pm]
root        16  0.0  0.0      0     0 ?        S    Jan28   0:02  \_ [sync_supers]
root        17  0.0  0.0      0     0 ?        S    Jan28   0:04  \_ [bdi-default]
root        18  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kintegrityd/0]
root        19  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kintegrityd/1]
root        20  0.0  0.0      0     0 ?        S    Jan28   0:03  \_ [kblockd/0]
root        21  0.0  0.0      0     0 ?        S    Jan28   0:12  \_ [kblockd/1]
root        22  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kacpid]
root        23  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kacpi_notify]
root        24  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kacpi_hotplug]
root        25  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ata/0]
root        26  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ata/1]
root        27  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ata_aux]
root        28  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ksuspend_usbd]
root        29  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [khubd]
root        30  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kseriod]
root        31  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kmmcd]
root        34  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [khungtaskd]
root        35  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kswapd0]
root        36  0.0  0.0      0     0 ?        SN   Jan28   0:00  \_ [ksmd]
root        37  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [aio/0]
root        38  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [aio/1]
root        39  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ecryptfs-kthrea]
root        40  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [crypto/0]
root        41  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [crypto/1]
root        44  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [pciehpd]
root        45  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [scsi_eh_0]
root        46  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [scsi_eh_1]
root        47  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kstriped]
root        50  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kmpathd/0]
root        51  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kmpathd/1]
root        52  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kmpath_handlerd]
root        53  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ksnapd]
root        54  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kondemand/0]
root        55  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kondemand/1]
root        56  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kconservative/0]
root        57  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kconservative/1]
root       213  0.0  0.0      0     0 ?        S    Jan28   0:24  \_ [mpt_poll_0]
root       274  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [mpt/0]
root       295  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [scsi_eh_2]
root       310  0.0  0.0      0     0 ?        S    Jan28   1:41  \_ [jbd2/sda1-8]
root       311  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ext4-dio-unwrit]
root       312  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [ext4-dio-unwrit]
root       342  0.0  0.0      0     0 ?        S    Jan28   0:54  \_ [flush-8:0]
root       627  0.0  0.0      0     0 ?        S    Jan28   0:00  \_ [kpsmoused]
root     18160  0.0  0.0      0     0 ?        S    Feb14   0:00  \_ [rpciod/0]
root     18161  0.0  0.0      0     0 ?        S    Feb14   0:00  \_ [rpciod/1]
root     18162  0.0  0.0      0     0 ?        S    Feb14   0:00  \_ [nfsiod]
root         1  0.0  0.0  61824  2872 ?        Ss   Jan28   0:11 /sbin/init
root       372  0.0  0.0  16904   860 ?        S    Jan28   0:00 upstart-udev-bridge --daemon
root       375  0.0  0.0  17072  1012 ?        S<s  Jan28   0:00 udevd --daemon
root      1054  0.0  0.0  16860   672 ?        S<   Jan28   0:00  \_ udevd --daemon
root     18163  0.0  0.0  17068   832 ?        S<   Feb14   0:00  \_ udevd --daemon
daemon     654  0.0  0.0   8256   644 ?        Ss   Jan28   0:00 portmap
root       788  0.0  0.0  49260  2592 ?        Ss   Jan28   0:00 /usr/sbin/sshd -D
root      8095  0.0  0.1 100888  4068 ?        Ss   16:03   0:00  \_ sshd: root@pts/0    
root      8157  0.0  0.0  11212  2084 pts/0    Ss   16:03   0:00      \_ -bash
root     15777  0.0  0.0   7172  1084 pts/0    R+   17:28   0:00          \_ ps aufx
statd      808  0.0  0.0  10392   844 ?        Ss   Jan28   0:00 rpc.statd -L
root       829  0.0  0.0    140    32 ?        Ss   Jan28   0:16 runsvdir -P /etc/service log: .....................................................................................................
root       834  0.0  0.0    116    32 ?        Ss   Jan28   0:00  \_ runsv chef-client
root       838  0.0  0.0    136    48 ?        S    Jan28   0:00      \_ svlogd -tt ./main
root     30898  0.2  1.8 192296 75736 ?        S    01:57   2:25      \_ /usr/bin/ruby1.8 /usr/bin/chef-client -i 1800 -s 60 -L /var/log/chef/client.log
root       832  0.0  0.0   6080   656 tty4     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty4
root       841  0.0  0.0   6080   656 tty5     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty5
root       844  0.0  0.0   6080   656 tty2     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty2
root       845  0.0  0.0   6080   660 tty3     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty3
root       847  0.0  0.0   6080   656 tty6     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty6
root       849  0.0  0.0  21076  1044 ?        Ss   Jan28   0:04 cron
daemon     853  0.0  0.0  18884   468 ?        Ss   Jan28   0:00 atd
root       864  0.0  0.0  11284   640 ?        Ss   Jan28   2:10 /usr/sbin/irqbalance
root       890  0.0  0.0 112412  1908 ?        Ssl  Jan28   5:09 /usr/sbin/automount
root       908  0.0  0.0  28016   976 ?        Ss   Jan28   0:00 nginx: master process /usr/sbin/nginx
www-data   910  0.0  0.0  64532  3064 ?        S    Jan28   0:00  \_ nginx: worker process
root       922  0.0  0.0 169668  2584 ?        Ssl  Jan28   0:34 /usr/sbin/nscd
mail       943  0.0  0.0  11888   648 ?        S    Jan28   0:00 /usr/sbin/nullmailer-send -d
root       971  0.0  1.1 152036 46264 ?        Sl   Jan28  36:07 splunkd -p 8089 start
root       972  0.0  0.0  49180  3512 ?        Ss   Jan28   0:00  \_ splunkd -p 8089 start
root      1160  0.0  0.0  14888  1276 ?        Ss   Jan28  19:31 /usr/lib/vmware-tools/sbin64/vmware-guestd --background /var/run/vmware-guestd.pid
ntp       1214  0.0  0.0  19700  1268 ?        Ss   Jan28   1:21 /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /var/lib/ntp/ntp.conf.dhcp -u 103:107
root      1231  0.0  0.3  21164 12980 ?        SLs  Jan28   0:00 /usr/sbin/memlockd -u memlockd
scs       1270  1.2  2.3 187788 96228 ?        SNl  Jan28 537:27 /usr/bin/ruby /opt/wp/roles/scs/src/dev/scs/bin/server.rb -p 8843
root      1309  0.0  0.0   6080   656 tty1     Ss+  Jan28   0:00 /sbin/getty -8 38400 tty1
dirsvc   27448  0.1  1.2 177408 50748 ?        Sl   Feb20   8:57 narwhal master --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.19/confi
dirsvc   13003  2.5  1.2 180012 49128 ?        Sl   16:57   0:47  \_ narwhal worker[1] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13460  2.5  1.2 180108 49236 ?        Sl   17:05   0:36  \_ narwhal worker[9] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13637  2.4  1.2 180008 49096 ?        Sl   17:08   0:29  \_ narwhal worker[3] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13650  2.9  1.2 180172 49420 ?        Sl   17:08   0:35  \_ narwhal worker[11] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.
dirsvc   13701  3.1  1.2 180172 49188 ?        Sl   17:10   0:35  \_ narwhal worker[13] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.
dirsvc   13731  2.7  1.2 181556 50628 ?        Sl   17:10   0:29  \_ narwhal worker[7] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13770  2.8  1.2 179400 50352 ?        Sl   17:11   0:29  \_ narwhal worker[8] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13778  3.3  1.2 180104 49172 ?        Sl   17:11   0:34  \_ narwhal worker[5] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13826  2.6  1.2 181556 50672 ?        Sl   17:12   0:25  \_ narwhal worker[0] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13939  2.8  1.2 177948 48848 ?        Sl   17:13   0:25  \_ narwhal worker[4] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   13971  3.2  1.4 189052 58292 ?        Sl   17:13   0:28  \_ narwhal worker[12] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.
dirsvc   13982  2.5  1.2 177792 48780 ?        Sl   17:14   0:22  \_ narwhal worker[6] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   15316  3.0  1.2 180072 49128 ?        Sl   17:20   0:15  \_ narwhal worker[2] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.1
dirsvc   15381  2.0  1.2 179944 48928 ?        Sl   17:21   0:08  \_ narwhal worker[14] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.
dirsvc   15743  3.5  1.1 177624 48596 ?        Sl   17:28   0:00  \_ narwhal worker[10] --port 8862 -c /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.
dirsvc   27461  0.1  1.3 235884 54744 ?        Sl   Feb20   9:20 /opt/ruby-1.9.2/bin/ruby /opt/wp/roles/directory/src/dev/directory/vendor/bundle/ruby/1.9.1/gems/wp-directory-svc-2.1.19/gem-bin/wo
root     11068  0.0  0.0 130480  1720 ?        Sl   04:20   0:00 rsyslogd -c4
zabbix   18062  0.0  0.0   9908   728 ?        SN   11:41   0:00 /usr/sbin/zabbix_agentd
zabbix   18063  0.0  0.0   9908   756 ?        SN   11:41   0:12  \_ /usr/sbin/zabbix_agentd
zabbix   18064  0.0  0.0   9980  1044 ?        SN   11:41   0:03  \_ /usr/sbin/zabbix_agentd
zabbix   18065  0.0  0.0   9980  1044 ?        SN   11:41   0:03  \_ /usr/sbin/zabbix_agentd
zabbix   18066  0.0  0.0   9980  1044 ?        SN   11:41   0:03  \_ /usr/sbin/zabbix_agentd
zabbix   18067  0.0  0.0   9908   660 ?        SN   11:41   0:00  \_ /usr/sbin/zabbix_agentd

EDIT: Plus d'infos sur demande:

$ dpkg --get-selections | grep vmware
vmware-open-vm-tools-common         install
vmware-open-vm-tools-kmod-2.6.32-32-server  install

$ cat /proc/cpuinfo
processor   : 0
vendor_id   : GenuineIntel
cpu family  : 6
model       : 44
model name  : Intel(R) Xeon(R) CPU           X5660  @ 2.80GHz
stepping    : 2
cpu MHz     : 2800.099
cache size  : 12288 KB
fpu     : yes
fpu_exception   : yes
cpuid level : 11
wp      : yes
flags       : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts mmx fxsr sse sse2 ss syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good xtopology tsc_reliable nonstop_tsc aperfmperf pni pclmulqdq ssse3 cx16 sse4_1 sse4_2 popcnt aes hypervisor lahf_lm ida arat
bogomips    : 5600.19
clflush size    : 64
cache_alignment : 64
address sizes   : 40 bits physical, 48 bits virtual
power management:

processor   : 1
vendor_id   : GenuineIntel
cpu family  : 6
model       : 44
model name  : Intel(R) Xeon(R) CPU           X5660  @ 2.80GHz
stepping    : 2
cpu MHz     : 2800.099
cache size  : 12288 KB
fpu     : yes
fpu_exception   : yes
cpuid level : 11
wp      : yes
flags       : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush dts mmx fxsr sse sse2 ss syscall nx rdtscp lm constant_tsc arch_perfmon pebs bts rep_good xtopology tsc_reliable nonstop_tsc aperfmperf pni pclmulqdq ssse3 cx16 sse4_1 sse4_2 popcnt aes hypervisor lahf_lm ida arat
bogomips    : 5600.19
clflush size    : 64
cache_alignment : 64
address sizes   : 40 bits physical, 48 bits virtual
power management:
linux vmware-esx high-load dbenhur
la source
Vous avez négligé de mentionner quoi que ce soit sur le stockage sous-jacent, le support de connexion, le matériel, la version de VMware, si VMware Tools est installé, etc.
ewwhite
@ewwhite a ajouté les informations demandées. (Sauf que je ne peux pas répondre "etc." parce que le monde est trop grand pour être complètement décrit. :)
dbenhur
Trois ans plus tard, ce service et son architecture d'hébergement sont révolus depuis longtemps, mais la question déconcertante demeure. J'ai récemment lu cet article sur les bogues du planificateur Linux et je me demande si l'interaction de ces bogues avec l'exécution de VM a pu être le coupable. ece.ubc.ca/~sasha/papers/eurosys16-final29.pdf
dbenhur
Étant donné que ce Q apparaît lors de la recherche sur Google, j'aimerais laisser un lien vers l'excellent article sur les «moyennes de charge» de Linux de Brendan Gregg , qui contient la description la plus complète des moyennes de charge (et les mesures à consulter à la place).
Nickolay

Réponses:

11

La moyenne de charge est basée sur les processus en attente dans la file d'attente d'exécution. Cela signifie que si vous avez des processus qui utilisent souvent des tranches de temps fractionnaires, vous pouvez voir une moyenne de charge élevée sans une utilisation élevée du processeur.

Le meilleur exemple est le courrier. La quantité de temps CPU nécessaire pour envoyer un message est très limitée, mais lorsque des milliers de courriers circulent dans le système (en particulier si le démon de messagerie bifurque les processus pour gérer chacun d'eux), la file d'attente d'exécution devient très longue. Il est courant de voir des serveurs de messagerie réactifs fonctionnant bien avec des charges moyennes de 25, 50 à plus de 100.

Pour un serveur Web, j'utiliserais le temps de réponse de la page comme mesure principale, ne vous inquiétez pas de la moyenne de charge. Sous les ordonnanceurs modernes, la charge moyenne inférieure au double du nombre de cœurs n'aura généralement aucun effet négatif. Vous pouvez essayer le nombre de cœurs par machine virtuelle par rapport au nombre total de machines virtuelles. Certaines applications bénéficieront de nombreux cœurs sur quelques machines, d'autres sont meilleures pour un petit nombre de cœurs et de nombreuses instances.

mfarver
la source
1
Merci pour votre réponse. Qu'est-ce qui constitue une "tranche de temps fractionnaire"? Si je comprends bien le planificateur, un processus est affecté à un processeur et s'exécute sur ce processeur jusqu'au prochain intervalle de planification ou jusqu'à ce qu'il effectue un appel système de blocage qui le fasse céder. Si mon processeur est inactif 70% du temps, mais la longueur de ma file d'attente d'exécution est en moyenne supérieure à 2, ce qui me laisse perplexe, pourquoi ces processus prêts à exécuter ne sont-ils pas simplement planifiés sur le processeur le plus inactif?
dbenhur
J'ajouterais qu'il s'agit d'un service Web, mais pas d'un serveur Web. Il a un profil d'exécution semblable à un tas d'autres services similaires que nous exécutons: recevoir et désérialiser une demande, effectuer une répartition vers des services / bases de données en amont, calculer un résultat basé sur les réponses des amonts, sérialiser une réponse, griffonner un journal msg. Durée de demande médiane ~ 60 ms, 90% 200 ms, 99% 500 ms +. Nous avons un tas d'autres services avec des profils similaires fonctionnant sur des conteneurs vm comparables qui ne présentent pas cette déconnexion entre Load et CPU%.
dbenhur
Linux va seulement jusqu'à la planification vers un processeur virtuel, qu'ESX planifie ensuite via ses propres algorithmes vers un vrai processeur. Dans quelle mesure les MV comparables sont-ils similaires? CPU très similaire pour une charge différente? Même utilisation de la mémoire?
Matt
@mindthemonkey Il y a au moins une douzaine de services différents dans les machines virtuelles. Certains ont des profils sensiblement différents, mais la majorité ressemble assez à ce service. 4 Go de mémoire, 2 virt cpus, modest IO (principalement réseau et journalisation de base), exécutez une utilisation de 30 à 60% de cpu sur la courbe quotidienne. Les nœuds gourmands en E / S et / ou mémoire (DB, SOLR) obtiennent des hôtes dédiés. La plupart de ces autres services virtuels montrent la corrélation attendue entre le cpu% et la charge (au moins tant qu'ils restent en bonne santé loin de 100%).
dbenhur
@mindthemonkey alors que le planificateur invité ne contrôle que le virt cpu et ESX planifie dans un contexte plus large, je ne vois pas comment cela affecte substantiellement le cpu% et la comptabilité de charge. Les deux sont basés sur des échantillons prélevés à une certaine fréquence et dans la mesure où l'invité est anticipé par la planification de l'hyperviseur, qui affectera à la fois les tranches où le travail réel est effectué et les tranches où l'invité prélève ses échantillons.
dbenhur
1

Si nous utilisons les commandes shell suivantes pour surveiller la moyenne de charge réelle, nous pourrions avoir des vues différentes sur ce phénomène. procs_running pourrait être beaucoup plus élevé que prévu.

while true; do cat /proc/loadavg ; cat /proc/stat| grep procs; done
WENPIN
la source
1

Lorsque vous avez un problème de performances dans une machine virtuelle, vous devez d'abord aborder le problème à la fois du côté du superviseur et de la machine virtuelle. Une autre chose à garder à l'esprit est que le chronométrage dans une machine virtuelle n'est pas précis. Cela signifie également que les statistiques mesurées dans une machine virtuelle peuvent ne pas être correctes.

Quelles sont les statistiques du processeur et des E / S pour cette machine virtuelle? Faites attention au compteur CPU ready - il doit être inférieur à 5%. Sur quelle version d'ESX utilisez-vous? Quelle est votre architecture matérielle en test et prod?

Sur VM, vous pouvez tout profiler de l'application au noyau avec perf et visualiser la sortie avec des graphiques à flamme

Mircea Vutcovici
la source
Merci d'avoir pris le temps d'essayer de résoudre un problème il y a cinq ans - les systèmes et les logiciels en question appartiennent à une entreprise dans laquelle je ne travaille plus et la pile VM et le service en question n'y sont plus en service de toute façon. :) Il y a un tas d'informations sur le processeur et les E / S déjà publiées dans la question d'origine. Les travaux publics et l'exposition de Brendan sur la perf et les graphes de flamme ont dépassé cette question de plus d'un an.
dbenhur
1
Aucun problème. Ce sera peut-être utile à quelqu'un.
Mircea Vutcovici
0

Cela ne ressemble pas à une moyenne de charge particulièrement élevée. Si vous voulez le retrouver, iotopc'est probablement le meilleur outil pour le travail.

David Schwartz
la source
iotopest ennuyeux, tout indique environ 0.
dbenhur
Toute charge moyenne supérieure au nombre de processeurs signifie que j'ai plus de processus en attente d'exécution que de processeurs pour les exécuter. Je vois de nombreux intervalles au-dessus de 2,0 et plusieurs la-5 sur 4 et jusqu'à 6,5. Cela signifie que j'ai souvent des processus qui bloquent pour le processeur derrière d'autres processus et implique une latence indésirable par manque de capacité du processeur. Je m'attends normalement à ce que la charge moyenne et le cpu% soient corrélés jusqu'à ce que le système commence à approcher la saturation à 100% du cpu; après cette moyenne de charge est le meilleur signal car il indique à quel point le système est sur-engagé, pas seulement qu'il est à 100% occupé.
dbenhur
0

J'ai été confronté à un scénario très similaire au vôtre. Dans mon cas, la moyenne de charge a chuté après avoir changé le planificateur d'E / S du périphérique de bloc de la VM problématique en planificateur NOOP. Ce planificateur n'est qu'une file d'attente FIFO, ce qui fonctionne bien lorsque l'hyperviseur appliquera de toute façon ses propres algorithmes de planification d'E / S. Pas besoin de réorganiser deux fois.

Cela dit, je suis toujours confronté à des événements de clavier lents sur la machine virtuelle problématique, donc je pense que je n'ai supprimé que la moyenne de charge élevée sans résoudre le problème réel. Je mettrai définitivement à jour cette réponse si je trouve la cause première.

Liste des planificateurs disponibles (et [planificateur] en cours d'utilisation):

cat /sys/block/sdX/queue/scheduler
noop anticipatory deadline [cfq]

Changez-le avec:

echo noop > /sys/block/sdX/queue/scheduler

Pour le rendre persistant, vous devez ajouter elevator=noopaux paramètres de démarrage du noyau de votre machine virtuelle.

billyw
la source
-2

La moyenne de charge est le nombre de processus exécutables en attente de CPU. Un processus qui attend des E / S ne compte pas du tout. L '"explication habituelle" est tout simplement fausse.

vonbrand
la source
3
Linux inclut des processus en veille ininterprétable dans son calcul de charge. Ces processus apparaissent avec l'état «D» dans les outils d'inspection de processus habituels. Cet état est généralement utilisé par les pilotes de périphérique en attente d'E / S disque ou réseau. Cette "explication habituelle" est vraie pour Linux, mais pas pour la plupart des autres Unix.
dbenhur
1
s / ininterprétable / ininterruptible /
dbenhur
1
Un commentaire plus tôt faisait référence à un travail de performance de Brendan Gregg qui me rappelait qu'il avait récemment fait une belle archéologie sur la façon dont Uninterruptible Sleep s'est retrouvé dans la charge moyenne de Linux
dbenhur