主頁 > 後端開發 > 使用awk分析JVM GC日志

使用awk分析JVM GC日志

2020-09-24 01:34:42 後端開發

使用分析GC日志

gc日志是一種結構化的日志 ,就是一種固定的格式,不同的gc,不同 的jdk版本生產的日志格式資料是不一樣的,但是只要是同一個gc引數和同一個版本,gc日志是固定的,

所以以下的分析方法也適用于不同的gc日志格式資料,

awk背景知識

awk是一種文本檔案分析工具,結合正則運算式、內置函式、分隔符、甚至內置的條件回圈等語法,可以分析算雜的文本資料,遠遠超出日常作為列分析工具的范籌,

這里簡單介紹一些簡單的awk使用方法,以便進行gc日志的分析甚至資料統計等,
演示的文本檔案為gc.log,內容如下:

2020-07-28T01:23:35.309+0800: [GC (Allocation Failure) [PSYoungGen: 65536K->1480K(76288K)] 65536K->1488K(251392K), 0.0048826 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:23:35.344+0800: [GC (Allocation Failure) [PSYoungGen: 67016K->1448K(141824K)] 67024K->1464K(316928K), 0.0038402 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:23:35.441+0800: [GC (Allocation Failure) [PSYoungGen: 132520K->1480K(141824K)] 132536K->1496K(316928K), 0.0046722 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:23:35.482+0800: [GC (Allocation Failure) [PSYoungGen: 132552K->1416K(272896K)] 132568K->1432K(448000K), 0.0037451 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
  1. 基本用法
$ awk '{print $1}' gc.log

2020-07-28T01:23:35.309+0800:
2020-07-28T01:23:35.344+0800:
2020-07-28T01:23:35.441+0800:
2020-07-28T01:23:35.482+0800:

這里是常用的用法,就是對gc.log這個檔案進行過濾:

其中,每一行只顯示第一列,用"print $1",另外$0表示第一行的全部資料,$2、$3表示第2列,第3列資料

每一列使用空格作為分隔符,

  1. 分隔符
$ awk -F ":" '{print $1}' gc.log

2020-07-28T01
2020-07-28T01
2020-07-28T01
2020-07-28T01

這里與上面比較只是指定了分隔符,這里為":",

  1. 多顯示
$ awk '{print $1","$2}' gc.log

2020-07-28T01:23:35.309+0800:,[GC
2020-07-28T01:23:35.344+0800:,[GC
2020-07-28T01:23:35.441+0800:,[GC
2020-07-28T01:23:35.482+0800:,[GC

顯示第1列與第2列,同時用“,”來隔開,如果沒有“,”時第一列與第二列之前相當于合并在一起,

  1. 條件陳述句
$ awk '{if(match($1, "482")){print $0}}' gc.log

2020-07-28T01:23:35.482+0800: [GC (Allocation Failure) [PSYoungGen: 132552K->1416K(272896K)] 132568K->1432K(448000K), 0.0037451 secs] [Times: user=0.00 sys=0.00, real=0.00 secs]

這里表示只顯示第1列中包含482字串的行,
這里可以使用類似c語言的if陳述句,match函式是內置函式,match($1,"482")表示第一列包含age

  1. 變數使用
$ awk 'BEGIN{count=0}{count++;}END{print "count="count}' gc.log

count=4
  1. 回圈陳述句
$ awk '{
  for(i=1;i<NF;i++)  {
      printf $i"@@"
  }
  print ""
}' gc.log

2020-07-28T01:23:35.309+0800:@@[GC@@(Allocation@@Failure)@@[PSYoungGen:@@65536K->1480K(76288K)]@@65536K->1488K(251392K),@@0.0048826@@secs]@@[Times:@@user=0.00@@sys=0.00,@@real=0.00@@
2020-07-28T01:23:35.344+0800:@@[GC@@(Allocation@@Failure)@@[PSYoungGen:@@67016K->1448K(141824K)]@@67024K->1464K(316928K),@@0.0038402@@secs]@@[Times:@@user=0.00@@sys=0.00,@@real=0.00@@
2020-07-28T01:23:35.441+0800:@@[GC@@(Allocation@@Failure)@@[PSYoungGen:@@132520K->1480K(141824K)]@@132536K->1496K(316928K),@@0.0046722@@secs]@@[Times:@@user=0.13@@sys=0.00,@@real=0.00@@
2020-07-28T01:23:35.482+0800:@@[GC@@(Allocation@@Failure)@@[PSYoungGen:@@132552K->1416K(272896K)]@@132568K->1432K(448000K),@@0.0037451@@secs]@@[Times:@@user=0.00@@sys=0.00,@@real=0.00@@

print有換行,printf不換行 , NF表示當前行的列數

分析GC日志

日志資料如下,保存為gc.log

2020-07-28T01:45:24.619+0800: 0.727: [GC (Allocation Failure) [PSYoungGen: 65536K->1496K(76288K)] 65536K->1504K(251392K), 0.0042882 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:24.653+0800: 0.763: [GC (Allocation Failure) [PSYoungGen: 67032K->1448K(76288K)] 67040K->1456K(251392K), 0.0042457 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:24.679+0800: 0.786: [GC (Allocation Failure) [PSYoungGen: 66984K->1432K(76288K)] 66992K->1440K(251392K), 0.0033243 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:24.701+0800: 0.808: [GC (Allocation Failure) [PSYoungGen: 66968K->1384K(141824K)] 66976K->1392K(316928K), 0.0035944 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:24.810+0800: 0.918: [GC (Allocation Failure) [PSYoungGen: 132456K->1400K(141824K)] 132464K->1408K(316928K), 0.0043860 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:24.852+0800: 0.959: [GC (Allocation Failure) [PSYoungGen: 132472K->1384K(263680K)] 132480K->1392K(438784K), 0.0035378 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:25.054+0800: 1.162: [GC (Allocation Failure) [PSYoungGen: 263528K->0K(263680K)] 263536K->1340K(438784K), 0.0055308 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:25.135+0800: 1.242: [GC (Allocation Failure) [PSYoungGen: 262144K->0K(526336K)] 263484K->1340K(701440K), 0.0009377 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:25.515+0800: 1.623: [GC (Allocation Failure) [PSYoungGen: 524288K->0K(526336K)] 525628K->1340K(701440K), 0.0030435 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:25.651+0800: 1.758: [GC (Allocation Failure) [PSYoungGen: 524288K->800K(840704K)] 525628K->2140K(1015808K), 0.0042685 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:26.178+0800: 2.285: [GC (Allocation Failure) [PSYoungGen: 839968K->0K(841216K)] 841308K->2004K(1016320K), 0.0072233 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:26.419+0800: 2.526: [GC (Allocation Failure) [PSYoungGen: 839168K->0K(1345536K)] 841172K->2004K(1520640K), 0.0008589 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:27.240+0800: 3.348: [GC (Allocation Failure) [PSYoungGen: 1342976K->768K(1345536K)] 1344980K->2772K(1520640K), 0.0044832 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:27.589+0800: 3.696: [GC (Allocation Failure) [PSYoungGen: 1343744K->608K(1385472K)] 1345748K->2836K(1560576K), 0.0042988 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:27.995+0800: 4.102: [GC (Allocation Failure) [PSYoungGen: 1384032K->288K(1385472K)] 1386260K->3044K(1560576K), 0.0041383 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:28.365+0800: 4.472: [GC (Allocation Failure) [PSYoungGen: 1383712K->0K(1386496K)] 1386468K->2932K(1561600K), 0.0024757 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:28.729+0800: 4.837: [GC (Allocation Failure) [PSYoungGen: 1384448K->768K(1386496K)] 1387380K->3700K(1561600K), 0.0046646 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:29.101+0800: 5.208: [GC (Allocation Failure) [PSYoungGen: 1385216K->0K(1386496K)] 1388148K->3604K(1561600K), 0.0047139 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:29.472+0800: 5.580: [GC (Allocation Failure) [PSYoungGen: 1384448K->0K(1386496K)] 1388052K->3604K(1561600K), 0.0011109 secs] [Times: user=0.03 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:29.836+0800: 5.944: [GC (Allocation Failure) [PSYoungGen: 1384448K->768K(1386496K)] 1388052K->4372K(1561600K), 0.0045448 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:30.207+0800: 6.315: [GC (Allocation Failure) [PSYoungGen: 1385216K->0K(1386496K)] 1388820K->4276K(1561600K), 0.0046372 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:30.584+0800: 6.691: [GC (Allocation Failure) [PSYoungGen: 1384448K->288K(1318912K)] 1388724K->4564K(1494016K), 0.0022933 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:30.944+0800: 7.051: [GC (Allocation Failure) [PSYoungGen: 1318688K->640K(1257984K)] 1322964K->5140K(1433088K), 0.0036924 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:31.284+0800: 7.391: [GC (Allocation Failure) [PSYoungGen: 1256576K->0K(1197056K)] 1261076K->4988K(1372160K), 0.0034112 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:31.596+0800: 7.703: [GC (Allocation Failure) [PSYoungGen: 1196544K->544K(1383936K)] 1201532K->5532K(1559040K), 0.0038690 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:31.970+0800: 8.078: [GC (Allocation Failure) [PSYoungGen: 1382944K->320K(1387008K)] 1387932K->5788K(1562112K), 0.0045615 secs] [Times: user=0.11 sys=0.02, real=0.00 secs] 
2020-07-28T01:45:32.340+0800: 8.447: [GC (Allocation Failure) [PSYoungGen: 1385792K->0K(1319936K)] 1391260K->5692K(1495040K), 0.0021098 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:32.686+0800: 8.794: [GC (Allocation Failure) [PSYoungGen: 1319424K->800K(1257984K)] 1325116K->6492K(1433088K), 0.0042386 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:33.031+0800: 9.138: [GC (Allocation Failure) [PSYoungGen: 1257760K->0K(1385472K)] 1263452K->6364K(1560576K), 0.0046622 secs] [Times: user=0.02 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:33.400+0800: 9.508: [GC (Allocation Failure) [PSYoungGen: 1383936K->0K(1318400K)] 1390300K->6364K(1493504K), 0.0014439 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:33.754+0800: 9.862: [GC (Allocation Failure) [PSYoungGen: 1317888K->832K(1256960K)] 1324252K->7196K(1432064K), 0.0042319 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:34.086+0800: 10.194: [GC (Allocation Failure) [PSYoungGen: 1256256K->0K(1385984K)] 1262620K->7036K(1561088K), 0.0044440 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:34.456+0800: 10.564: [GC (Allocation Failure) [PSYoungGen: 1384448K->0K(1318912K)] 1391484K->7036K(1494016K), 0.0008067 secs] [Times: user=0.01 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:34.802+0800: 10.910: [GC (Allocation Failure) [PSYoungGen: 1318400K->800K(1256960K)] 1325436K->7836K(1432064K), 0.0047808 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:35.142+0800: 11.249: [GC (Allocation Failure) [PSYoungGen: 1256736K->0K(1384448K)] 1263772K->7708K(1559552K), 0.0040559 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:35.515+0800: 11.622: [GC (Allocation Failure) [PSYoungGen: 1382912K->0K(1317888K)] 1390620K->7708K(1492992K), 0.0010345 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:35.867+0800: 11.975: [GC (Allocation Failure) [PSYoungGen: 1317376K->768K(1256448K)] 1325084K->8476K(1431552K), 0.0034270 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:36.210+0800: 12.318: [GC (Allocation Failure) [PSYoungGen: 1255680K->0K(1196032K)] 1263388K->8380K(1371136K), 0.0039587 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:36.533+0800: 12.641: [GC (Allocation Failure) [PSYoungGen: 1195520K->0K(1140736K)] 1203900K->8380K(1315840K), 0.0010645 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:36.841+0800: 12.949: [GC (Allocation Failure) [PSYoungGen: 1139200K->800K(1086464K)] 1147580K->9180K(1261568K), 0.0036930 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:37.153+0800: 13.261: [GC (Allocation Failure) [PSYoungGen: 1086240K->0K(1325056K)] 1094620K->9052K(1500160K), 0.0047955 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:37.508+0800: 13.615: [GC (Allocation Failure) [PSYoungGen: 1324544K->0K(1262080K)] 1333596K->9052K(1437184K), 0.0010161 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:37.897+0800: 14.004: [GC (Allocation Failure) [PSYoungGen: 1261568K->832K(1203200K)] 1270620K->9884K(1378304K), 0.0038449 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:38.240+0800: 14.347: [GC (Allocation Failure) [PSYoungGen: 1202496K->0K(1145344K)] 1211548K->9740K(1320448K), 0.0048670 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:38.559+0800: 14.666: [GC (Allocation Failure) [PSYoungGen: 1144832K->0K(1092608K)] 1154572K->9740K(1267712K), 0.0012054 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:38.859+0800: 14.966: [GC (Allocation Failure) [PSYoungGen: 1091072K->672K(1040896K)] 1100812K->10412K(1216000K), 0.0035737 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:39.146+0800: 15.253: [GC (Allocation Failure) [PSYoungGen: 1040544K->0K(1269248K)] 1050284K->10412K(1444352K), 0.0078338 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:39.504+0800: 15.611: [GC (Allocation Failure) [PSYoungGen: 1268736K->0K(1380864K)] 1279148K->10412K(1555968K), 0.0025550 secs] [Times: user=0.03 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:39.902+0800: 16.010: [GC (Allocation Failure) [PSYoungGen: 1379328K->736K(1380864K)] 1389740K->11148K(1555968K), 0.0036041 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:40.282+0800: 16.389: [GC (Allocation Failure) [PSYoungGen: 1380064K->0K(1387008K)] 1390476K->11084K(1562112K), 0.0047973 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:40.676+0800: 16.783: [GC (Allocation Failure) [PSYoungGen: 1385472K->768K(1387008K)] 1396556K->11852K(1562112K), 0.0044042 secs] [Times: user=0.02 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:41.051+0800: 17.158: [GC (Allocation Failure) [PSYoungGen: 1386240K->0K(1387008K)] 1397324K->11756K(1562112K), 0.0042475 secs] [Times: user=0.13 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:41.428+0800: 17.535: [GC (Allocation Failure) [PSYoungGen: 1385472K->0K(1319936K)] 1397228K->11756K(1495040K), 0.0007525 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:41.792+0800: 17.899: [GC (Allocation Failure) [PSYoungGen: 1319424K->768K(1257984K)] 1331180K->12524K(1433088K), 0.0044829 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:42.171+0800: 18.279: [GC (Allocation Failure) [PSYoungGen: 1257728K->0K(1385472K)] 1269484K->12444K(1560576K), 0.0047608 secs] [Times: user=0.02 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:42.563+0800: 18.675: [GC (Allocation Failure) [PSYoungGen: 1383936K->0K(1318400K)] 1396380K->12444K(1493504K), 0.0007516 secs] [Times: user=0.02 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:42.914+0800: 19.021: [GC (Allocation Failure) [PSYoungGen: 1317888K->768K(1256960K)] 1330332K->13212K(1432064K), 0.0042181 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:43.256+0800: 19.363: [GC (Allocation Failure) [PSYoungGen: 1256192K->0K(1196544K)] 1268636K->13116K(1371648K), 0.0042273 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:43.577+0800: 19.684: [GC (Allocation Failure) [PSYoungGen: 1196032K->0K(1141248K)] 1209148K->13116K(1316352K), 0.0010647 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:43.885+0800: 19.993: [GC (Allocation Failure) [PSYoungGen: 1139712K->800K(1086976K)] 1152828K->13916K(1262080K), 0.0044039 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:44.182+0800: 20.289: [GC (Allocation Failure) [PSYoungGen: 1086752K->0K(1304064K)] 1099868K->13796K(1479168K), 0.0047595 secs] [Times: user=0.00 sys=0.00, real=0.01 secs] 
2020-07-28T01:45:44.542+0800: 20.650: [GC (Allocation Failure) [PSYoungGen: 1303552K->0K(1242112K)] 1317348K->13796K(1417216K), 0.0014079 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:44.885+0800: 20.993: [GC (Allocation Failure) [PSYoungGen: 1241600K->768K(1184256K)] 1255396K->14564K(1359360K), 0.0039656 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:45.224+0800: 21.332: [GC (Allocation Failure) [PSYoungGen: 1183488K->0K(1127424K)] 1197284K->14468K(1302528K), 0.0035375 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:45.540+0800: 21.647: [GC (Allocation Failure) [PSYoungGen: 1126912K->0K(1075200K)] 1141380K->14468K(1250304K), 0.0012474 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] 
2020-07-28T01:45:45.845+0800: 21.952: [GC (Allocation Failure) [PSYoungGen: 1073664K->768K(1024512K)] 1088132K->15236K(1199616K), 0.0038977 secs] [Times: user=0.03 sys=0.03, real=0.00 secs] 
  1. 統計gc時間間隔(分布)
    其中第二列就是時間,所以主要求出兩行之差就可以算出,直接寫代碼
awk '{print $2}' gc.txt |
awk -F ":" '{print $1}'|
awk 'BEGIN{temp=0;count=0}{
    if(count != 0){
        diff = $1 - temp;
        print diff
        
    }
    temp = $1
    count++;
}'

結果如下:
0.036
0.023
0.022
0.11
0.041
0.203
0.08
0.381
0.135
0.527
0.241
0.822
0.348
0.406
0.37
0.365
0.371
0.372
0.364
...

這樣就可以得到gc的兩次gc的間隔了,然后再統計gc的間隔分布就容易了,就可以分析出gc的頻繁,為gc調優做準備

  1. 求每次gc的晉升量(晉升速度、分布)
    晉升量就是younggc后老年代的變化量
awk '{
    if(match($0, "PSYoungGen")){
        print $7","$8
    }
}' gc.txt|
awk -F "->" '{print $1","$2","$3}'|
awk -F "K[(]" '{print $1","$2","$3}'|
awk -F "K[)]]" '{print $1$2}'|
awk -F "K[)]" '{print $1}'|
awk -F "K" '{print $1$2$3}'|
awk -F "," '{
    temp =$5 - $2;
    print temp;
}'|
awk 'BEGIN{temp=0;count=0}{
    if(count != 0){
        diff = $1 - temp;
        print diff
        
    }
    temp = $1
    count++;
}'

結果如下:
0
0
0
0
0
1332
0
0
0
664
0
0
224
528
176
0
672
0
0
672
0
224
488
0
480
224
0
...
  1. 求每次gc的時間(gc時間的分布等)
awk '{
    if(match($0, "PSYoungGen")){
        print $7","$8$9
    }
}' gc.txt|
awk -F "->" '{print $1","$2","$3}'|
awk -F "K[(]" '{print $1","$2","$3}'|
awk -F "K[)]]" '{print $1$2}'|
awk -F "K[)]" '{print $1$2}'|
awk -F "K" '{print $1$2$3}'|
awk -F "," '{print $6}'

結果如下:
0.0042882
0.0042457
0.0033243
0.0035944
0.0043860
0.0035378
0.0055308
0.0009377
0.0030435
0.0042685
0.0072233
0.0008589
0.0044832
0.0042988
0.0041383
0.0024757

這里再弄細一點,時間分布:0ms - 200ms,步長為10ms

awk '{
    if(match($0, "PSYoungGen")){
        print $7","$8$9
    }
}' gc.txt|
awk -F "->" '{print $1","$2","$3}'|
awk -F "K[(]" '{print $1","$2","$3}'|
awk -F "K[)]]" '{print $1$2}'|
awk -F "K[)]" '{print $1$2}'|
awk -F "K" '{print $1$2$3}'|
awk -F "," '{print $7}'|
awk 'BEGIN{
   count[0]=0;
   for(i=0;i<21;i++){
       count[i]=0;
   }
   total=0;
}{
    for(i=0;i<21;i++){
        
        if($1*1000 < (i+1)*10){
            count[i]++;
            break;
        }
        if(i >=20){
            count[20]++;
        }
    }
    total++;
}END{
    for(i=0;i<21;i++){
        if(i != 20){
            print (i*10)"ms~"((i+1)*10)"ms:"(count[i]/total*100.0)"%"
        }else{
            print (i*10)"ms+:"(count[i]/total*100.0)"%"
        }
    }
}'
結果如下:
0ms~10ms:100%
10ms~20ms:0%
20ms~30ms:0%
30ms~40ms:0%
40ms~50ms:0%
50ms~60ms:0%
60ms~70ms:0%
70ms~80ms:0%
80ms~90ms:0%
90ms~100ms:0%
100ms~110ms:0%
110ms~120ms:0%
120ms~130ms:0%
130ms~140ms:0%
140ms~150ms:0%
150ms~160ms:0%
160ms~170ms:0%
170ms~180ms:0%
180ms~190ms:0%
190ms~200ms:0%
200ms+:0%

總結

當然還有很的資訊可以挖掘,
對調參、優化程式的性能狀態提供比較好的統計資料,同時結合其他一些日志或者jvm資訊,甚至可以直接優化代碼,

轉載請註明出處,本文鏈接:https://www.uj5u.com/houduan/115581.html

標籤:Java

上一篇:java動態代理——jvm指令集基本概念和方法位元組碼結構的進一步探究及proxy原始碼分析四

下一篇:Java自學-JDBC 資料庫連接池

標籤雲
其他(157675) Python(38076) JavaScript(25376) Java(17977) C(15215) 區塊鏈(8255) C#(7972) AI(7469) 爪哇(7425) MySQL(7132) html(6777) 基礎類(6313) sql(6102) 熊猫(6058) PHP(5869) 数组(5741) R(5409) Linux(5327) 反应(5209) 腳本語言(PerlPython)(5129) 非技術區(4971) Android(4554) 数据框(4311) css(4259) 节点.js(4032) C語言(3288) json(3245) 列表(3129) 扑(3119) C++語言(3117) 安卓(2998) 打字稿(2995) VBA(2789) Java相關(2746) 疑難問題(2699) 细绳(2522) 單片機工控(2479) iOS(2429) ASP.NET(2402) MongoDB(2323) 麻木的(2285) 正则表达式(2254) 字典(2211) 循环(2198) 迅速(2185) 擅长(2169) 镖(2155) 功能(1967) .NET技术(1958) Web開發(1951) python-3.x(1918) HtmlCss(1915) 弹簧靴(1913) C++(1909) xml(1889) PostgreSQL(1872) .NETCore(1853) 谷歌表格(1846) Unity3D(1843) for循环(1842)

熱門瀏覽
  • 【C++】Microsoft C++、C 和匯編程式檔案

    ......

    uj5u.com 2020-09-10 00:57:23 more
  • 例外宣告

    相比于斷言適用于排除邏輯上不可能存在的狀態,例外通常是用于邏輯上可能發生的錯誤。 例外宣告 Item 1:當函式不可能拋出例外或不能接受拋出例外時,使用noexcept 理由 如果不打算拋出例外的話,程式就會認為無法處理這種錯誤,并且應當盡早終止,如此可以有效地阻止例外的傳播與擴散。 示例 //不可 ......

    uj5u.com 2020-09-10 00:57:27 more
  • Codeforces 1400E Clear the Multiset(貪心 + 分治)

    鏈接:https://codeforces.com/problemset/problem/1400/E 來源:Codeforces 思路:給你一個陣列,現在你可以進行兩種操作,操作1:將一段沒有 0 的區間進行減一的操作,操作2:將 i 位置上的元素歸零。最終問:將這個陣列的全部元素歸零后操作的最少 ......

    uj5u.com 2020-09-10 00:57:30 more
  • UVA11610 【Reverse Prime】

    本人看到此題沒有翻譯,就附帶了一個自己的翻譯版本 思考 這一題,它的第一個要求是找出所有 $7$ 位反向質數及其質因數的個數。 我們應該需要質數篩篩選1~$10^{7}$的所有數,這里就不慢慢介紹了。但是,重讀題,我們突然發現反向質數都是 $7$ 位,而將它反過來后的數字卻是 $6$ 位數,這就說明 ......

    uj5u.com 2020-09-10 00:57:36 more
  • 統計區間素數數量

    1 #pragma GCC optimize(2) 2 #include <bits/stdc++.h> 3 using namespace std; 4 bool isprime[1000000010]; 5 vector<int> prime; 6 inline int getlist(int ......

    uj5u.com 2020-09-10 00:57:47 more
  • C/C++編程筆記:C++中的 const 變數詳解,教你正確認識const用法

    1、C中的const 1、區域const變數存放在堆疊區中,會分配記憶體(也就是說可以通過地址間接修改變數的值)。測驗代碼如下: 運行結果: 2、全域const變數存放在只讀資料段(不能通過地址修改,會發生寫入錯誤), 默認為外部聯編,可以給其他源檔案使用(需要用extern關鍵字修飾) 運行結果: ......

    uj5u.com 2020-09-10 00:58:04 more
  • 【C++犯錯記錄】VS2019 MFC添加資源不懂如何修改資源宏ID

    1. 首先在資源視圖中,添加資源 2. 點擊新添加的資源,復制自動生成的ID 3. 在解決方案資源管理器中找到Resource.h檔案,編輯,使用整個專案搜索和替換的方式快速替換 宏宣告 4. Ctrl+Shift+F 全域搜索,點擊查找全部,然后逐個替換 5. 為什么使用搜索替換而不使用屬性視窗直 ......

    uj5u.com 2020-09-10 00:59:11 more
  • 【C++犯錯記錄】VS2019 MFC不懂的批量添加資源

    1. 打開資源頭檔案Resource.h,在其中預先定義好宏 ID(不清楚其實ID值應該設定多少,可以先新建一個相同的資源項,再在這個資源的ID值的基礎上遞增即可) 2. 在資源視圖中選中專案資源,按F7編輯資源檔案,按 ID 型別 相對路徑的形式添加 資源。(別忘了先把檔案拷貝到專案中的res檔案 ......

    uj5u.com 2020-09-10 01:00:19 more
  • C/C++編程筆記:關于C++的參考型別,專供新手入門使用

    今天要講的是C++中我最喜歡的一個用法——參考,也叫別名。 參考就是給一個變數名取一個變數名,方便我們間接地使用這個變數。我們可以給一個變數創建N個參考,這N + 1個變數共享了同一塊記憶體區域。(參考型別的變數會占用記憶體空間,占用的記憶體空間的大小和指標型別的大小是相同的。雖然參考是一個物件的別名,但 ......

    uj5u.com 2020-09-10 01:00:22 more
  • 【C/C++編程筆記】從頭開始學習C ++:初學者完整指南

    眾所周知,C ++的學習曲線陡峭,但是花時間學習這種語言將為您的職業帶來奇跡,并使您與其他開發人員區分開。您會更輕松地學習新語言,形成真正的解決問題的技能,并在編程的基礎上打下堅實的基礎。 C ++將幫助您養成良好的編程習慣(即清晰一致的編碼風格,在撰寫代碼時注釋代碼,并限制類內部的可見性),并且由 ......

    uj5u.com 2020-09-10 01:00:41 more
最新发布
  • Rust中的智能指標:Box<T> Rc<T> Arc<T> Cell<T> RefCell<T> Weak

    Rust中的智能指標是什么 智能指標(smart pointers)是一類資料結構,是擁有資料所有權和額外功能的指標。是指標的進一步發展 指標(pointer)是一個包含記憶體地址的變數的通用概念。這個地址參考,或 ” 指向”(points at)一些其 他資料 。參考以 & 符號為標志并借用了他們所 ......

    uj5u.com 2023-04-20 07:24:10 more
  • Java的值傳遞和參考傳遞

    值傳遞不會改變本身,參考傳遞(如果傳遞的值需要實體化到堆里)如果發生修改了會改變本身。 1.基本資料型別都是值傳遞 package com.example.basic; public class Test { public static void main(String[] args) { int ......

    uj5u.com 2023-04-20 07:24:04 more
  • [2]SpinalHDL教程——Scala簡單入門

    第一個 Scala 程式 shell里面輸入 $ scala scala> 1 + 1 res0: Int = 2 scala> println("Hello World!") Hello World! 檔案形式 object HelloWorld { /* 這是我的第一個 Scala 程式 * 以 ......

    uj5u.com 2023-04-20 07:23:58 more
  • 理解函式指標和回呼函式

    理解 函式指標 指向函式的指標。比如: 理解函式指標的偽代碼 void (*p)(int type, char *data); // 定義一個函式指標p void func(int type, char *data); // 宣告一個函式func p = func; // 將指標p指向函式func ......

    uj5u.com 2023-04-20 07:23:52 more
  • Django筆記二十五之資料庫函式之日期函式

    本文首發于公眾號:Hunter后端 原文鏈接:Django筆記二十五之資料庫函式之日期函式 日期函式主要介紹兩個大類,Extract() 和 Trunc() Extract() 函式作用是提取日期,比如我們可以提取一個日期欄位的年份,月份,日等資料 Trunc() 的作用則是截取,比如 2022-0 ......

    uj5u.com 2023-04-20 07:23:45 more
  • 一天吃透JVM面試八股文

    什么是JVM? JVM,全稱Java Virtual Machine(Java虛擬機),是通過在實際的計算機上仿真模擬各種計算機功能來實作的。由一套位元組碼指令集、一組暫存器、一個堆疊、一個垃圾回收堆和一個存盤方法域等組成。JVM屏蔽了與作業系統平臺相關的資訊,使得Java程式只需要生成在Java虛擬機 ......

    uj5u.com 2023-04-20 07:23:31 more
  • 使用Java接入小程式訂閱訊息!

    更新完微信服務號的模板訊息之后,我又趕緊把微信小程式的訂閱訊息給實作了!之前我一直以為微信小程式也是要企業才能申請,沒想到小程式個人就能申請。 訊息推送平臺🔥推送下發【郵件】【短信】【微信服務號】【微信小程式】【企業微信】【釘釘】等訊息型別。 https://gitee.com/zhongfuch ......

    uj5u.com 2023-04-20 07:22:59 more
  • java -- 緩沖流、轉換流、序列化流

    緩沖流 緩沖流, 也叫高效流, 按照資料型別分類: 位元組緩沖流:BufferedInputStream,BufferedOutputStream 字符緩沖流:BufferedReader,BufferedWriter 緩沖流的基本原理,是在創建流物件時,會創建一個內置的默認大小的緩沖區陣列,通過緩沖 ......

    uj5u.com 2023-04-20 07:22:49 more
  • Java-SpringBoot-Range請求頭設定實作視頻分段傳輸

    老實說,人太懶了,現在基本都不喜歡寫筆記了,但是網上有關Range請求頭的文章都太水了 下面是抄的一段StackOverflow的代碼...自己大修改過的,寫的注釋挺全的,應該直接看得懂,就不解釋了 寫的不好...只是希望能給視頻網站開發的新手一點點幫助吧. 業務場景:視頻分段傳輸、視頻多段傳輸(理 ......

    uj5u.com 2023-04-20 07:22:42 more
  • Windows 10開發教程_編程入門自學教程_菜鳥教程-免費教程分享

    教程簡介 Windows 10開發入門教程 - 從簡單的步驟了解Windows 10開發,從基本到高級概念,包括簡介,UWP,第一個應用程式,商店,XAML控制元件,資料系結,XAML性能,自適應設計,自適應UI,自適應代碼,檔案管理,SQLite資料庫,應用程式到應用程式通信,應用程式本地化,應用程式 ......

    uj5u.com 2023-04-20 07:22:35 more