1回复
3年前
求助一个近期频发的 CMS GC
JAVA-OPTS=-Xmx16384m -XX:MaxDirectMemorySize=512M \
-XX:+UseParNewGC -XX:+UseConcMarkSweepGC -XX:CMSInitiatingOccupancyFraction=75 \
-verbose:gc -XX:+PrintGCDetails -XX:+PrintGCDateStamps \
-Xloggc:/logs/resourcemanager-$(date +%Y%m%d%H%M%S).gc.log \
-XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath=/logs
gc log
2021-08-13T10:34:45.816+0800: 6217288.704: [GC (CMS Initial Mark) [1 CMS-initial-mark: 1504448K(1963304K)] 1574635K(2592424K), 0.0064612 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:34:45.823+0800: 6217288.710: [CMS-concurrent-mark-start]
2021-08-13T10:34:46.002+0800: 6217288.889: [CMS-concurrent-mark: 0.179/0.179 secs] [Times: user=1.25 sys=0.00, real=0.18 secs]
2021-08-13T10:34:46.002+0800: 6217288.890: [CMS-concurrent-preclean-start]
2021-08-13T10:34:46.011+0800: 6217288.898: [CMS-concurrent-preclean: 0.009/0.009 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:34:46.011+0800: 6217288.899: [CMS-concurrent-abortable-preclean-start]
2021-08-13T10:34:47.289+0800: 6217290.176: [CMS-concurrent-abortable-preclean: 1.273/1.278 secs] [Times: user=1.61 sys=0.23, real=1.28 secs]
2021-08-13T10:34:47.293+0800: 6217290.180: [GC (CMS Final Remark) [YG occupancy: 419332 K (629120 K)]6217290.180: [Rescan (parallel) , 0.0256345 secs]6217290.206: [weak refs processing, 0.0001768 secs]6217290.206: [class unloading, 0.0683217 secs]6217290.274: [scrub symbol table, 0.0064516 secs]6217290.281: [scrub string table, 0.0013440 secs][1 CMS-remark: 1504448K(1963304K)] 1923781K(2592424K), 0.1041847 secs] [Times: user=1.61 sys=0.00, real=0.10 secs]
2021-08-13T10:34:47.397+0800: 6217290.284: [CMS-concurrent-sweep-start]
2021-08-13T10:34:48.469+0800: 6217291.356: [CMS-concurrent-sweep: 1.020/1.072 secs] [Times: user=2.28 sys=0.00, real=1.08 secs]
2021-08-13T10:34:48.469+0800: 6217291.356: [CMS-concurrent-reset-start]
2021-08-13T10:34:48.509+0800: 6217291.396: [CMS-concurrent-reset: 0.040/0.040 secs] [Times: user=0.00 sys=0.00, real=0.03 secs]
2021-08-13T10:35:57.543+0800: 6217360.430: [GC (CMS Initial Mark) [1 CMS-initial-mark: 1503273K(1963304K)] 1573281K(2592424K), 0.0068478 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:35:57.550+0800: 6217360.437: [CMS-concurrent-mark-start]
2021-08-13T10:35:57.729+0800: 6217360.616: [CMS-concurrent-mark: 0.179/0.179 secs] [Times: user=1.34 sys=0.00, real=0.17 secs]
2021-08-13T10:35:57.729+0800: 6217360.616: [CMS-concurrent-preclean-start]
2021-08-13T10:35:57.746+0800: 6217360.634: [CMS-concurrent-preclean: 0.016/0.018 secs] [Times: user=0.00 sys=0.00, real=0.02 secs]
2021-08-13T10:35:57.747+0800: 6217360.634: [CMS-concurrent-abortable-preclean-start]
2021-08-13T10:36:01.077+0800: 6217363.964: [CMS-concurrent-abortable-preclean: 3.252/3.330 secs] [Times: user=6.01 sys=0.30, real=3.33 secs]
2021-08-13T10:36:01.080+0800: 6217363.968: [GC (CMS Final Remark) [YG occupancy: 501531 K (629120 K)]6217363.968: [Rescan (parallel) , 0.0296167 secs]6217363.997: [weak refs processing, 0.0001858 secs]6217363.998: [class unloading, 0.0343178 secs]6217364.032: [scrub symbol table, 0.0054881 secs]6217364.037: [scrub string table, 0.0012802 secs][1 CMS-remark: 1535689K(1963304K)] 2037221K(2592424K), 0.0730644 secs] [Times: user=0.73 sys=0.00, real=0.07 secs]
2021-08-13T10:36:01.154+0800: 6217364.041: [CMS-concurrent-sweep-start]
2021-08-13T10:36:02.233+0800: 6217365.121: [CMS-concurrent-sweep: 1.005/1.080 secs] [Times: user=2.18 sys=0.00, real=1.08 secs]
2021-08-13T10:36:02.234+0800: 6217365.121: [CMS-concurrent-reset-start]
2021-08-13T10:36:02.264+0800: 6217365.151: [CMS-concurrent-reset: 0.030/0.030 secs] [Times: user=0.00 sys=0.00, real=0.03 secs]
2021-08-13T10:37:05.870+0800: 6217428.757: [GC (CMS Initial Mark) [1 CMS-initial-mark: 1474713K(1963304K)] 1544718K(2592424K), 0.0066498 secs] [Times: user=0.00 sys=0.00, real=0.00 secs]
2021-08-13T10:37:05.877+0800: 6217428.764: [CMS-concurrent-mark-start]
2021-08-13T10:37:06.057+0800: 6217428.944: [CMS-concurrent-mark: 0.180/0.180 secs] [Times: user=1.32 sys=0.00, real=0.18 secs]
2021-08-13T10:37:06.057+0800: 6217428.944: [CMS-concurrent-preclean-start]
2021-08-13T10:37:06.074+0800: 6217428.962: [CMS-concurrent-preclean: 0.016/0.018 secs] [Times: user=0.00 sys=0.00, real=0.02 secs]
2021-08-13T10:37:06.074+0800: 6217428.962: [CMS-concurrent-abortable-preclean-start]
2021-08-13T10:37:09.408+0800: 6217432.296: [CMS-concurrent-abortable-preclean: 3.268/3.334 secs] [Times: user=5.95 sys=0.09, real=3.33 secs]
2021-08-13T10:37:09.412+0800: 6217432.299: [GC (CMS Final Remark) [YG occupancy: 465093 K (629120 K)]6217432.299: [Rescan (parallel) , 0.0285142 secs]6217432.328: [weak refs processing, 0.0003991 secs]6217432.328: [class unloading, 0.0374008 secs]6217432.366: [scrub symbol table, 0.0056630 secs]6217432.371: [scrub string table, 0.0013366 secs][1 CMS-remark: 1508253K(1963304K)] 1973347K(2592424K), 0.0755452 secs] [Times: user=0.72 sys=0.00, real=0.07 secs]
2021-08-13T10:37:09.488+0800: 6217432.375: [CMS-concurrent-sweep-start]
2021-08-13T10:37:10.552+0800: 6217433.439: [CMS-concurrent-sweep: 1.015/1.064 secs] [Times: user=2.15 sys=0.00, real=1.07 secs]
2021-08-13T10:37:10.552+0800: 6217433.440: [CMS-concurrent-reset-start]
2021-08-13T10:37:10.583+0800: 6217433.470: [CMS-concurrent-reset: 0.030/0.030 secs] [Times: user=0.00 sys=0.00, real=0.03 secs]
2021-08-13T10:38:17.393+0800: 6217500.281: [GC (CMS Initial Mark) [1 CMS-initial-mark: 1504354K(1963304K)] 1576037K(2592424K), 0.0063269 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:38:17.400+0800: 6217500.287: [CMS-concurrent-mark-start]
2021-08-13T10:38:17.596+0800: 6217500.484: [CMS-concurrent-mark: 0.197/0.197 secs] [Times: user=1.41 sys=0.00, real=0.19 secs]
2021-08-13T10:38:17.597+0800: 6217500.484: [CMS-concurrent-preclean-start]
2021-08-13T10:38:17.608+0800: 6217500.496: [CMS-concurrent-preclean: 0.011/0.012 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:38:17.608+0800: 6217500.496: [CMS-concurrent-abortable-preclean-start]
2021-08-13T10:38:20.849+0800: 6217503.737: [CMS-concurrent-abortable-preclean: 3.175/3.241 secs] [Times: user=4.85 sys=0.30, real=3.25 secs]
2021-08-13T10:38:20.852+0800: 6217503.740: [GC (CMS Final Remark) [YG occupancy: 388737 K (629120 K)]6217503.740: [Rescan (parallel) , 0.0238211 secs]6217503.764: [weak refs processing, 0.0001537 secs]6217503.764: [class unloading, 0.0320226 secs]6217503.796: [scrub symbol table, 0.0056141 secs]6217503.801: [scrub string table, 0.0012932 secs][1 CMS-remark: 1536568K(1963304K)] 1925305K(2592424K), 0.0650416 secs] [Times: user=1.57 sys=0.00, real=0.06 secs]
2021-08-13T10:38:20.917+0800: 6217503.805: [CMS-concurrent-sweep-start]
2021-08-13T10:38:21.981+0800: 6217504.869: [CMS-concurrent-sweep: 0.999/1.064 secs] [Times: user=1.84 sys=0.00, real=1.07 secs]
2021-08-13T10:38:21.982+0800: 6217504.869: [CMS-concurrent-reset-start]
2021-08-13T10:38:22.012+0800: 6217504.899: [CMS-concurrent-reset: 0.031/0.031 secs] [Times: user=0.00 sys=0.00, real=0.03 secs]
2021-08-13T10:39:28.873+0800: 6217571.760: [GC (CMS Initial Mark) [1 CMS-initial-mark: 1501487K(1963304K)] 1571857K(2592424K), 0.0064196 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:39:28.880+0800: 6217571.767: [CMS-concurrent-mark-start]
2021-08-13T10:39:29.070+0800: 6217571.957: [CMS-concurrent-mark: 0.190/0.190 secs] [Times: user=1.33 sys=0.00, real=0.19 secs]
2021-08-13T10:39:29.070+0800: 6217571.958: [CMS-concurrent-preclean-start]
2021-08-13T10:39:29.084+0800: 6217571.971: [CMS-concurrent-preclean: 0.012/0.013 secs] [Times: user=0.00 sys=0.00, real=0.01 secs]
2021-08-13T10:39:29.084+0800: 6217571.971: [CMS-concurrent-abortable-preclean-start]
2021-08-13T10:39:30.347+0800: 6217573.235: [CMS-concurrent-abortable-preclean: 1.258/1.264 secs] [Times: user=1.60 sys=0.00, real=1.26 secs]
2021-08-13T10:39:30.351+0800: 6217573.238: [GC (CMS Final Remark) [YG occupancy: 420076 K (629120 K)]6217573.238: [Rescan (parallel) , 0.0289100 secs]6217573.267: [weak refs processing, 0.0002143 secs]6217573.268: [class unloading, 0.0477647 secs]6217573.315: [scrub symbol table, 0.0063652 secs]6217573.322: [scrub string table, 0.0014570 secs][1 CMS-remark: 1501487K(1963304K)] 1921563K(2592424K), 0.0874964 secs] [Times: user=0.75 sys=0.00, real=0.08 secs]
2021-08-13T10:39:30.439+0800: 6217573.326: [CMS-concurrent-sweep-start]
2021-08-13T10:39:31.506+0800: 6217574.393: [CMS-concurrent-sweep: 1.014/1.067 secs] [Times: user=2.20 sys=0.05, real=1.07 secs]
2021-08-13T10:39:31.506+0800: 6217574.393: [CMS-concurrent-reset-start]
2021-08-13T10:39:31.537+0800: 6217574.425: [CMS-concurrent-reset: 0.032/0.032 secs] [Times: user=0.07 sys=0.02, real=0.03 secs]
1380 阅读