How to show the gc pause time with UseShenandoahGC

[Chunhui Shen]

Is there any vm options to show the gc pause time when using ShenandoahGC?


Here is my gc log when using ShenandoahGC, no gc pause time found:
2015-10-23T15:10:35.919+0800: 1738.275: [GC MakeParsable start total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.919+0800: 1738.275: [GC MakeParsable end, 0.000199 secs total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.919+0800: 1738.275: [GC ClearLiveness start total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.919+0800: 1738.275: [GC ClearLiveness end, 0.000140 secs total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.919+0800: 1738.275: [GC ScanRoots start total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.930+0800: 1738.286: [GC ScanRoots end, 0.011113 secs total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.930+0800: 1738.286: [GC ResizeTLABs start total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.930+0800: 1738.287: [GC ResizeTLABs end, 0.000146 secs total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.930+0800: 1738.287: [GC InitMark end, 0.017967 secs total = 75497472 K, used = 51861702 K free = 23635769 K]
2015-10-23T15:10:35.930+0800: 1738.287: [GC ConcurrentMark start total = 75497472 K, used = 51865240 K free = 23632231 Kcalc used = 51958116 K heap used = 51925350 K]
2015-10-23T15:10:36.146+0800: 1738.502: [GC ConcurrentMark end, 0.215220 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.148+0800: 1738.504: [GC FinalMark start total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.148+0800: 1738.504: [GC RescanRoots start total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.159+0800: 1738.515: [GC RescanRoots end, 0.011034 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.159+0800: 1738.515: [GC DrainSATB start total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.159+0800: 1738.516: [GC DrainSATB end, 0.000559 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.159+0800: 1738.516: [GC DrainQueues start total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.163+0800: 1738.519: [GC DrainQueues end, 0.003586 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.163+0800: 1738.519: [GC WeakRefs start total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.182+0800: 1738.538: [GC WeakRefs end, 0.019088 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.182+0800: 1738.538: [GC FinalMark end, 0.034520 secs total = 75497472 K, used = 52252771 K free = 23244700 K]
2015-10-23T15:10:36.182+0800: 1738.538: [GC PrepareEvac start total = 75497472 K, used = 52252771 K free = 23244700 K]
Collection set used = 18513920 K live = 312119 K reclaimable = 18201800 K
2015-10-23T15:10:36.183+0800: 1738.539: [GC PrepareEvac end, 0.000964 secs total = 75497472 K, used = 23712714 K free = 51784757 K]
2015-10-23T15:10:36.183+0800: 1738.539: [GC InitEvac start total = 75497472 K, used = 23712714 K free = 51784757 K]
2015-10-23T15:10:36.190+0800: 1738.547: [GC InitEvac end, 0.007175 secs total = 75497472 K, used = 23715364 K free = 51782108 K]
2015-10-23T15:10:36.190+0800: 1738.547: [GC ConcurrentEvacuation start total = 75497472 K, used = 23781289 K free = 51716182 Kcalc used = 23843788 K heap used = 23843788 K]
2015-10-23T15:10:36.252+0800: 1738.608: [GC ConcurrentEvacuation end, 0.061384 secs total = 75497472 K, used = 24367172 K free = 51130299 K]
2015-10-23T15:10:36.252+0800: 1738.608: [GC ResetBitmaps start total = 75497472 K, used = 24367172 K free = 51130299 K]
2015-10-23T15:10:36.290+0800: 1738.647: [GC ResetBitmaps end, 0.038490 secs total = 75497472 K, used = 24367172 K free = 51130299 K]
2015-10-23T15:11:14.121+0800: 1776.477: [GC InitMark start total = 75497472 K, used = 51446713 K free = 24050758 K]
2015-10-23T15:11:14.121+0800: 1776.477: [GC AccumulateStats start total = 75497472 K, used = 51446713 K free = 24050758 K]




Thanks