Сколько главных ГК при мониторинге IntelliJ 2018.03? - PullRequest
0 голосов
/ 18 марта 2019

Major GC вызывается System.gc().

Чтобы избежать большого количества Major GC при запуске IntelliJ 2018.3 , я пыталсянастроить idea64.vmoptions со следующими параметрами VM

(непосредственно скопировано из аргументов JVM VisualVM)

-Xms256m
-Xmx2400m
-XX:NewSize=512M
-XX:MaxNewSize=512M
-XX:+UseConcMarkSweepGC
-XX:ReservedCodeCacheSize=240m
-XX:SoftRefLRUPolicyMSPerMB=50
-ea
-Dsun.io.useCanonCaches=false
-Djava.net.preferIPv4Stack=true
-Djdk.http.auth.tunneling.disabledSchemes=""
-XX:+HeapDumpOnOutOfMemoryError
-XX:-OmitStackTraceInFastThrow
-XX:+PrintGCTimeStamps
-XX:+PrintGCDateStamps
-Xloggc:/home/hearen/.IntelliJIdea2018.3/gc_details.log
-XX:+CITime
-XX:+PrintGCDetails
-Dawt.useSystemAAFontSettings=lcd
-Dsun.java2d.renderer=sun.java2d.marlin.MarlinRenderingEngine
-XX:ErrorFile=/home/hearen/java_error_in_IDEA_%p.log
-XX:HeapDumpPath=/home/hearen/java_error_in_IDEA.hprof
-Didea.paths.selector=IntelliJIdea2018.3
-Djb.vmOptionsFile=/home/hearen/.IntelliJIdea2018.3/config/idea64.vmoptions
-Didea.jre.check=true

Я пытался избежать Minor иМаксимально большие ГХ с достаточно большой памятью для Young & Tenured Generation ( -Xms512m -Xmx2400m -XX: MaxNewSize = 512M -XX: NewSize = 512M ) и отключил -XX:+DisableExplicitGC.

Но я все еще был свидетелем множества Major GC в журналах GC (в VisualVM я видел 18 коллекций Major GC для Old Gen и 14 для Eden).

Как я отмечал, -XX:CMSTriggerRatio будет по умолчанию 80% для запуска цикла сбора CMS, что, кажется, не является причиной, но в журналах GC есть много циклов CMS.

2019-03-18T18:53:40.683+0800: 176.928: [GC (CMS Initial Mark) [1 CMS-initial-mark: 54738K(150112K)] 476819K(621920K), 0.0516469 secs] [Times: user=0.20 sys=0.00, real=0.05 secs] 
2019-03-18T18:53:40.734+0800: 176.979: [CMS-concurrent-mark-start]
2019-03-18T18:53:40.797+0800: 177.043: [CMS-concurrent-mark: 0.063/0.063 secs] [Times: user=0.06 sys=0.00, real=0.07 secs] 
2019-03-18T18:53:40.797+0800: 177.043: [CMS-concurrent-preclean-start]
2019-03-18T18:53:40.800+0800: 177.045: [CMS-concurrent-preclean: 0.003/0.003 secs] [Times: user=0.01 sys=0.00, real=0.00 secs] 
2019-03-18T18:53:40.800+0800: 177.045: [CMS-concurrent-abortable-preclean-start]
 CMS: abort preclean due to time 2019-03-18T18:53:45.872+0800: 182.117: [CMS-concurrent-abortable-preclean: 3.168/5.072 secs] [Times: user=3.20 sys=0.00, real=5.07 secs] 
2019-03-18T18:53:45.872+0800: 182.117: [GC (CMS Final Remark) [YG occupancy: 423458 K (471808 K)]2019-03-18T18:53:45.872+0800: 182.117: [Rescan (parallel) , 0.0511363 secs]2019-03-18T18:53:45.923+0800: 182.168: [weak refs processing, 0.0000925 secs]2019-03-18T18:53:45.923+0800: 182.168: [class unloading, 0.0183514 secs]2019-03-18T18:53:45.942+0800: 182.187: [scrub symbol table, 0.0381231 secs]2019-03-18T18:53:45.980+0800: 182.225: [scrub string table, 0.0013231 secs][1 CMS-remark: 54738K(150112K)] 478196K(621920K), 0.1099238 secs] [Times: user=0.26 sys=0.00, real=0.11 secs] 
2019-03-18T18:53:45.982+0800: 182.227: [CMS-concurrent-sweep-start]
2019-03-18T18:53:45.998+0800: 182.244: [CMS-concurrent-sweep: 0.016/0.016 secs] [Times: user=0.02 sys=0.00, real=0.02 secs] 
2019-03-18T18:53:45.998+0800: 182.244: [CMS-concurrent-reset-start]
2019-03-18T18:53:45.999+0800: 182.245: [CMS-concurrent-reset: 0.001/0.001 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2019-03-18T18:53:48.000+0800: 184.245: [GC (CMS Initial Mark) [1 CMS-initial-mark: 54738K(150112K)] 478965K(621920K), 0.0538103 secs] [Times: user=0.20 sys=0.00, real=0.05 secs] 

Возможно, полезно

Чтобы обеспечить точность результатов, я пробовал несколько раз для каждой конфигурации.

Я пытался сравнить с & без -XX:NewSize=512M -XX:MaxNewSize=512M

  1. С: Major -> 18 и Minor -> 14;
  2. БЕЗ (Eden будет 266M): Major -> 10и Minor -> 40;

Мои вопросы

  1. Почему существует так много Major GCs ?
  2. Почему так много CMS , что их вызвало?
  3. Не могу ли я одновременно уменьшить значение Minor и Major, даже если у меня есть память?

Любая помощь будет высоко ценится :)

1 Ответ

1 голос
/ 18 марта 2019

Вы используете CMS в своей конфигурации.Это означает три типа пауз

  1. незначительная / молодая коллекция [ParNew]
  2. одновременная старые космические коллекции
  3. полная однопотоковая последняя инстанция последней инстанции

(см. Сборка мусора в HotSpot JVM , статья старая, но поясняет фрагменты журналов GC)

незначительный и одновременный в порядке. полное - это плохо.

VisualVM не различает одновременное и полное , поэтому количество «основных» коллекций очень вводит в заблуждение для CMS GC.

PS Возможно, вы захотите использовать плагин «Visual GC», чтобы внимательно следить за динамикой кучи.enter image description here enter image description here

...