Issue 2139: [gerrit gc] bitmap generation forcing jvm gc
Status:  New
Owner: ----
Reported by Ian.Kuml...@gmail.com, Sep 23, 2013
************************************************************
***** NOTE: THIS BUG TRACKER IS FOR GERRIT CODE REVIEW *****
***** DO NOT SUBMIT BUGS FOR CHROME, ANDROID, INTERNAL *****
***** ISSUES WITH YOUR COMPANY'S GERRIT SETUP, ETC.    *****
***** THOSE ISSUE BELONG IN DIFFERENT ISSUE TRACKERS!  *****
************************************************************

Affected Version: 2.7

What steps will reproduce the problem?
1. enable gc logging for the jvm
2. run gerrit gc
3. success! ;)

What is the expected output? What do you see instead?
Not running or running jvm gc less often

Please provide any additional information below.
I noticed this while gerrit generated bitmaps for a kernel git - it was the one that was "missing" a idx file in the other bugreport

Example log (from tomcat):
1320.781: [GC1320.782: [ParNew: 1380160K->153344K(1380160K), 0.2298820 secs] 5056063K->3869406K(104704256K) icms_dc=0 , 0.2301780 secs] [Times: user=3.73 sys=0.05, real=0.23 secs] 
1471.043: [GC1471.043: [ParNew: 1380029K->153344K(1380160K), 0.2679620 secs] 5096091K->4100437K(104704256K) icms_dc=0 , 0.2681890 secs] [Times: user=4.19 sys=0.10, real=0.27 secs] 
1542.515: [GC1542.516: [ParNew: 1380160K->153344K(1380160K), 0.2627880 secs] 5327253K->4306313K(104704256K) icms_dc=0 , 0.2633440 secs] [Times: user=4.21 sys=0.09, real=0.26 secs] 
1545.538: [GC1545.538: [ParNew: 1380160K->88186K(1380160K), 0.2737180 secs] 5533129K->4377169K(104704256K) icms_dc=0 , 0.2739750 secs] [Times: user=4.18 sys=0.07, real=0.28 secs] 
1550.536: [GC1550.536: [ParNew: 1315002K->153344K(1380160K), 0.2370440 secs] 5603985K->4483835K(104704256K) icms_dc=0 , 0.2373110 secs] [Times: user=3.81 sys=0.05, real=0.24 secs] 
1553.485: [GC1553.485: [ParNew: 1380160K->78514K(1380160K), 0.2314320 secs] 5710651K->4559499K(104704256K) icms_dc=0 , 0.2316610 secs] [Times: user=3.70 sys=0.07, real=0.23 secs] 
1555.728: [GC1555.728: [ParNew: 1305330K->153216K(1380160K), 0.2025610 secs] 5786315K->4651872K(104704256K) icms_dc=0 , 0.2027740 secs] [Times: user=3.28 sys=0.04, real=0.20 secs] 
1557.994: [GC1557.994: [ParNew: 1380032K->64458K(1380160K), 0.2071860 secs] 5878688K->4709353K(104704256K) icms_dc=0 , 0.2073750 secs] [Times: user=3.11 sys=0.04, real=0.21 secs] 
1560.292: [GC1560.292: [ParNew: 1291274K->53666K(1380160K), 0.1826900 secs] 5936169K->4698562K(104704256K) icms_dc=0 , 0.1828850 secs] [Times: user=3.01 sys=0.04, real=0.19 secs] 
1562.535: [GC1562.535: [ParNew: 1280482K->71476K(1380160K), 0.1950230 secs] 5925378K->4716372K(104704256K) icms_dc=0 , 0.1952950 secs] [Times: user=3.23 sys=0.02, real=0.19 secs] 
1564.786: [GC1564.786: [ParNew: 1298292K->89356K(1380160K), 0.1977960 secs] 5943188K->4734251K(104704256K) icms_dc=0 , 0.1980530 secs] [Times: user=3.22 sys=0.03, real=0.19 secs] 
1567.017: [GC1567.017: [ParNew: 1316172K->91015K(1380160K), 0.1937090 secs] 5961067K->4757855K(104704256K) icms_dc=0 , 0.1939670 secs] [Times: user=3.13 sys=0.03, real=0.19 secs] 
1569.288: [GC1569.288: [ParNew: 1317831K->93008K(1380160K), 0.1955290 secs] 5984671K->4781681K(104704256K) icms_dc=0 , 0.1957790 secs] [Times: user=3.16 sys=0.03, real=0.19 secs] 
1571.757: [GC1571.757: [ParNew: 1319696K->99250K(1380160K), 0.1888940 secs] 6008369K->4809934K(104704256K) icms_dc=0 , 0.1890910 secs] [Times: user=3.05 sys=0.03, real=0.19 secs] 
1574.012: [GC1574.012: [ParNew: 1326066K->77382K(1380160K), 0.2274480 secs] 6036750K->4832260K(104704256K) icms_dc=0 , 0.2276520 secs] [Times: user=3.60 sys=0.02, real=0.23 secs] 
1576.254: [GC1576.254: [ParNew: 1304198K->79011K(1380160K), 0.1876020 secs] 6059076K->4858452K(104704256K) icms_dc=0 , 0.1878010 secs] [Times: user=2.96 sys=0.05, real=0.19 secs] 
1578.753: [GC1578.753: [ParNew: 1305827K->94852K(1380160K), 0.1984410 secs] 6085268K->4903707K(104704256K) icms_dc=0 , 0.1986620 secs] [Times: user=3.14 sys=0.04, real=0.20 secs] 
1581.302: [GC1581.302: [ParNew: 1321668K->122270K(1380160K), 0.1966900 secs] 6130523K->4953851K(104704256K) icms_dc=0 , 0.1969330 secs] [Times: user=3.21 sys=0.04, real=0.20 secs] 
1584.107: [GC1584.107: [ParNew: 1349086K->115678K(1380160K), 0.2060810 secs] 6180667K->5018698K(104704256K) icms_dc=0 , 0.2063060 secs] [Times: user=3.24 sys=0.03, real=0.21 secs] 
1588.901: [GC1588.901: [ParNew: 1342494K->153343K(1380160K), 0.2531600 secs] 6245514K->5273219K(104704256K) icms_dc=0 , 0.2533910 secs] [Times: user=3.54 sys=0.07, real=0.25 secs] 
1591.502: [GC1591.502: [ParNew: 1380159K->71318K(1380160K), 0.2506810 secs] 6500035K->5344417K(104704256K) icms_dc=0 , 0.2509070 secs] [Times: user=4.07 sys=0.06, real=0.25 secs] 
1593.930: [GC1593.931: [ParNew: 1298134K->97634K(1380160K), 0.2262930 secs] 6571233K->5370733K(104704256K) icms_dc=0 , 0.2266180 secs] [Times: user=3.73 sys=0.02, real=0.22 secs] 
1596.442: [GC1596.443: [ParNew: 1324450K->51793K(1380160K), 0.1991380 secs] 6597549K->5395554K(104704256K) icms_dc=0 , 0.1993760 secs] [Times: user=2.97 sys=0.06, real=0.20 secs] 
1598.719: [GC1598.719: [ParNew: 1278609K->81034K(1380160K), 0.1944510 secs] 6622370K->5424795K(104704256K) icms_dc=0 , 0.1946770 secs] [Times: user=3.18 sys=0.01, real=0.20 secs] 
1601.018: [GC1601.018: [ParNew: 1307850K->86027K(1380160K), 0.1987880 secs] 6651611K->5456051K(104704256K) icms_dc=0 , 0.1990590 secs] [Times: user=3.14 sys=0.06, real=0.20 secs] 
1603.428: [GC1603.428: [ParNew: 1312843K->92052K(1380160K), 0.2015200 secs] 6682867K->5487045K(104704256K) icms_dc=0 , 0.2017600 secs] [Times: user=3.29 sys=0.03, real=0.20 secs] 
1606.626: [GC1606.626: [ParNew: 1318868K->153130K(1380160K), 0.2055180 secs] 6713861K->5589772K(104704256K) icms_dc=0 , 0.2057900 secs] [Times: user=3.21 sys=0.04, real=0.21 secs] 
1610.071: [GC1610.071: [ParNew: 1379946K->131346K(1380160K), 0.2277310 secs] 6816588K->5720469K(104704256K) icms_dc=0 , 0.2279570 secs] [Times: user=3.21 sys=0.07, real=0.23 secs] 
1614.606: [GC1614.607: [ParNew: 1358162K->153339K(1380160K), 0.2403230 secs] 6947285K->5961585K(104704256K) icms_dc=0 , 0.2405260 secs] [Times: user=3.20 sys=0.05, real=0.24 secs] 
1619.137: [GC1619.137: [ParNew: 1380155K->153298K(1380160K), 0.2441350 secs] 7188401K->6161934K(104704256K) icms_dc=0 , 0.2446700 secs] [Times: user=3.48 sys=0.08, real=0.24 secs] 
1622.711: [GC1622.711: [ParNew: 1380043K->153344K(1380160K), 0.2227990 secs] 7388679K->6325315K(104704256K) icms_dc=0 , 0.2229970 secs] [Times: user=3.15 sys=0.07, real=0.23 secs] 
1624.981: [GC1624.981: [ParNew: 1380160K->25453K(1380160K), 0.2099710 secs] 7552131K->6350044K(104704256K) icms_dc=0 , 0.2102430 secs] [Times: user=2.91 sys=0.06, real=0.21 secs] 
1627.238: [GC1627.238: [ParNew: 1252269K->50134K(1380160K), 0.1843370 secs] 7576860K->6374725K(104704256K) icms_dc=0 , 0.1845410 secs] [Times: user=3.07 sys=0.02, real=0.18 secs] 
1629.872: [GC1629.872: [ParNew: 1276950K->96228K(1380160K), 0.1918960 secs] 7601541K->6420819K(104704256K) icms_dc=0 , 0.1921910 secs] [Times: user=3.19 sys=0.02, real=0.19 secs] 
1632.735: [GC1632.735: [ParNew: 1323044K->129811K(1380160K), 0.2020110 secs] 7647635K->6479239K(104704256K) icms_dc=0 , 0.2022760 secs] [Times: user=3.26 sys=0.03, real=0.20 secs] 
1635.602: [GC1635.602: [ParNew: 1356627K->120351K(1380160K), 0.2027480 secs] 7706055K->6540298K(104704256K) icms_dc=0 , 0.2029850 secs] [Times: user=2.85 sys=0.07, real=0.20 secs] 
1638.504: [GC1638.504: [ParNew: 1347167K->135674K(1380160K), 0.2050160 secs] 7767114K->6613992K(104704256K) icms_dc=0 , 0.2052770 secs] [Times: user=3.04 sys=0.05, real=0.21 secs] 
1641.258: [GC1641.258: [ParNew: 1362490K->147282K(1380160K), 0.2012690 secs] 7840808K->6687026K(104704256K) icms_dc=0 , 0.2014690 secs] [Times: user=3.07 sys=0.05, real=0.20 secs] 
1643.656: [GC1643.657: [ParNew: 1374098K->100619K(1380160K), 0.2055260 secs] 7913842K->6714005K(104704256K) icms_dc=0 , 0.2057240 secs] [Times: user=3.18 sys=0.05, real=0.21 secs] 
1646.064: [GC1646.064: [ParNew: 1327435K->52625K(1380160K), 0.1986320 secs] 7940821K->6739013K(104704256K) icms_dc=0 , 0.1988600 secs] [Times: user=3.05 sys=0.04, real=0.20 secs] 
1648.265: [GC1648.265: [ParNew: 1279441K->71115K(1380160K), 0.1874340 secs] 7965829K->6757503K(104704256K) icms_dc=0 , 0.1876700 secs] [Times: user=3.05 sys=0.01, real=0.19 secs] 
1650.455: [GC1650.455: [ParNew: 1297931K->90555K(1380160K), 0.1888580 secs] 7984319K->6776943K(104704256K) icms_dc=0 , 0.1890620 secs] [Times: user=3.10 sys=0.02, real=0.19 secs] 
1652.617: [GC1652.617: [ParNew: 1317371K->82588K(1380160K), 0.1921130 secs] 8003759K->6795744K(104704256K) icms_dc=0 , 0.1923570 secs] [Times: user=3.07 sys=0.02, real=0.20 secs] 
1655.084: [GC1655.084: [ParNew: 1309404K->88676K(1380160K), 0.1929900 secs] 8022560K->6827088K(104704256K) icms_dc=0 , 0.1932480 secs] [Times: user=3.13 sys=0.04, real=0.19 secs] 
1657.576: [GC1657.576: [ParNew: 1315492K->102707K(1380160K), 0.2038790 secs] 8053904K->6859860K(104704256K) icms_dc=0 , 0.2041080 secs] [Times: user=3.31 sys=0.03, real=0.21 secs] 
1660.084: [GC1660.085: [ParNew: 1329523K->100159K(1380160K), 0.2056770 secs] 8086676K->6895000K(104704256K) icms_dc=0 , 0.2058870 secs] [Times: user=3.30 sys=0.04, real=0.21 secs] 
1662.587: [GC1662.587: [ParNew: 1326975K->103864K(1380160K), 0.1993510 secs] 8121816K->6930356K(104704256K) icms_dc=0 , 0.1998130 secs] [Times: user=3.22 sys=0.02, real=0.20 secs] 
1665.063: [GC1665.063: [ParNew: 1330680K->107803K(1380160K), 0.1943070 secs] 8157172K->6967114K(104704256K) icms_dc=0 , 0.1945660 secs] [Times: user=3.05 sys=0.06, real=0.19 secs] 
1667.523: [GC1667.523: [ParNew: 1334619K->109823K(1380160K), 0.1978450 secs] 8193930K->7004352K(104704256K) icms_dc=0 , 0.1980760 secs] [Times: user=3.13 sys=0.03, real=0.20 secs] 
1670.004: [GC1670.004: [ParNew: 1336639K->110701K(1380160K), 0.1915270 secs] 8231168K->7040369K(104704256K) icms_dc=0 , 0.1917690 secs] [Times: user=2.98 sys=0.05, real=0.19 secs] 
1672.457: [GC1672.457: [ParNew: 1337517K->110213K(1380160K), 0.2036340 secs] 8267185K->7076594K(104704256K) icms_dc=0 , 0.2038960 secs] [Times: user=3.24 sys=0.03, real=0.21 secs] 
1674.938: [GC1674.938: [ParNew: 1337029K->114558K(1380160K), 0.1944890 secs] 8303410K->7117919K(104704256K) icms_dc=0 , 0.1947260 secs] [Times: user=3.08 sys=0.05, real=0.20 secs] 
1677.758: [GC1677.758: [ParNew: 1341374K->114851K(1380160K), 0.2049460 secs] 8344735K->7190725K(104704256K) icms_dc=0 , 0.2051860 secs] [Times: user=3.02 sys=0.04, real=0.21 secs] 
1681.076: [GC1681.077: [ParNew: 1341667K->153344K(1380160K), 0.2085440 secs] 8417541K->7313681K(104704256K) icms_dc=0 , 0.2088040 secs] [Times: user=3.07 sys=0.07, real=0.21 secs] 
1683.707: [GC1683.707: [ParNew: 1380160K->51485K(1380160K), 0.2137790 secs] 8540497K->7364497K(104704256K) icms_dc=0 , 0.2140030 secs] [Times: user=2.92 sys=0.05, real=0.21 secs] 
... and so on...