Hi Thomas:

I adjustment young generation(add option -XX:MaxNewSize=2G) and  jvm option  -XX:+UseCondCardMark. young gc performance is good.  The following is the test result: 

2019-09-18T16:11:48.855+0800: 7.548: [GC (Allocation Failure) 2019-09-18T16:11:48.855+0800: 7.549: [ParNew: 1677824K->15120K(1887488K), 0.0930820 secs] 1677824K->15120K(6081792K), 0.0933637 secs] [Times: user=0.52 sys=0.02, real=0.09 secs] 
2019-09-18T16:11:55.039+0800: 13.732: [GC (Allocation Failure) 2019-09-18T16:11:55.039+0800: 13.732: [ParNew: 1692944K->29125K(1887488K), 0.1679678 secs] 1692944K->42590K(6081792K), 0.1681202 secs] [Times: user=0.48 sys=0.01, real=0.17 secs] 
2019-09-18T16:12:00.457+0800: 19.150: [GC (Allocation Failure) 2019-09-18T16:12:00.457+0800: 19.150: [ParNew: 1706949K->42066K(1887488K), 0.0748636 secs] 1720414K->79771K(6081792K), 0.0750874 secs] [Times: user=0.56 sys=0.01, real=0.08 secs] 
2019-09-18T16:12:03.884+0800: 22.577: [GC (Allocation Failure) 2019-09-18T16:12:03.884+0800: 22.578: [ParNew: 1719890K->32733K(1887488K), 0.0827623 secs] 1757595K->100491K(6081792K), 0.0830139 secs] [Times: user=0.35 sys=0.02, real=0.08 secs] 
2019-09-18T16:12:07.091+0800: 25.784: [GC (Allocation Failure) 2019-09-18T16:12:07.091+0800: 25.784: [ParNew: 1710557K->20205K(1887488K), 0.0601293 secs] 1778315K->102135K(6081792K), 0.0604077 secs] [Times: user=0.33 sys=0.01, real=0.06 secs] 
2019-09-18T16:17:54.138+0800: 372.831: [GC (Allocation Failure) 2019-09-18T16:17:54.138+0800: 372.832: [ParNew: 1698029K->30694K(1887488K), 0.0856543 secs] 1779959K->120901K(6081792K), 0.0866636 secs] [Times: user=0.82 sys=0.02, real=0.09 secs] 
2019-09-18T16:18:02.910+0800: 381.604: [GC (Allocation Failure) 2019-09-18T16:18:02.911+0800: 381.604: [ParNew: 1708518K->26661K(1887488K), 0.0643907 secs] 1798725K->135391K(6081792K), 0.0651947 secs] [Times: user=0.38 sys=0.02, real=0.06 secs] 
2019-09-18T16:18:47.382+0800: 426.075: [GC (Allocation Failure) 2019-09-18T16:18:47.382+0800: 426.076: [ParNew: 1704485K->9160K(1887488K), 0.0382246 secs] 1813215K->132381K(6081792K), 0.0388612 secs] [Times: user=0.29 sys=0.00, real=0.04 secs] 
2019-09-18T16:19:01.638+0800: 440.331: [GC (Allocation Failure) 2019-09-18T16:19:01.638+0800: 440.332: [ParNew: 1686984K->2431K(1887488K), 0.0260851 secs] 1810205K->125945K(6081792K), 0.0267197 secs] [Times: user=0.18 sys=0.00, real=0.03 secs] 
2019-09-18T16:19:28.281+0800: 466.974: [GC (Allocation Failure) 2019-09-18T16:19:28.281+0800: 466.975: [ParNew: 1680255K->1038K(1887488K), 0.0224859 secs] 1803769K->124617K(6081792K), 0.0231843 secs] [Times: user=0.27 sys=0.00, real=0.02 secs] 
2019-09-18T16:19:50.902+0800: 489.596: [GC (Allocation Failure) 2019-09-18T16:19:50.903+0800: 489.596: [ParNew: 1678862K->490K(1887488K), 0.0219144 secs] 1802441K->124098K(6081792K), 0.0222766 secs] [Times: user=0.27 sys=0.00, real=0.02 secs] 
2019-09-18T16:20:12.396+0800: 511.089: [GC (Allocation Failure) 2019-09-18T16:20:12.396+0800: 511.090: [ParNew: 1678314K->302K(1887488K), 0.0709556 secs] 1801922K->123933K(6081792K), 0.0715986 secs] [Times: user=0.25 sys=0.03, real=0.07 secs] 
2019-09-18T16:20:23.951+0800: 522.645: [GC (Allocation Failure) 2019-09-18T16:20:23.952+0800: 522.645: [ParNew: 1678126K->465K(1887488K), 0.0149990 secs] 1801757K->124156K(6081792K), 0.0154312 secs] [Times: user=0.12 sys=0.00, real=0.01 secs] 
2019-09-18T16:20:42.784+0800: 541.478: [GC (Allocation Failure) 2019-09-18T16:20:42.785+0800: 541.478: [ParNew: 1678289K->248K(1887488K), 0.0262949 secs] 1801980K->123951K(6081792K), 0.0269588 secs] [Times: user=0.23 sys=0.00, real=0.03 secs] 
2019-09-18T16:21:00.324+0800: 559.018: [GC (Allocation Failure) 2019-09-18T16:21:00.325+0800: 559.018: [ParNew: 1678072K->509K(1887488K), 0.0255606 secs] 1801775K->124222K(6081792K), 0.0261868 secs] [Times: user=0.24 sys=0.00, real=0.03 secs] 
2019-09-18T16:21:28.636+0800: 587.329: [GC (Allocation Failure) 2019-09-18T16:21:28.636+0800: 587.329: [ParNew: 1678333K->253K(1887488K), 0.0186502 secs] 1802046K->124001K(6081792K), 0.0189960 secs] [Times: user=0.12 sys=0.00, real=0.02 secs] 
2019-09-18T16:21:48.353+0800: 607.047: [GC (Allocation Failure) 2019-09-18T16:21:48.353+0800: 607.047: [ParNew: 1678077K->229K(1887488K), 0.0126195 secs] 1801825K->124020K(6081792K), 0.0129481 secs] [Times: user=0.14 sys=0.00, real=0.01 secs] 
2019-09-18T16:22:08.502+0800: 627.196: [GC (Allocation Failure) 2019-09-18T16:22:08.503+0800: 627.196: [ParNew: 1678053K->991K(1887488K), 0.0288644 secs] 1801844K->124789K(6081792K), 0.0295153 secs] [Times: user=0.31 sys=0.00, real=0.03 secs] 
2019-09-18T16:22:20.935+0800: 639.629: [GC (Allocation Failure) 2019-09-18T16:22:20.935+0800: 639.629: [ParNew: 1678815K->490K(1887488K), 0.0132877 secs] 1802613K->124475K(6081792K), 0.0137042 secs] [Times: user=0.15 sys=0.00, real=0.02 secs] 
2019-09-18T16:22:47.196+0800: 665.890: [GC (Allocation Failure) 2019-09-18T16:22:47.197+0800: 665.890: [ParNew: 1678314K->209K(1887488K), 0.0265394 secs] 1802299K->124203K(6081792K), 0.0269575 secs] [Times: user=0.31 sys=0.00, real=0.03 secs] 
2019-09-18T16:23:26.972+0800: 705.666: [GC (Allocation Failure) 2019-09-18T16:23:26.972+0800: 705.666: [ParNew: 1678033K->232K(1887488K), 0.0120621 secs] 1802027K->124233K(6081792K), 0.0124285 secs] [Times: user=0.14 sys=0.01, real=0.01 secs] 
2019-09-18T16:24:12.279+0800: 750.973: [GC (Allocation Failure) 2019-09-18T16:24:12.280+0800: 750.973: [ParNew: 1678056K->237K(1887488K), 0.0149379 secs] 1802057K->124254K(6081792K), 0.0152761 secs] [Times: user=0.20 sys=0.00, real=0.01 secs] 
2019-09-18T16:24:39.330+0800: 778.023: [GC (Allocation Failure) 2019-09-18T16:24:39.330+0800: 778.024: [ParNew: 1678061K->319K(1887488K), 0.0121459 secs] 1802078K->124365K(6081792K), 0.0125020 secs] [Times: user=0.15 sys=0.00, real=0.01 secs] 
2019-09-18T16:25:21.456+0800: 820.150: [GC (Allocation Failure) 2019-09-18T16:25:21.457+0800: 820.150: [ParNew: 1678143K->283K(1887488K), 0.0121017 secs] 1802189K->124427K(6081792K), 0.0125083 secs] [Times: user=0.17 sys=0.00, real=0.01 secs] 
2019-09-18T16:25:42.295+0800: 840.989: [GC (Allocation Failure) 2019-09-18T16:25:42.296+0800: 840.989: [ParNew: 1678107K->330K(1887488K), 0.0103852 secs] 1802251K->124516K(6081792K), 0.0107008 secs] [Times: user=0.13 sys=0.00, real=0.01 secs] 
2019-09-18T16:25:59.550+0800: 858.243: [GC (Allocation Failure) 2019-09-18T16:25:59.550+0800: 858.243: [ParNew: 1678154K->217K(1887488K), 0.0138046 secs] 1802340K->124407K(6081792K), 0.0142143 secs] [Times: user=0.15 sys=0.00, real=0.01 secs] 

Thanks!


----- 回复邮件 -----
发信人:Thomas Schatzl <thomas.scha...@oracle.com>
收信人:"Yan Gang" <yang...@ec.com.cn>,"hotspot-gc-use" <hotspot-gc-use@openjdk.java.net>
时  间:2019年09月13日 17时24分33秒
主  题:Re: question of ParNewGeneration::real_forwardee_slow


Hi,

On 12.09.19 11:38, Yan Gang wrote:
> Thomas:
>
> I modify Java option :

I really recommend only doing one thing at a time: i.e. not change
options *and* the environment at the same time, or try to find new
causes for the issues. That will most likely only confuse or scare you,
and often these are connected in some way, so fixing one may solve the
other (or may obviate the need to "fix" them).

The environment exhibits very long sys times in your log output which I
recommend to investigate. They also seem to be causing most of the
slowdown. I.e. it seems wise to understand and fix these first.

In addition to simply trying the fixes for the most common issues
presented in the tuning guide, you can use system tools like
iostat/vmstat/* to get to understand your environment behavior more.

Thanks,
Thomas

Attachment: gc.log
Description: Binary data

_______________________________________________
hotspot-gc-use mailing list
hotspot-gc-use@openjdk.java.net
https://mail.openjdk.java.net/mailman/listinfo/hotspot-gc-use

Reply via email to