Skip to content

Instantly share code, notes, and snippets.

@eonnen
Created October 26, 2012 18:29
Show Gist options
  • Star 1 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save eonnen/3960535 to your computer and use it in GitHub Desktop.
Save eonnen/3960535 to your computer and use it in GitHub Desktop.
53957.475: [CMS-concurrent-reset-start]
53957.495: [CMS-concurrent-reset: 0.019/0.019 secs] [Times: user=0.02 sys=0.00, real=0.02 secs]
53958.902: [GC [1 CMS-initial-mark: 5818896K(7898752K)] 5847381K(8339648K), 0.1594680 secs] [Times: user=0.16 sys=0.01, real=0.16 secs]
53959.069: [CMS-concurrent-mark-start]
53965.150: [CMS-concurrent-mark: 5.791/6.081 secs] [Times: user=34.36 sys=0.37, real=6.09 secs]
53965.153: [CMS-concurrent-preclean-start]
53965.184: [CMS-concurrent-preclean: 0.031/0.031 secs] [Times: user=0.04 sys=0.00, real=0.03 secs]
53965.186: [CMS-concurrent-abortable-preclean-start]
CMS: abort preclean due to time 53970.208: [CMS-concurrent-abortable-preclean: 2.954/5.022 secs] [Times: user=3.39 sys=0.04, real=5.22 secs]
53970.281: [GC[YG occupancy: 63461 K (440896 K)]53970.284: [Rescan (parallel) , 0.0671630 secs]53970.351: [weak refs processing, 0.0002130 secs] [1 CMS-remark: 5818896K(7898752K)] 5882358K(8339648K), 0.0697680 secs] [Times: user=1.06 sys=0.02, real=0.07 secs]
53970.358: [CMS-concurrent-sweep-start]
53976.716: [GC 53976.722: [ParNew: 400661K->10452K(440896K), 0.0905470 secs] 6209157K->5823545K(8339648K), 0.0997720 secs] [Times: user=0.95 sys=0.03, real=0.10 secs]
53977.994: [CMS-concurrent-sweep: 7.205/7.637 secs] [Times: user=12.06 sys=2.84, real=7.64 secs]
53977.997: [CMS-concurrent-reset-start]
53978.016: [CMS-concurrent-reset: 0.020/0.020 secs] [Times: user=0.03 sys=0.01, real=0.02 secs]
53980.143: [GC [1 CMS-initial-mark: 5807447K(7898752K)] 6140155K(8339648K), 0.2839170 secs] [Times: user=0.28 sys=0.00, real=0.28 secs]
53980.437: [CMS-concurrent-mark-start]
53986.397: [GC 53986.402: [ParNew: 402388K->12250K(440896K), 0.0899740 secs] 6209835K->5826280K(8339648K), 0.0983240 secs] [Times: user=0.94 sys=0.02, real=0.10 secs]
53986.589: [CMS-concurrent-mark: 5.808/6.152 secs] [Times: user=36.05 sys=0.60, real=6.15 secs]
53986.591: [CMS-concurrent-preclean-start]
53986.933: [CMS-concurrent-preclean: 0.320/0.342 secs] [Times: user=0.39 sys=0.01, real=0.35 secs]
53986.935: [CMS-concurrent-abortable-preclean-start]
53990.591: [CMS-concurrent-abortable-preclean: 3.573/3.656 secs] [Times: user=4.99 sys=0.95, real=3.66 secs]
53990.674: [GC[YG occupancy: 217155 K (440896 K)]53990.676: [Rescan (parallel) , 0.0638120 secs]53990.740: [weak refs processing, 0.0000500 secs] [1 CMS-remark: 5814030K(7898752K)] 6031185K(8339648K), 0.0663750 secs] [Times: user=1.07 sys=0.01, real=0.07 secs]
53990.747: [CMS-concurrent-sweep-start]
53997.819: [CMS-concurrent-sweep: 6.716/7.072 secs] [Times: user=7.83 sys=0.32, real=7.08 secs]
53997.822: [CMS-concurrent-reset-start]
53997.841: [CMS-concurrent-reset: 0.019/0.019 secs] [Times: user=0.02 sys=0.00, real=0.02 secs]
53998.709: [GC 53998.714: [ParNew: 404186K->8945K(440896K), 0.0969980 secs] 6213880K->5826943K(8339648K), 0.1051800 secs] [Times: user=0.95 sys=0.03, real=0.11 secs]
53998.888: [GC [1 CMS-initial-mark: 5817997K(7898752K)] 5827549K(8339648K), 0.1481990 secs] [Times: user=0.15 sys=0.00, real=0.15 secs]
53999.043: [CMS-concurrent-mark-start]
54000.711: [GC 54000.716: [ParNew: 400879K->8651K(440896K), 0.0910260 secs] 6218877K->5831686K(8339648K), 0.0988320 secs] [Times: user=0.96 sys=0.03, real=0.10 secs]
54004.570: [GC 54004.574: [ParNew: 400560K->8875K(440896K), 0.0989110 secs] 6223595K->5837133K(8339648K), 0.1067140 secs] [Times: user=1.00 sys=0.04, real=0.10 secs]
54005.570: [CMS-concurrent-mark: 6.030/6.527 secs] [Times: user=41.86 sys=2.00, real=6.53 secs]
54005.572: [CMS-concurrent-preclean-start]
54006.396: [CMS-concurrent-preclean: 0.773/0.824 secs] [Times: user=1.52 sys=0.29, real=0.82 secs]
54006.398: [CMS-concurrent-abortable-preclean-start]
54006.650: [GC 54006.654: [ParNew: 400816K->12069K(440896K), 0.0945380 secs] 6229074K->5845916K(8339648K), 0.1023590 secs] [Times: user=1.00 sys=0.03, real=0.11 secs]
54006.825: [GC 54006.830: [ParNew: 12268K->2376K(440896K), 0.0847780 secs] 5846115K->5843206K(8339648K), 0.0924630 secs] [Times: user=0.94 sys=0.02, real=0.09 secs]
54008.704: [CMS-concurrent-abortable-preclean: 1.090/2.306 secs] [Times: user=4.74 sys=0.52, real=2.31 secs]
54008.794: [GC[YG occupancy: 207637 K (440896 K)]54008.796: [Rescan (parallel) , 0.0622960 secs]54008.859: [weak refs processing, 0.0000420 secs] [1 CMS-remark: 5840830K(7898752K)] 6048467K(8339648K), 0.0647240 secs] [Times: user=0.96 sys=0.03, real=0.07 secs]
54008.866: [CMS-concurrent-sweep-start]
54010.129: [GC 54010.134: [ParNew: 394388K->7268K(440896K), 0.0834950 secs] 6234246K->5847132K(8339648K), 0.0929500 secs] [Times: user=1.02 sys=0.02, real=0.09 secs]
54011.652: [GC 54011.657: [ParNew: 399168K->7862K(440896K), 0.0988950 secs] 6238441K->5852945K(8339648K), 0.1066800 secs] [Times: user=0.94 sys=0.05, real=0.11 secs]
54014.021: [GC 54014.025: [ParNew: 399873K->11778K(440896K), 0.0943940 secs] 6244357K->5860871K(8339648K), 0.1022520 secs] [Times: user=0.95 sys=0.03, real=0.10 secs]
54016.139: [GC 54016.144: [ParNew: 403677K->13303K(440896K), 0.0930470 secs] 6251783K->5868438K(8339648K), 0.1011610 secs] [Times: user=0.94 sys=0.02, real=0.10 secs]
54016.701: [CMS-concurrent-sweep: 6.844/7.835 secs] [Times: user=17.72 sys=2.44, real=7.84 secs]
54016.704: [CMS-concurrent-reset-start]
54016.723: [CMS-concurrent-reset: 0.019/0.019 secs] [Times: user=0.02 sys=0.00, real=0.02 secs]
54017.731: [GC 54017.736: [ParNew: 405239K->8621K(440896K), 0.0963250 secs] 6259018K->5868773K(8339648K), 0.1041400 secs] [Times: user=0.99 sys=0.03, real=0.10 secs]
54017.907: [GC [1 CMS-initial-mark: 5860152K(7898752K)] 5868825K(8339648K), 0.1498060 secs] [Times: user=0.15 sys=0.00, real=0.16 secs]
54018.064: [CMS-concurrent-mark-start]
54019.795: [GC 54019.799: [ParNew: 401182K->13333K(440896K), 0.0898580 secs] 6261335K->5878602K(8339648K), 0.0976600 secs] [Times: user=0.96 sys=0.05, real=0.10 secs]
54019.966: [GC 54019.970: [ParNew: 13762K->6142K(440896K), 0.0893410 secs] 5879030K->5880669K(8339648K), 0.0969890 secs] [Times: user=0.92 sys=0.03, real=0.10 secs]
54021.714: [GC 54021.719: [ParNew: 398078K->8824K(440896K), 0.0818940 secs] 6272605K->5883368K(8339648K), 0.0900380 secs] [Times: user=0.99 sys=0.02, real=0.09 secs]
54024.663: [GC 54024.667: [ParNew: 400911K->14619K(440896K), 0.0980760 secs] 6275454K->5895868K(8339648K), 0.1060270 secs] [Times: user=0.97 sys=0.03, real=0.11 secs]
54025.217: [CMS-concurrent-mark: 6.033/7.153 secs] [Times: user=46.57 sys=3.01, real=7.16 secs]
54025.220: [CMS-concurrent-preclean-start]
54026.496: [CMS-concurrent-preclean: 1.201/1.276 secs] [Times: user=2.19 sys=0.35, real=1.27 secs]
54026.498: [CMS-concurrent-abortable-preclean-start]
54026.979: [GC 54026.984: [ParNew: 406996K->10355K(440896K), 0.0981870 secs] 6288245K->5898729K(8339648K), 0.1060200 secs] [Times: user=1.00 sys=0.02, real=0.10 secs]
54027.158: [GC 54027.163: [ParNew: 10418K->2908K(440896K), 0.0909970 secs] 5898791K->5898763K(8339648K), 0.0987420 secs] [Times: user=0.93 sys=0.02, real=0.10 secs]
54028.382: [CMS-concurrent-abortable-preclean: 1.207/1.884 secs] [Times: user=4.75 sys=0.49, real=1.88 secs]
54028.453: [GC[YG occupancy: 202310 K (440896 K)]54028.455: [Rescan (parallel) , 0.0591870 secs]54028.514: [weak refs processing, 0.0000610 secs] [1 CMS-remark: 5895854K(7898752K)] 6098165K(8339648K), 0.0616100 secs] [Times: user=1.00 sys=0.01, real=0.06 secs]
54028.521: [CMS-concurrent-sweep-start]
54028.993: [GC 54028.998: [ParNew: 394844K->12589K(440896K), 0.0885590 secs] 6289650K->5907397K(8339648K), 0.0967720 secs] [Times: user=0.96 sys=0.04, real=0.10 secs]
54030.104: [GC 54030.109: [ParNew: 404632K->10257K(440896K), 0.0955760 secs] 6297239K->5909144K(8339648K), 0.1035400 secs] [Times: user=1.03 sys=0.04, real=0.11 secs]
54030.282: [GC 54030.287: [ParNew: 10611K->5191K(440896K), 0.0904030 secs] 5909498K->5912308K(8339648K), 0.0981390 secs] [Times: user=0.97 sys=0.03, real=0.10 secs]
54030.984: [GC 54031.124: [ParNew: 397127K->12288K(440896K), 0.0870500 secs] 6302584K->5917826K(8339648K), 0.0961580 secs] [Times: user=1.05 sys=0.04, real=0.24 secs]
54032.062: [GC 54032.067: [ParNew: 406762K->15927K(440896K), 0.0915940 secs] 6310647K->5925983K(8339648K), 0.1001750 secs] [Times: user=0.95 sys=0.04, real=0.10 secs]
54032.833: [GC 54032.838: [ParNew: 410005K->18736K(440896K), 0.0972710 secs] 6319057K->5933732K(8339648K), 0.1059940 secs] [Times: user=0.99 sys=0.03, real=0.11 secs]
54033.010: [GC 54033.015: [ParNew: 18832K->7646K(440896K), 0.0998880 secs] 5933827K->5934753K(8339648K), 0.1075880 secs] [Times: user=0.91 sys=0.04, real=0.11 secs]
54033.687: [GC 54033.692: [ParNew: 399554K->10954K(440896K), 0.0801380 secs] 6323913K->5935317K(8339648K), 0.0882730 secs] [Times: user=0.94 sys=0.03, real=0.09 secs]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment