java - G1GC Strange behavior -
i've decided try g1gc on eclipse mars rc3 javaee developers installation, observed strange behavior:
as can see has run 700 full gcs lifecycle of application, while 30 minor gcs. noticed that minor gcs executed when application under load - when starts , loads lot of stuff, while full gcs when it's idle. (it idle of these 11 hours!) expect when application nothing there no need gc, or @ leas minor gc. monitored memory consumption of eclipse - during idle time never incresed more 130-140 mb, 1 more reason why these full gcs strange.
here eclipse.ini jvm config:
-server -xverify:none -xx:+aggressiveopts -xx:+useg1gc -xx:maxgcpausemillis=100 -xx:+usestringdeduplication -xx:+usecompressedoops -xx:+usecompressedclasspointers -xx:maxmetaspacesize=256m -xloggc:/home/svetlin/software/eclipse/gc.log -xx:+printgcdetails -xx:+printgctimestamps -xx:+printgcdatestamps -xx:+usegclogfilerotation -xx:numberofgclogfiles=5 -xx:gclogfilesize=20m -xms1g -xmx1g
here gc log: http://pastebin.com/svbe4w1a
java version: openjdk 64-bit server vm (25.45-b02) linux-amd64 jre (1.8.0_45-internal-b14), built on may 17 2015 19:21:01 "buildd" gcc 4.9.2
do have idea why g1gc these full gc when there not need gc @ ?
you suffering system.gc()
calls can seen in log:
2015-06-14t14:56:23.682+0300: 12790,173: [full gc (system.gc()) 121m->118m(1024m), 0,4524898 secs] [eden: 4096,0k(561,0m)->0,0b(561,0m) survivors: 0,0b->0,0b heap: 121,7m(1024,0m)->118,2m(1024,0m)], [metaspace: 135216k->135216k(1177600k)] [times: user=0,71 sys=0,00, real=0,45 secs] 2015-06-14t14:57:23.682+0300: 12850,174: [full gc (system.gc()) 121m->118m(1024m), 0,4732930 secs] [eden: 3072,0k(561,0m)->0,0b(561,0m) survivors: 0,0b->0,0b heap: 121,2m(1024,0m)->118,2m(1024,0m)], [metaspace: 135216k->135216k(1177600k)] [times: user=0,73 sys=0,00, real=0,47 secs] 2015-06-14t14:58:28.684+0300: 12915,175: [full gc (system.gc()) 169m->118m(1024m), 0,4912699 secs] [eden: 52,0m(561,0m)->0,0b(561,0m) survivors: 0,0b->0,0b heap: 169,9m(1024,0m)->118,8m(1024,0m)], [metaspace: 135601k->135601k(1177600k)] [times: user=0,74 sys=0,00, real=0,49 secs]
the system.gc()
calls seem happen once every minute. run weird plugins cause this?
otherwise, periodic system.gc()
calls due java rmi runtime calling them. on older java versions think done every minute increased once every hour. regardless, try setting properties sure:
-dsun.rmi.dgc.server.gcinterval=999999999 -dsun.rmi.dgc.client.gcinterval=999999999
as jvm options.
Comments
Post a Comment