author | mchernov |
Thu, 03 Mar 2016 16:12:38 +0300 | |
changeset 37061 | f4f1c40edfd9 |
parent 36390 | a2d991d1d628 |
child 37181 | 0d5e8ae18924 |
permissions | -rw-r--r-- |
35885 | 1 |
/* |
2 |
* Copyright (c) 2016, Oracle and/or its affiliates. All rights reserved. |
|
3 |
* DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER. |
|
4 |
* |
|
5 |
* This code is free software; you can redistribute it and/or modify it |
|
6 |
* under the terms of the GNU General Public License version 2 only, as |
|
7 |
* published by the Free Software Foundation. |
|
8 |
* |
|
9 |
* This code is distributed in the hope that it will be useful, but WITHOUT |
|
10 |
* ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or |
|
11 |
* FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License |
|
12 |
* version 2 for more details (a copy is included in the LICENSE file that |
|
13 |
* accompanied this code). |
|
14 |
* |
|
15 |
* You should have received a copy of the GNU General Public License version |
|
16 |
* 2 along with this work; if not, write to the Free Software Foundation, |
|
17 |
* Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA. |
|
18 |
* |
|
19 |
* Please contact Oracle, 500 Oracle Parkway, Redwood Shores, CA 94065 USA |
|
20 |
* or visit www.oracle.com if you need additional information or have any |
|
21 |
* questions. |
|
22 |
*/ |
|
23 |
package gc.g1.plab.lib; |
|
24 |
||
25 |
import java.util.EnumMap; |
|
26 |
import java.util.HashMap; |
|
27 |
import java.util.Map; |
|
28 |
import java.util.Optional; |
|
29 |
import java.util.Scanner; |
|
30 |
import java.util.regex.Matcher; |
|
31 |
import java.util.regex.Pattern; |
|
32 |
||
33 |
/** |
|
34 |
* LogParser class parses VM output to get PLAB and ConsumptionStats values. |
|
35 |
* |
|
36 |
* Typical GC log with PLAB statistics (options - -Xlog:gc=debug,gc+plab=debug) looks like: |
|
37 |
* |
|
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
38 |
* [0.330s][debug][gc,plab ] GC(0) Young PLAB allocation: allocated: 1825632B, wasted: 29424B, unused: 2320B, used: 1793888B, undo waste: 0B, |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
39 |
* [0.330s][debug][gc,plab ] GC(0) Young other allocation: region end waste: 0B, regions filled: 2, direct allocated: 271520B, failure used: 0B, failure wasted: 0B |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
40 |
* [0.330s][debug][gc,plab ] GC(0) Young sizing: calculated: 358776B, actual: 358776B |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
41 |
* [0.330s][debug][gc,plab ] GC(0) Old PLAB allocation: allocated: 427248B, wasted: 592B, unused: 368584B, used: 58072B, undo waste: 0B, |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
42 |
* [0.330s][debug][gc,plab ] GC(0) Old other allocation: region end waste: 0B, regions filled: 1, direct allocated: 41704B, failure used: 0B, failure wasted: 0B |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
43 |
* [0.330s][debug][gc,plab ] GC(0) Old sizing: calculated: 11608B, actual: 11608B |
35885 | 44 |
*/ |
45 |
final public class LogParser { |
|
46 |
||
47 |
// Name for GC ID field in report. |
|
48 |
public final static String GC_ID = "gc_id"; |
|
49 |
||
50 |
/** |
|
51 |
* Type of parsed log element. |
|
52 |
*/ |
|
53 |
public static enum ReportType { |
|
54 |
SURVIVOR_STATS, |
|
55 |
OLD_STATS |
|
56 |
} |
|
57 |
||
58 |
private final String log; |
|
59 |
||
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
60 |
// Contains Map of PLAB statistics for given log. |
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
61 |
private final Map<Long, Map<ReportType, Map<String, Long>>> report; |
35885 | 62 |
|
63 |
// GC ID |
|
64 |
private static final Pattern GC_ID_PATTERN = Pattern.compile("\\[gc,plab\\s*\\] GC\\((\\d+)\\)"); |
|
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
65 |
// Pattern for extraction pair <name>: <numeric value> |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
66 |
private static final Pattern PAIRS_PATTERN = Pattern.compile("\\w* \\w+:\\s+\\d+"); |
35885 | 67 |
|
68 |
/** |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
69 |
* Construct LogParser object, parse log file with PLAB statistics and store it into report. |
35885 | 70 |
* |
71 |
* @param log - VM Output |
|
72 |
*/ |
|
73 |
public LogParser(String log) { |
|
74 |
if (log == null) { |
|
75 |
throw new IllegalArgumentException("Parameter log should not be null."); |
|
76 |
} |
|
77 |
this.log = log; |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
78 |
report = parseLines(); |
35885 | 79 |
} |
80 |
||
81 |
/** |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
82 |
* @return log which was processed |
35885 | 83 |
*/ |
84 |
public String getLog() { |
|
85 |
return log; |
|
86 |
} |
|
87 |
||
88 |
/** |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
89 |
* Returns the GC log entries for Survivor and Old stats. |
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
90 |
* The entries are represented as a map of gcID to the StatMap. |
35885 | 91 |
* |
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
92 |
* @return The log entries for the Survivor and Old stats. |
35885 | 93 |
*/ |
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
94 |
public Map<Long, Map<ReportType, Map<String, Long>>> getEntries() { |
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
95 |
return report; |
35885 | 96 |
} |
97 |
||
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
98 |
private Map<Long, Map<ReportType, Map<String, Long>>> parseLines() throws NumberFormatException { |
35885 | 99 |
Scanner lineScanner = new Scanner(log); |
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
100 |
Map<Long, Map<ReportType, Map<String, Long>>> allocationStatistics = new HashMap<>(); |
35885 | 101 |
Optional<Long> gc_id; |
102 |
while (lineScanner.hasNextLine()) { |
|
103 |
String line = lineScanner.nextLine(); |
|
104 |
gc_id = getGcId(line); |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
105 |
if (gc_id.isPresent()) { |
35885 | 106 |
Matcher matcher = PAIRS_PATTERN.matcher(line); |
107 |
if (matcher.find()) { |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
108 |
Map<ReportType, Map<String, Long>> oneReportItem; |
35885 | 109 |
ReportType reportType; |
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
110 |
|
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
111 |
if (!allocationStatistics.containsKey(gc_id.get())) { |
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
112 |
allocationStatistics.put(gc_id.get(), new EnumMap<>(ReportType.class)); |
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
113 |
} |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
114 |
|
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
115 |
if (line.contains("Young")) { |
35885 | 116 |
reportType = ReportType.SURVIVOR_STATS; |
117 |
} else { |
|
118 |
reportType = ReportType.OLD_STATS; |
|
119 |
} |
|
120 |
||
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
121 |
oneReportItem = allocationStatistics.get(gc_id.get()); |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
122 |
if (!oneReportItem.containsKey(reportType)) { |
37061
f4f1c40edfd9
8150183: gc/g1/plab/TestPLABResize.java - previous PLAB size should be less than current
mchernov
parents:
36390
diff
changeset
|
123 |
oneReportItem.put(reportType, new HashMap<>()); |
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
124 |
} |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
125 |
|
35885 | 126 |
// Extract all pairs from log. |
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
127 |
Map<String, Long> plabStats = oneReportItem.get(reportType); |
35885 | 128 |
do { |
129 |
String pair = matcher.group(); |
|
36390
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
130 |
String[] nameValue = pair.replaceAll(": ", ":").split(":"); |
a2d991d1d628
8141141: Young and Old gen PLAB stats are similar in output with -XX:+PrintPLAB
tschatzl
parents:
35885
diff
changeset
|
131 |
plabStats.put(nameValue[0].trim(), Long.parseLong(nameValue[1])); |
35885 | 132 |
} while (matcher.find()); |
133 |
} |
|
134 |
} |
|
135 |
} |
|
136 |
return allocationStatistics; |
|
137 |
} |
|
138 |
||
139 |
private Optional<Long> getGcId(String line) { |
|
140 |
Matcher number = GC_ID_PATTERN.matcher(line); |
|
141 |
if (number.find()) { |
|
142 |
return Optional.of(Long.parseLong(number.group(1))); |
|
143 |
} |
|
144 |
return Optional.empty(); |
|
145 |
} |
|
146 |
} |