CMS Collector GC Log Sample

以下に、「CMS Collector GC Log Sample:Promotion Failureが発生していない場合」を示します。

0.138: [GC 0.138: [ParNew: 26240K->3264K(29504K), 0.0503947 secs] 26240K->8241K(521024K), 
　　　　0.0505461 secs]
0.208: [GC 0.208: [ParNew: 29504K->3264K(29504K), 0.0584993 secs] 34481K->16437K(521024K), 
　　　　0.0586376 secs]
0.288: [GC 0.288: [ParNew: 29504K->3264K(29504K), 0.0537040 secs] 42677K->24310K(521024K), 
　　　　0.0538141 secs]
0.361: [GC 0.361: [ParNew: 29504K->3264K(29504K), 0.0531213 secs] 50550K->32191K(521024K), 
　　　　0.0532422 secs]
0.433: [GC 0.433: [ParNew: 29504K->3264K(29504K), 0.0522256 secs] 58431K->41322K(521024K), 
　　　　0.0523589 secs]
0.504: [GC 0.504: [ParNew: 29504K->3264K(29504K), 0.0537750 secs] 67562K->49221K(521024K), 
　　　　0.0538940 secs]
0.577: [GC 0.577: [ParNew: 29504K->3263K(29504K), 0.0562242 secs] 75461K->58279K(521024K), 
　　　　0.0563734 secs]
0.653: [GC 0.653: [ParNew: 29503K->3263K(29504K), 0.0558789 secs] 84519K->68016K(521024K), 
　　　　0.0560082 secs]
0.732: [GC 0.732: [ParNew: 27819K->3263K(29504K), 0.0512057 secs] 92572K->75318K(521024K), 
　　　　0.0513152 secs]
0.816: [GC 0.816: [ParNew: 29503K->3263K(29504K), 0.0513719 secs] 101558K->85021K(521024K), 
　　　　0.0515082 secs]
0.887: [GC 0.887: [ParNew: 29503K->3263K(29504K), 0.0702126 secs] 111261K->92865K(521024K), 
　　　　0.0703385 secs]
0.977: [GC 0.977: [ParNew: 29493K->3263K(29504K), 0.0582202 secs] 119095K->103417K(521024K), 
　　　　0.0583747 secs]
1.069: [GC 1.069: [ParNew: 29503K->3263K(29504K), 0.0579582 secs] 129657K->111277K(521024K), 
　　　　0.0580817 secs]
1.147: [GC 1.147: [ParNew: 29503K->3263K(29504K), 0.0552400 secs] 137517K->121900K(521024K), 
　　　　0.0553679 secs]
1.221: [GC 1.222: [ParNew: 29503K->3263K(29504K), 0.0520387 secs] 148140K->129770K(521024K), 
　　　　0.0521723 secs]
1.308: [GC 1.308: [ParNew: 29503K->3263K(29504K), 0.0558130 secs] 156010K->137626K(521024K), 
　　　　0.0559367 secs]
1.383: [GC 1.383: [ParNew: 29503K->3263K(29504K), 0.0581504 secs] 163866K->145567K(521024K), 
　　　　0.0582719 secs]
1.462: [GC 1.462: [ParNew: 29503K->3263K(29504K), 0.0279485 secs] 171807K->147913K(521024K), 
　　　　0.0280438 secs]
1.509: [GC 1.509: [ParNew: 29503K->3263K(29504K), 0.0566304 secs] 174153K->156086K(521024K), 
　　　　0.0567388 secs]
1.590: [GC 1.590: [ParNew: 29503K->3263K(29504K), 0.0578604 secs] 182326K->164342K(521024K), 
　　　　0.0579853 secs]
1.673: [GC 1.673: [ParNew: 29503K->3263K(29504K), 0.0427951 secs] 190582K->170096K(521024K), 
　　　　0.0428912 secs]
1.736: [GC 1.736: [ParNew: 29503K->3263K(29504K), 0.0549346 secs] 196336K->178546K(521024K), 
　　　　0.0550402 secs]
1.822: [GC 1.822: [ParNew: 29503K->3263K(29504K), 0.0617031 secs] 204786K->186966K(521024K), 
　　　　0.0617919 secs]
1.913: [GC 1.913: [ParNew: 29503K->3263K(29504K), 0.0565309 secs] 213206K->195428K(521024K), 
　　　　0.0566399 secs]
1.988: [GC 1.988: [ParNew: 29503K->3262K(29504K), 0.0596696 secs] 221668K->203868K(521024K), 
　　　　0.0597830 secs]
2.072: [GC 2.072: [ParNew: 29502K->3262K(29504K), 0.0556364 secs] 230108K->212328K(521024K), 
　　　　0.0557328 secs]
2.146: [GC 2.146: [ParNew: 29502K->3262K(29504K), 0.0548838 secs] 238568K->220786K(521024K), 
　　　　0.0549944 secs]
2.221: [GC 2.221: [ParNew: 29502K->3262K(29504K), 0.0598263 secs] 247026K->229297K(521024K), 
　　　　0.0599146 secs]
2.299: [GC 2.299: [ParNew: 29502K->3262K(29504K), 0.0552330 secs] 255537K->237734K(521024K), 
　　　　0.0553336 secs]
2.373: [GC 2.373: [ParNew: 29502K->3262K(29504K), 0.0603222 secs] 263974K->246197K(521024K), 
　　　　0.0604208 secs]
2.454: [GC 2.454: [ParNew: 29502K->3262K(29504K), 0.0537571 secs] 272437K->254638K(521024K), 
　　　　0.0538557 secs]
2.526: [GC 2.526: [ParNew: 29502K->3262K(29504K), 0.0668088 secs] 280878K->263101K(521024K), 
　　　　0.0669197 secs]
2.593: [GC [1 CMS-initial-mark: 259838K(491520K)] 263365K(521024K), 0.0023419 secs]
2.596: [CMS-concurrent-mark-start]
2.646: [GC 2.646: [ParNew: 29502K->3262K(29504K), 0.0642959 secs] 289341K->271436K(521024K), 
　　　　0.0643864 secs]
2.744: [GC 2.744: [ParNew: 29502K->3262K(29504K), 0.0674348 secs] 297676K->279900K(521024K), 
　　　　0.0675192 secs]
2.846: [GC 2.846: [ParNew: 29502K->3262K(29504K), 0.0626507 secs] 306140K->288317K(521024K), 
　　　　0.0627529 secs]
2.947: [GC 2.947: [ParNew: 29502K->3262K(29504K), 0.0233147 secs] 314557K->290129K(521024K), 
　　　　0.0234083 secs]
2.988: [GC 2.988: [ParNew: 29502K->3262K(29504K), 0.0615486 secs] 316369K->298589K(521024K), 
　　　　0.0617458 secs]
3.084: [GC 3.084: [ParNew: 29502K->3262K(29504K), 0.0698357 secs] 324829K->306926K(521024K), 
　　　　0.0699226 secs]
3.203: [GC 3.203: [ParNew: 29502K->3262K(29504K), 0.0596520 secs] 333166K->315389K(521024K), 
　　　　0.0597347 secs]
3.297: [GC 3.297: [ParNew: 29502K->3262K(29504K), 0.0715789 secs] 341629K->323814K(521024K), 
　　　　0.0716789 secs]
3.406: [GC 3.406: [ParNew: 29502K->3262K(29504K), 0.0401529 secs] 350054K->328510K(521024K), 
　　　　0.0402624 secs]
3.468: [GC 3.468: [ParNew: 29502K->3262K(29504K), 0.0642811 secs] 354750K->336924K(521024K), 
　　　　0.0643766 secs]
3.566: [GC 3.566: [ParNew: 29502K->3262K(29504K), 0.0639919 secs] 363164K->345325K(521024K), 
　　　　0.0640880 secs]
3.664: [GC 3.664: [ParNew: 29502K->3262K(29504K), 0.0629745 secs] 371565K->353772K(521024K), 
　　　　0.0630885 secs]
3.761: [GC 3.761: [ParNew: 29502K->3262K(29504K), 0.0620040 secs] 380012K->362266K(521024K), 
　　　　0.0620970 secs]
3.858: [GC 3.858: [ParNew: 29502K->3262K(29504K), 0.0634712 secs] 388506K->370722K(521024K), 
　　　　0.0635525 secs]
3.942: [GC 3.942: [ParNew: 29502K->3262K(29504K), 0.0620791 secs] 396962K->379118K(521024K), 
　　　　0.0621710 secs]
4.050: [GC 4.050: [ParNew: 29502K->3262K(29504K), 0.0668317 secs] 405358K->387582K(521024K), 
　　　　0.0669457 secs]
4.151: [GC 4.151: [ParNew: 29502K->3262K(29504K), 0.0634262 secs] 413822K->395989K(521024K), 
　　　　0.0635282 secs]
4.248: [GC 4.248: [ParNew: 29502K->3262K(29504K), 0.0681735 secs] 422229K->404426K(521024K), 
　　　　0.0682900 secs]
4.357: [CMS-concurrent-mark: 0.655/1.761 secs]
4.357: [CMS-concurrent-preclean-start]
4.362: [GC 4.362: [ParNew: 29502K->3262K(29504K), 0.0448459 secs] 430666K->409290K(521024K), 
　　　　0.0449445 secs]
4.419: [CMS-concurrent-preclean: 0.040/0.062 secs]
4.419: [CMS-concurrent-abortable-preclean-start]
4.428: [CMS-concurrent-abortable-preclean: 0.007/0.010 secs]
4.436: [GC 4.436: [ParNew: 29502K->3262K(29504K), 0.0662626 secs] 435530K->417739K(521024K), 
　　　　0.0663598 secs]
4.520: [GC 4.521: [ParNew: 29502K->3262K(29504K), 0.0667493 secs] 443979K->426201K(521024K), 
　　　　0.0668426 secs]
4.588: [GC[YG occupancy: 3619 K (29504 K)]4.588: [Rescan (parallel) , 0.0148329 secs]4.603: 
　　　　[weak refs processing, 0.0000291 secs] [1 CMS-remark: 422939K(491520K)] 426559K(521024K), 
　　　　0.0149645 secs]
4.623: [GC 4.623: [ParNew: 29502K->3262K(29504K), 0.0654511 secs] 452441K->434579K(521024K), 
　　　　0.0655444 secs]
4.688: [CMS-concurrent-sweep-start]
4.735: [GC 4.735: [ParNew: 29502K->3262K(29504K), 0.0608980 secs] 430822K->413067K(521024K), 
　　　　0.0609902 secs]
4.830: [GC 4.830: [ParNew: 29502K->3262K(29504K), 0.0607605 secs] 406054K->388278K(521024K), 
　　　　0.0608535 secs]
4.926: [GC 4.926: [ParNew: 29502K->3262K(29504K), 0.0618269 secs] 385507K->367646K(521024K), 
　　　　0.0619255 secs]
5.040: [GC 5.040: [ParNew: 29502K->3262K(29504K), 0.0632877 secs] 363774K->345998K(521024K), 
　　　　0.0633745 secs]
5.140: [GC 5.140: [ParNew: 29502K->3262K(29504K), 0.0614740 secs] 353345K->335538K(521024K), 
　　　　0.0615578 secs]
5.236: [GC 5.236: [ParNew: 29502K->3262K(29504K), 0.0654787 secs] 359549K->341780K(521024K), 
　　　　0.0655703 secs]
5.321: [GC 5.321: [ParNew: 29502K->3262K(29504K), 0.0609645 secs] 368020K->350182K(521024K), 
　　　　0.0610731 secs]
5.425: [CMS-concurrent-sweep: 0.302/0.737 secs]
5.425: [CMS-concurrent-reset-start]
5.439: [GC 5.439: [ParNew: 29502K->3262K(29504K), 0.0500287 secs] 376422K->358628K(521024K), 
　　　　0.0501530 secs]
5.489: [CMS-concurrent-reset: 0.014/0.064 secs]
5.507: [GC 5.508: [ParNew: 29502K->3264K(29504K), 0.0569966 secs] 384868K->367069K(521024K), 
　　　　0.0571087 secs]
5.566: [GC [1 CMS-initial-mark: 363805K(491520K)] 369491K(521024K), 0.0041036 secs]
5.570: [CMS-concurrent-mark-start]
5.605: [GC 5.605: [ParNew: 29504K->3263K(29504K), 0.0151078 secs] 393309K->368350K(521024K), 
　　　　0.0151908 secs]
5.655: [GC 5.655: [ParNew: 29503K->3264K(29504K), 0.0567148 secs] 394590K->375689K(521024K), 
　　　　0.0568131 secs]
5.750: [GC 5.750: [ParNew: 29504K->3264K(29504K), 0.0202414 secs] 401929K->377662K(521024K), 
　　　　0.0203210 secs]
5.804: [GC 5.804: [ParNew: 29504K->3264K(29504K), 0.0608035 secs] 403902K->385765K(521024K), 
　　　　0.0608949 secs]
5.895: [GC 5.895: [ParNew: 29504K->3264K(29504K), 0.0688118 secs] 412005K->394227K(521024K), 
　　　　0.0689370 secs]
5.997: [GC 5.997: [ParNew: 29504K->3264K(29504K), 0.0583597 secs] 420467K->402630K(521024K), 
　　　　0.0584499 secs]
6.089: [GC 6.090: [ParNew: 29504K->3264K(29504K), 0.0639693 secs] 428870K->411005K(521024K), 
　　　　0.0640634 secs]
6.173: [GC 6.173: [ParNew: 29504K->3262K(29504K), 0.0665931 secs] 437245K->419435K(521024K), 
　　　　0.0666940 secs]
6.274: [GC 6.274: [ParNew: 29502K->3262K(29504K), 0.0650088 secs] 445675K->427892K(521024K), 
　　　　0.0651111 secs]
6.373: [GC 6.373: [ParNew (promotion failed): 29502K->29502K(29504K), 0.1050159 secs]6.478: 
　　　　[CMSbailing out to foreground collection
6.581: [CMS-concurrent-mark: 0.426/1.011 secs]
 (concurrent mode failure): 433005K->73849K(491520K), 0.6122303 secs] 454132K->73849K(521024K), 
　　　　0.7174085 secs]
7.111: [GC 7.111: [ParNew: 26240K->3262K(29504K), 0.0412245 secs] 100089K->82581K(521024K), 
　　　　0.0413231 secs]
7.171: [GC 7.171: [ParNew: 29502K->3262K(29504K), 0.0535071 secs] 108821K->91380K(521024K), 
　　　　0.0536440 secs]
7.243: [GC 7.243: [ParNew: 29502K->3262K(29504K), 0.0514160 secs] 117620K->99918K(521024K), 
　　　　0.0515219 secs]
7.312: [GC 7.313: [ParNew: 29502K->3262K(29504K), 0.0511682 secs] 126158K->108347K(521024K), 
　　　　0.0512724 secs]
7.386: [GC 7.386: [ParNew: 29502K->3262K(29504K), 0.0563790 secs] 134587K->116867K(521024K), 
　　　　0.0565153 secs]
7.462: [GC 7.462: [ParNew: 29502K->3262K(29504K), 0.0526807 secs] 143107K->125300K(521024K), 
　　　　0.0527793 secs]
7.533: [GC 7.533: [ParNew: 29502K->3262K(29504K), 0.0515119 secs] 151540K->133751K(521024K), 
　　　　0.0516216 secs]
7.603: [GC 7.603: [ParNew: 29502K->3262K(29504K), 0.0514283 secs] 159991K->142214K(521024K), 
　　　　0.0515348 secs]
7.684: [GC 7.684: [ParNew: 29502K->3262K(29504K), 0.0570545 secs] 168454K->150662K(521024K), 
　　　　0.0571508 secs]
7.761: [GC 7.761: [ParNew: 29502K->3262K(29504K), 0.0511909 secs] 176902K->159102K(521024K), 
　　　　0.0512884 secs]
7.832: [GC 7.833: [ParNew: 29502K->3262K(29504K), 0.0443263 secs] 185342K->164499K(521024K), 
　　　　0.0444171 secs]
7.898: [GC 7.898: [ParNew: 29502K->3262K(29504K), 0.0448367 secs] 190739K->170991K(521024K), 
　　　　0.0449429 secs]
7.961: [GC 7.962: [ParNew: 29502K->3262K(29504K), 0.0514451 secs] 197231K->179485K(521024K), 
　　　　0.0515331 secs]
8.013: [GC [1 CMS-initial-mark: 176222K(491520K)] 179777K(521024K), 0.0022687 secs]
8.016: [CMS-concurrent-mark-start]
8.050: [GC 8.050: [ParNew: 29502K->3262K(29504K), 0.0571791 secs] 205725K->187818K(521024K), 
　　　　0.0572673 secs]
8.141: [GC 8.141: [ParNew: 29502K->3262K(29504K), 0.0649747 secs] 214058K->196235K(521024K), 
　　　　0.0650661 secs]
8.240: [GC 8.240: [ParNew: 29502K->3262K(29504K), 0.0611315 secs] 222475K->204698K(521024K), 
　　　　0.0612195 secs]
8.303: [CMS-concurrent-mark: 0.103/0.288 secs]
8.303: [CMS-concurrent-preclean-start]
8.320: [CMS-concurrent-preclean: 0.016/0.016 secs]
8.320: [CMS-concurrent-abortable-preclean-start]
8.325: [CMS-concurrent-abortable-preclean: 0.005/0.005 secs]
8.333: [GC 8.333: [ParNew: 29502K->3262K(29504K), 0.0613265 secs] 230938K->213148K(521024K), 
　　　　0.0614221 secs]
8.399: [GC[YG occupancy: 10481 K (29504 K)]8.399: [Rescan (parallel) , 0.0109743 secs]8.410: 
　　　　[weak refs processing, 0.0000305 secs] [1 CMS-remark: 209886K(491520K)] 220367K(521024K), 
　　　　0.0111067 secs]
8.412: [CMS-concurrent-sweep-start]
8.436: [GC 8.436: [ParNew: 29502K->3262K(29504K), 0.0575637 secs] 224597K->206648K(521024K), 
　　　　0.0577017 secs]
8.530: [GC 8.530: [ParNew: 29502K->3262K(29504K), 0.0592955 secs] 210572K->192796K(521024K), 
　　　　0.0593860 secs]
8.625: [GC 8.625: [ParNew: 29502K->3262K(29504K), 0.0562027 secs] 203278K->185377K(521024K), 
　　　　0.0562982 secs]
8.718: [GC 8.718: [ParNew: 29502K->3264K(29504K), 0.0566457 secs] 189205K->171410K(521024K), 
　　　　0.0567734 secs]
8.844: [GC 8.845: [ParNew: 29504K->3263K(29504K), 0.0614492 secs] 153910K->136133K(521024K), 
　　　　0.0615528 secs]
8.942: [GC 8.943: [ParNew: 29503K->3263K(29504K), 0.0620383 secs] 140075K->122299K(521024K), 
　　　　0.0621428 secs]
9.029: [GC 9.029: [ParNew: 29503K->3263K(29504K), 0.0590625 secs] 142067K->124299K(521024K), 
　　　　0.0591556 secs]
9.105: [CMS-concurrent-sweep: 0.278/0.693 secs]
9.105: [CMS-concurrent-reset-start]
9.118: [CMS-concurrent-reset: 0.013/0.013 secs]
9.127: [GC 9.127: [ParNew: 29503K->3263K(29504K), 0.0322991 secs] 147113K->125429K(521024K), 
　　　　0.0323893 secs]
9.178: [GC 9.178: [ParNew: 29503K->3263K(29504K), 0.0573495 secs] 151669K->133928K(521024K), 
　　　　0.0574517 secs]
9.254: [GC 9.254: [ParNew: 29503K->3263K(29504K), 0.0508296 secs] 160168K->142391K(521024K), 
　　　　0.0509238 secs]
9.323: [GC 9.323: [ParNew: 29503K->3263K(29504K), 0.0550260 secs] 168631K->150848K(521024K), 
　　　　0.0551383 secs]
9.397: [GC 9.397: [ParNew: 29503K->3263K(29504K), 0.0557409 secs] 177088K->159299K(521024K), 
　　　　0.0558454 secs]
9.471: [GC 9.471: [ParNew: 29503K->3263K(29504K), 0.0563580 secs] 185539K->167752K(521024K), 
　　　　0.0564594 secs]
9.548: [GC 9.548: [ParNew: 29503K->3263K(29504K), 0.0539613 secs] 193992K->176196K(521024K), 
　　　　0.0540627 secs]
9.621: [GC 9.621: [ParNew: 29503K->3263K(29504K), 0.0502547 secs] 202436K->184646K(521024K), 
　　　　0.0503620 secs]
9.671: [GC [1 CMS-initial-mark: 181382K(491520K)] 185186K(521024K), 0.0025285 secs]
9.674: [CMS-concurrent-mark-start]
9.699: [GC 9.699: [ParNew: 29503K->3263K(29504K), 0.0631477 secs] 210886K->192940K(521024K), 
　　　　0.0632382 secs]
9.831: [GC 9.831: [ParNew: 29503K->3263K(29504K), 0.0271440 secs] 219180K->195871K(521024K), 
　　　　0.0272384 secs]
9.893: [GC 9.893: [ParNew: 29503K->3264K(29504K), 0.0580984 secs] 222111K->203792K(521024K), 
　　　　0.0582074 secs]
9.986: [GC 9.986: [ParNew: 29504K->3264K(29504K), 0.0607988 secs] 230032K->212157K(521024K), 
　　　　0.0608971 secs]
10.082: [GC 10.082: [ParNew: 29504K->3264K(29504K), 0.0658888 secs] 238397K->220557K(521024K), 
　　　　0.0659782 secs]
10.319: [CMS-concurrent-mark: 0.361/0.645 secs]
10.319: [CMS-concurrent-preclean-start]
10.327: [CMS-concurrent-preclean: 0.008/0.008 secs]
10.327: [CMS-concurrent-abortable-preclean-start]
10.327: [CMS-concurrent-abortable-preclean: 0.000/0.000 secs]
10.331: [GC[YG occupancy: 23060 K (29504 K)]10.331: [Rescan (parallel) , 0.0155984 secs]10.346: 
　　　　 [weak refs processing, 0.0000274 secs] [1 CMS-remark: 217293K(491520K)] 240353K(521024K), 
　　　　 0.0157232 secs]
10.348: [CMS-concurrent-sweep-start]
10.542: [CMS-concurrent-sweep: 0.194/0.194 secs]
10.542: [CMS-concurrent-reset-start]
10.553: [CMS-concurrent-reset: 0.011/0.011 secs]
Heap
 par new generation   total 29504K, used 23060K [0x10070000, 0x12070000, 0x12070000)
  eden space 26240K,  75% used [0x10070000, 0x113c51e0, 0x11a10000)
  from space 3264K, 100% used [0x11d40000, 0x12070000, 0x12070000)
  to   space 3264K,   0% used [0x11a10000, 0x11a10000, 0x11d40000)
 concurrent mark-sweep generation total 491520K, used 143074K [0x12070000, 0x30070000, 0x30070000)
 concurrent-mark-sweep perm gen total 12288K, used 2021K [0x30070000, 0x30c70000, 0x34070000)

以下に、「CMS Collector GC Log Sample:Promotion Failureが発生した場合」を示します。

0.110: [GC 0.110: [ParNew: 13184K->1600K(14784K), 0.0247395 secs] 13184K->4518K(63936K), 
　　　　0.0249462 secs]
0.146: [GC 0.146: [ParNew: 14784K->1600K(14784K), 0.0313596 secs] 17702K->8609K(63936K), 
　　　　0.0315099 secs]
0.188: [GC 0.188: [ParNew: 14784K->1600K(14784K), 0.0284701 secs] 21793K->12607K(63936K), 
　　　　0.0286411 secs]
0.226: [GC 0.226: [ParNew: 14784K->1600K(14784K), 0.0261871 secs] 25791K->16606K(63936K), 
　　　　0.0263603 secs]
0.262: [GC 0.262: [ParNew: 14784K->1600K(14784K), 0.0263550 secs] 29790K->21136K(63936K), 
　　　　0.0265084 secs]
0.299: [GC 0.299: [ParNew: 14784K->1598K(14784K), 0.0236659 secs] 34320K->25095K(63936K), 
　　　　0.0238114 secs]
0.332: [GC 0.332: [ParNew: 14782K->1598K(14784K), 0.0306274 secs] 38279K->29088K(63936K), 
　　　　0.0307718 secs]
0.363: [GC [1 CMS-initial-mark: 27490K(49152K)] 29362K(63936K), 0.0013097 secs]
0.365: [CMS-concurrent-mark-start]
0.381: [GC 0.382: [ParNew: 14782K->1598K(14784K), 0.0317082 secs] 42272K->33738K(63936K), 
　　　　0.0318448 secs]
0.431: [GC 0.431: [ParNew: 14782K->1598K(14784K), 0.0318052 secs] 46922K->37701K(63936K), 
　　　　0.0319393 secs]
0.480: [GC 0.480: [ParNew: 14782K->1598K(14784K), 0.0329341 secs] 50885K->42468K(63936K), 
　　　　0.0330668 secs]
0.530: [GC 0.530: [ParNew: 14316K->1598K(14784K), 0.0311347 secs] 55186K->46279K(63936K), 
　　　　0.0312531 secs]
0.578: [GC 0.578: [ParNew: 14782K->14782K(14784K), 0.0000422 secs]0.578: 
　　　　[CMSbailing out to foreground collection
0.591: [CMS-concurrent-mark: 0.097/0.226 secs]
 (concurrent mode failure): 44680K->47947K(49152K), 0.2355741 secs] 59463K->47947K(63936K), 
　　　　0.2357702 secs]
0.824: [GC 0.824: [ParNew: 13184K->13184K(14784K), 0.0000497 secs]0.824: [CMS: 47947K->
　　　　47697K(49152K), 0.2373930 secs] 61131K->51960K(63936K), 0.2376031 secs]
1.062: [GC [1 CMS-initial-mark: 47697K(49152K)] 52258K(63936K), 0.0058929 secs]
1.068: [CMS-concurrent-mark-start]
1.079: [Full GC 1.079: [CMSbailing out to foreground collection
1.163: [CMS-concurrent-mark: 0.095/0.095 secs]
 (concurrent mode failure): 47697K->47697K(49152K), 0.2714722 secs] 60881K->54550K(63936K), 
　　　　[CMS Perm : 2002K->2002K(12288K)], 0.2715974 secs]
1.532: [Full GC 1.532: [CMS: 49092K->48116K(49152K), 0.2011404 secs] 63876K->57347K(63936K), 
　　　　[CMS Perm : 2002K->2002K(12288K)], 0.2012638 secs]
1.734: [GC [1 CMS-initial-mark: 48116K(49152K)] 61300K(63936K), 0.0095903 secs]
1.743: [CMS-concurrent-mark-start]
2.336: [CMS-concurrent-mark: 0.403/0.593 secs]
2.336: [CMS-concurrent-preclean-start]
2.558: [Full GC 2.558: [CMS2.608: [CMS-concurrent-preclean: 0.158/0.272 secs]
 (concurrent mode failure): 49092K->48409K(49152K), 0.2385767 secs] 63876K->58124K(63936K), 
　　　　[CMS Perm : 2002K->2002K(12288K)], 0.2386993 secs]
3.023: [Full GC 3.023: [CMS: 49091K->48614K(49152K), 0.2021654 secs] 63875K->59849K(63936K), 
　　　　[CMS Perm : 2002K->2002K(12288K)], 0.2022799 secs]
3.226: [GC [1 CMS-initial-mark: 48614K(49152K)] 61798K(63936K), 0.0110092 secs]
3.237: [CMS-concurrent-mark-start]
3.403: [Full GC 3.403: [CMS3.492: [CMS-concurrent-mark: 0.177/0.256 secs]
 (concurrent mode failure): 49090K->48753K(49152K), 0.3304641 secs] 63874K->60474K(63936K), 
　　　　[CMS Perm : 2002K->2001K(12288K)], 0.3305831 secs]
3.819: [Full GC 3.819: [CMS: 49093K->48855K(49152K), 0.2014102 secs] 63877K->61495K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2015306 secs]
4.021: [GC [1 CMS-initial-mark: 48855K(49152K)] 62039K(63936K), 0.0120337 secs]
4.033: [CMS-concurrent-mark-start]
4.123: [Full GC 4.123: [CMS4.214: [CMS-concurrent-mark: 0.143/0.181 secs]
 (concurrent mode failure): 49089K->48925K(49152K), 0.2911060 secs] 63873K->62049K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2912515 secs]
4.445: [Full GC 4.445: [CMS: 49089K->48974K(49152K), 0.2628130 secs] 63873K->62596K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2629284 secs]
4.708: [GC [1 CMS-initial-mark: 48974K(49152K)] 62596K(63936K), 0.0135246 secs]
4.722: [CMS-concurrent-mark-start]
4.930: [CMS-concurrent-mark: 0.151/0.208 secs]
4.930: [CMS-concurrent-preclean-start]
5.001: [Full GC 5.001: [CMS5.024: [CMS-concurrent-preclean: 0.082/0.094 secs]
 (concurrent mode failure): 49088K->49008K(49152K), 0.2899103 secs] 63872K->62979K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2901212 secs]
5.313: [Full GC 5.313: [CMS: 49092K->49034K(49152K), 0.2567589 secs] 63876K->63248K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2569044 secs]
5.570: [GC [1 CMS-initial-mark: 49034K(49152K)] 63248K(63936K), 0.0130282 secs]
5.583: [CMS-concurrent-mark-start]
5.607: [Full GC 5.607: [CMS5.708: [CMS-concurrent-mark: 0.117/0.125 secs]
 (concurrent mode failure): 49089K->49050K(49152K), 0.3572303 secs] 63873K->63436K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3573809 secs]
5.999: [Full GC 5.999: [CMS: 49091K->49062K(49152K), 0.2585105 secs] 63875K->63567K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2586572 secs]
6.258: [GC [1 CMS-initial-mark: 49062K(49152K)] 63568K(63936K), 0.0132701 secs]
6.271: [CMS-concurrent-mark-start]
6.282: [Full GC 6.282: [CMS6.389: [CMS-concurrent-mark: 0.113/0.118 secs]
 (concurrent mode failure): 49090K->49071K(49152K), 0.3648573 secs] 63874K->63659K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3650000 secs]
6.666: [Full GC 6.666: [CMS: 49093K->49077K(49152K), 0.2580568 secs] 63877K->63725K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2582216 secs]
6.924: [GC [1 CMS-initial-mark: 49077K(49152K)] 63725K(63936K), 0.0133958 secs]
6.938: [CMS-concurrent-mark-start]
6.943: [Full GC 6.943: [CMS7.051: [CMS-concurrent-mark: 0.111/0.113 secs]
 (concurrent mode failure): 49091K->49081K(49152K), 0.3706574 secs] 63875K->63770K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3707717 secs]
7.315: [Full GC 7.315: [CMS: 49089K->49084K(49152K), 0.2636908 secs] 63873K->63801K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2638260 secs]
7.579: [GC [1 CMS-initial-mark: 49084K(49152K)] 63801K(63936K), 0.0135478 secs]
7.593: [CMS-concurrent-mark-start]
7.645: [Full GC 7.645: [CMS7.721: [CMS-concurrent-mark: 0.120/0.128 secs]
 (concurrent mode failure): 49089K->49085K(49152K), 0.3404259 secs] 63873K->63822K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3405740 secs]
7.987: [Full GC 7.987: [CMS: 49092K->49087K(49152K), 0.2657871 secs] 63876K->63838K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2659101 secs]
8.253: [GC [1 CMS-initial-mark: 49087K(49152K)] 63839K(63936K), 0.0135816 secs]
8.267: [CMS-concurrent-mark-start]
8.277: [Full GC 8.277: [CMS8.379: [CMS-concurrent-mark: 0.111/0.112 secs]
 (concurrent mode failure): 49088K->49087K(49152K), 0.3583170 secs] 63872K->63848K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3584618 secs]
8.637: [Full GC 8.637: [CMS: 49088K->49087K(49152K), 0.2582110 secs] 63872K->63855K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2583664 secs]
8.896: [GC [1 CMS-initial-mark: 49087K(49152K)] 63856K(63936K), 0.0135012 secs]
8.909: [CMS-concurrent-mark-start]
8.916: [Full GC 8.916: [CMS9.019: [CMS-concurrent-mark: 0.110/0.110 secs]
 (concurrent mode failure): 49087K->49087K(49152K), 0.3634308 secs] 63871K->63860K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3635655 secs]
9.281: [Full GC 9.281: [CMS: 49087K->49087K(49152K), 0.2576009 secs] 63871K->63864K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2577434 secs]
9.539: [GC [1 CMS-initial-mark: 49087K(49152K)] 63864K(63936K), 0.0135534 secs]
9.552: [CMS-concurrent-mark-start]
9.552: [Full GC 9.552: [CMS9.664: [CMS-concurrent-mark: 0.112/0.112 secs]
 (concurrent mode failure): 49088K->49088K(49152K), 0.3699752 secs] 63872K->63866K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.3701180 secs]
9.930: [Full GC 9.930: [CMS: 49151K->49107K(49152K), 0.2598920 secs] 63935K->63887K(63936K), 
　　　　[CMS Perm : 2001K->2001K(12288K)], 0.2600389 secs]
10.191: [GC [1 CMS-initial-mark: 49107K(49152K)] 63887K(63936K), 0.0134958 secs]
10.204: [CMS-concurrent-mark-start]
10.316: [CMS-concurrent-mark: 0.111/0.112 secs]
10.316: [CMS-concurrent-preclean-start]
10.386: [CMS-concurrent-preclean: 0.070/0.070 secs]
10.386: [CMS-concurrent-abortable-preclean-start]
10.386: [CMS-concurrent-abortable-preclean: 0.000/0.000 secs]
10.388: [GC[YG occupancy: 14782 K (14784 K)]10.388: [Rescan (parallel) , 0.0118297 secs]10.400: 
　　　　 [weak refs processing, 0.0000075 secs] [1 CMS-remark: 49107K(49152K)] 63889K(63936K), 
　　　　 0.0120194 secs]
10.402: [CMS-concurrent-sweep-start]
10.432: [CMS-concurrent-sweep: 0.031/0.031 secs]
10.432: [CMS-concurrent-reset-start]
10.434: [CMS-concurrent-reset: 0.001/0.001 secs]
Heap
 par new generation   total 14784K, used 14782K [0x03080000, 0x04080000, 0x04080000)
  eden space 13184K, 100% used [0x03080000, 0x03d60000, 0x03d60000)
  from space 1600K,  99% used [0x03ef0000, 0x0407f8d8, 0x04080000)
  to   space 1600K,   0% used [0x03d60000, 0x03d60000, 0x03ef0000)
 concurrent mark-sweep generation total 49152K, used 49106K [0x04080000, 0x07080000, 0x07080000)
 concurrent-mark-sweep perm gen total 12288K, used 2020K [0x07080000, 0x07c80000, 0x0b080000)