grpc-go_server_gc-trace_with_reduce_allocs

2017/01/03 21:36:45 benchmark server listening at [::]:42983
gc 1 @150.131s 0%: 0.44+0.68+0.21 ms clock, 11+0.008/3.3/3.6+5.2 ms cpu, 4->4->1 MB, 5 MB goal, 32 P
gc 2 @150.153s 0%: 0.21+0.86+0.44 ms clock, 2.4+0.35/3.3/0+4.8 ms cpu, 4->4->1 MB, 5 MB goal, 32 P
gc 3 @150.174s 0%: 0.18+0.70+0.24 ms clock, 5.7+0.89/3.5/0.15+7.6 ms cpu, 4->4->1 MB, 5 MB goal, 32 P
gc 4 @150.177s 0%: 0.026+0.83+0.28 ms clock, 0.82+0.51/4.0/1.1+8.7 ms cpu, 4->4->3 MB, 5 MB goal, 32 P
gc 5 @150.178s 0%: 0.14+1.1+0.21 ms clock, 1.6+1.4/4.1/0.11+2.3 ms cpu, 5->6->4 MB, 6 MB goal, 32 P
gc 6 @150.181s 0%: 0.19+1.0+0.30 ms clock, 4.9+1.9/4.0/0.33+7.5 ms cpu, 7->7->5 MB, 9 MB goal, 32 P
gc 7 @150.220s 0%: 0.50+1.6+0.47 ms clock, 2.5+8.7/10/0+2.3 ms cpu, 10->10->7 MB, 11 MB goal, 32 P
gc 8 @150.295s 0%: 0.40+2.4+0.44 ms clock, 2.4+36/17/0+2.6 ms cpu, 13->13->9 MB, 14 MB goal, 32 P
gc 9 @150.393s 0%: 1.9+3.2+0.49 ms clock, 32+50/23/0+8.4 ms cpu, 17->17->11 MB, 18 MB goal, 32 P
gc 10 @150.508s 0%: 0.38+4.4+0.47 ms clock, 6.8+84/32/0+8.4 ms cpu, 21->21->13 MB, 22 MB goal, 32 P
gc 11 @150.636s 0%: 0.64+6.0+0.53 ms clock, 11+104/44/0+9.7 ms cpu, 26->27->17 MB, 27 MB goal, 32 P
gc 12 @150.830s 0%: 1.0+9.4+0.51 ms clock, 19+120/55/0+9.1 ms cpu, 33->33->20 MB, 34 MB goal, 32 P
gc 13 @151.077s 0%: 0.42+8.7+0.49 ms clock, 7.5+140/62/0+8.8 ms cpu, 39->39->22 MB, 40 MB goal, 32 P
gc 14 @151.404s 0%: 0.71+8.3+0.51 ms clock, 16+148/59/0+11 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 15 @151.717s 0%: 0.85+7.6+0.46 ms clock, 20+151/56/0+11 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 16 @152.042s 0%: 0.59+8.1+0.47 ms clock, 14+142/60/0+11 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 17 @152.363s 0%: 0.97+8.2+0.46 ms clock, 24+153/57/0+11 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 18 @152.698s 0%: 1.2+8.0+0.52 ms clock, 31+146/59/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 19 @153.035s 0%: 0.56+7.9+0.45 ms clock, 14+152/58/0+11 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 20 @153.366s 0%: 0.77+7.8+0.36 ms clock, 20+154/55/0+9.5 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 21 @153.711s 0%: 0.89+8.1+0.39 ms clock, 23+145/58/0+10 ms cpu, 43->44->22 MB, 44 MB goal, 32 P
gc 22 @154.045s 0%: 0.76+8.2+0.53 ms clock, 19+154/57/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 23 @154.392s 0%: 8.7+0.95+0.46 ms clock, 209+125/64/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 24 @154.742s 0%: 0.68+8.3+0.66 ms clock, 17+150/63/0+17 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 25 @155.072s 0%: 1.2+9.1+0.55 ms clock, 31+161/59/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 26 @155.399s 0%: 8.8+1.0+0.54 ms clock, 229+107/66/0+14 ms cpu, 43->43->22 MB, 45 MB goal, 32 P
gc 27 @155.733s 0%: 0.52+8.5+0.48 ms clock, 13+156/59/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 28 @156.074s 0%: 0.47+8.0+0.47 ms clock, 12+146/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
2017/01/03 21:36:51 server mark received:
2017/01/03 21:36:51  - &{reset:true }
gc 29 @156.389s 0%: 0.48+7.9+0.52 ms clock, 12+158/55/0+13 ms cpu, 43->43->22 MB, 45 MB goal, 32 P
gc 30 @156.767s 0%: 0.46+7.9+0.49 ms clock, 11+134/60/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 31 @157.141s 0%: 0.47+9.6+0.40 ms clock, 12+146/61/0+10 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 32 @157.514s 0%: 0.81+9.3+0.42 ms clock, 21+142/60/0+10 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 33 @157.900s 0%: 0.44+8.8+0.46 ms clock, 12+138/64/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 34 @158.235s 0%: 0.79+8.6+0.45 ms clock, 21+137/62/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 35 @158.564s 0%: 0.50+9.0+0.69 ms clock, 13+158/61/0+18 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 36 @158.892s 0%: 0.36+7.9+0.50 ms clock, 9.7+141/59/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 37 @159.227s 0%: 1.0+8.3+0.47 ms clock, 29+160/59/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 38 @159.564s 0%: 1.2+7.5+0.47 ms clock, 32+151/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 39 @159.888s 0%: 0.45+7.7+0.46 ms clock, 12+141/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 40 @160.223s 0%: 0.54+8.2+0.45 ms clock, 14+150/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 41 @160.556s 0%: 0.58+9.4+0.42 ms clock, 15+149/62/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 42 @160.883s 0%: 0.78+7.9+0.38 ms clock, 21+152/56/0+10 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 43 @161.224s 0%: 0.60+8.4+0.51 ms clock, 17+148/57/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 44 @161.554s 0%: 0.49+9.1+0.43 ms clock, 13+157/60/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 45 @161.874s 0%: 0.55+8.4+0.42 ms clock, 14+155/56/0+11 ms cpu, 43->43->22 MB, 45 MB goal, 32 P
gc 46 @162.204s 0%: 0.50+8.2+0.54 ms clock, 14+152/56/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 47 @162.534s 0%: 0.45+8.4+0.44 ms clock, 11+136/64/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 48 @162.865s 0%: 0.64+7.8+0.44 ms clock, 18+152/59/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 49 @163.197s 0%: 0.57+8.3+0.36 ms clock, 16+151/57/0+10 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 50 @163.540s 0%: 0.82+9.3+0.43 ms clock, 22+151/59/0+11 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 51 @163.859s 0%: 0.62+8.5+0.55 ms clock, 17+161/57/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 52 @164.182s 0%: 0.58+8.0+0.47 ms clock, 16+154/56/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 53 @164.509s 0%: 0.44+9.7+0.54 ms clock, 12+152/63/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 54 @164.839s 0%: 0.45+8.5+0.49 ms clock, 12+148/58/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 55 @165.169s 0%: 1.1+7.8+0.39 ms clock, 33+152/56/0+11 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 56 @165.497s 0%: 1.3+8.7+0.44 ms clock, 38+159/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 57 @165.835s 0%: 0.59+8.1+0.40 ms clock, 16+150/57/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 58 @166.163s 0%: 0.50+8.2+0.43 ms clock, 13+141/60/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 59 @166.488s 0%: 0.67+7.5+0.50 ms clock, 18+143/57/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 60 @166.828s 0%: 0.95+8.5+0.42 ms clock, 26+143/60/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 61 @167.148s 0%: 0.97+7.8+0.48 ms clock, 27+152/56/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 62 @167.467s 0%: 0.76+9.0+0.46 ms clock, 21+146/62/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 63 @167.816s 0%: 1.1+7.8+0.54 ms clock, 33+147/58/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 64 @168.143s 0%: 0.58+8.6+0.45 ms clock, 16+157/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 65 @168.461s 0%: 0.58+7.9+0.47 ms clock, 16+145/59/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 66 @168.801s 0%: 0.44+7.8+0.45 ms clock, 12+155/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 67 @169.122s 0%: 0.38+8.0+0.42 ms clock, 10+155/57/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 68 @169.442s 0%: 0.40+9.5+0.42 ms clock, 11+136/58/0+11 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 69 @169.779s 0%: 0.57+7.9+0.45 ms clock, 16+154/58/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 70 @170.115s 0%: 0.62+8.2+0.44 ms clock, 17+157/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 71 @170.450s 0%: 1.1+10+0.51 ms clock, 33+156/61/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 72 @170.793s 0%: 0.46+8.0+0.51 ms clock, 12+159/58/0+14 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 73 @171.126s 0%: 0.62+8.6+1.7 ms clock, 17+154/62/0+49 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 74 @171.463s 0%: 0.51+7.7+0.46 ms clock, 14+148/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 75 @171.796s 0%: 0.66+7.9+0.50 ms clock, 18+156/57/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 76 @172.115s 0%: 0.76+8.8+0.50 ms clock, 21+163/55/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 77 @172.435s 0%: 0.67+8.4+0.53 ms clock, 18+163/56/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 78 @172.762s 0%: 0.48+8.5+0.55 ms clock, 13+162/57/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 79 @173.091s 0%: 0.69+8.3+0.49 ms clock, 19+152/60/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 80 @173.428s 0%: 0.57+7.8+0.44 ms clock, 16+156/59/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 81 @173.774s 0%: 0.67+8.3+0.52 ms clock, 18+155/59/0+14 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 82 @174.114s 0%: 0.82+7.9+0.43 ms clock, 23+150/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 83 @174.451s 0%: 0.40+7.7+0.54 ms clock, 11+155/59/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 84 @174.783s 0%: 0.64+8.3+0.38 ms clock, 17+147/61/0+10 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 85 @175.110s 0%: 0.56+7.9+0.37 ms clock, 15+158/58/0+10 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 86 @175.437s 0%: 0.46+8.5+0.45 ms clock, 13+149/58/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 87 @175.780s 0%: 0.50+8.3+0.41 ms clock, 14+158/59/0+11 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 88 @176.111s 0%: 1.1+8.8+0.55 ms clock, 31+164/58/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 89 @176.444s 0%: 0.55+8.4+0.43 ms clock, 15+144/59/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 90 @176.791s 0%: 0.53+8.3+0.50 ms clock, 14+148/59/0+14 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 91 @177.121s 0%: 0.56+8.3+0.51 ms clock, 15+156/59/0+14 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 92 @177.458s 0%: 0.53+8.7+0.63 ms clock, 14+155/59/0+16 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 93 @177.795s 0%: 0.52+7.7+0.44 ms clock, 14+147/56/0+12 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 94 @178.118s 0%: 0.65+8.4+0.43 ms clock, 18+163/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 95 @178.433s 0%: 0.65+8.3+0.48 ms clock, 18+155/59/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 96 @178.769s 0%: 0.93+8.5+0.47 ms clock, 26+154/60/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 97 @179.100s 0%: 0.44+8.0+0.48 ms clock, 12+153/57/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 98 @179.427s 0%: 0.43+8.3+0.46 ms clock, 12+161/57/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 99 @179.765s 0%: 0.51+7.9+0.45 ms clock, 14+141/58/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 100 @180.089s 0%: 0.51+8.0+0.44 ms clock, 14+158/56/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 101 @180.413s 0%: 0.67+8.3+0.48 ms clock, 19+146/57/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 102 @180.751s 0%: 0.48+8.1+0.53 ms clock, 14+151/57/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 103 @181.069s 0%: 0.96+8.2+0.57 ms clock, 27+146/57/0+16 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 104 @181.382s 0%: 0.49+7.4+0.66 ms clock, 14+146/57/0+19 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 105 @181.714s 0%: 0.42+9.2+0.55 ms clock, 12+155/57/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 106 @182.034s 0%: 0.77+8.2+0.47 ms clock, 22+155/58/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 107 @182.356s 0%: 0.55+8.0+0.46 ms clock, 16+154/57/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 108 @182.693s 0%: 0.72+8.5+0.52 ms clock, 21+159/58/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 109 @183.027s 0%: 0.54+8.3+0.46 ms clock, 15+157/58/0+13 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 110 @183.353s 0%: 0.55+7.7+0.43 ms clock, 15+153/57/0+12 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 111 @183.692s 0%: 0.61+8.0+0.46 ms clock, 17+143/60/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 112 @184.020s 0%: 0.47+7.8+0.59 ms clock, 13+152/56/0+17 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 113 @184.348s 0%: 0.56+8.0+0.52 ms clock, 16+155/58/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 114 @184.692s 0%: 0.46+8.0+0.50 ms clock, 13+147/60/0+14 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 115 @185.017s 0%: 0.44+9.5+0.58 ms clock, 12+154/60/0+17 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 116 @185.339s 0%: 0.47+8.2+0.54 ms clock, 13+162/57/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 117 @185.675s 0%: 0.54+8.5+0.53 ms clock, 15+153/58/0+15 ms cpu, 43->44->22 MB, 45 MB goal, 32 P
gc 118 @186.004s 0%: 0.49+8.1+0.53 ms clock, 14+149/57/0+15 ms cpu, 44->44->22 MB, 45 MB goal, 32 P
gc 119 @186.326s 0%: 0.58+7.8+0.47 ms clock, 16+149/56/0+13 ms cpu, 43->44->22 MB, 45 MB goal, 32 P