annotate src/share/vm/gc_implementation/shared/gcTraceTime.cpp @ 20190:0982ec23da03

8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps Reviewed-by: jwilhelm, ehelin, tschatzl
author brutisso
date Thu, 19 Jun 2014 13:31:14 +0200
parents 86e6d691f2e1
children
Ignore whitespace changes - Everywhere: Within whitespace: At end of lines:
rev   line source
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
1 /*
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
2 * Copyright (c) 2012, 2013, Oracle and/or its affiliates. All rights reserved.
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
3 * DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER.
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
4 *
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
5 * This code is free software; you can redistribute it and/or modify it
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
6 * under the terms of the GNU General Public License version 2 only, as
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
7 * published by the Free Software Foundation.
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
8 *
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
9 * This code is distributed in the hope that it will be useful, but WITHOUT
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
10 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
11 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
12 * version 2 for more details (a copy is included in the LICENSE file that
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
13 * accompanied this code).
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
14 *
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
15 * You should have received a copy of the GNU General Public License version
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
16 * 2 along with this work; if not, write to the Free Software Foundation,
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
17 * Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA.
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
18 *
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
19 * Please contact Oracle, 500 Oracle Parkway, Redwood Shores, CA 94065 USA
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
20 * or visit www.oracle.com if you need additional information or have any
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
21 * questions.
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
22 *
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
23 */
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
24
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
25 #include "precompiled.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
26 #include "gc_implementation/shared/gcTimer.hpp"
20190
0982ec23da03 8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps
brutisso
parents: 13400
diff changeset
27 #include "gc_implementation/shared/gcTrace.hpp"
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
28 #include "gc_implementation/shared/gcTraceTime.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
29 #include "runtime/globals.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
30 #include "runtime/os.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
31 #include "runtime/safepoint.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
32 #include "runtime/thread.inline.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
33 #include "runtime/timer.hpp"
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
34 #include "utilities/ostream.hpp"
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
35 #include "utilities/ticks.inline.hpp"
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
36
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
37
20190
0982ec23da03 8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps
brutisso
parents: 13400
diff changeset
38 GCTraceTime::GCTraceTime(const char* title, bool doit, bool print_cr, GCTimer* timer, GCId gc_id) :
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
39 _title(title), _doit(doit), _print_cr(print_cr), _timer(timer), _start_counter() {
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
40 if (_doit || _timer != NULL) {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
41 _start_counter.stamp();
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
42 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
43
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
44 if (_timer != NULL) {
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
45 assert(SafepointSynchronize::is_at_safepoint(), "Tracing currently only supported at safepoints");
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
46 assert(Thread::current()->is_VM_thread(), "Tracing currently only supported from the VM thread");
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
47
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
48 _timer->register_gc_phase_start(title, _start_counter);
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
49 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
50
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
51 if (_doit) {
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
52 if (PrintGCTimeStamps) {
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
53 gclog_or_tty->stamp();
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
54 gclog_or_tty->print(": ");
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
55 }
20190
0982ec23da03 8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps
brutisso
parents: 13400
diff changeset
56 if (PrintGCID) {
0982ec23da03 8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps
brutisso
parents: 13400
diff changeset
57 gclog_or_tty->print("#%u: ", gc_id.id());
0982ec23da03 8043607: Add a GC id as a log decoration similar to PrintGCTimeStamps
brutisso
parents: 13400
diff changeset
58 }
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
59 gclog_or_tty->print("[%s", title);
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
60 gclog_or_tty->flush();
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
61 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
62 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
63
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
64 GCTraceTime::~GCTraceTime() {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
65 Ticks stop_counter;
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
66
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
67 if (_doit || _timer != NULL) {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
68 stop_counter.stamp();
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
69 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
70
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
71 if (_timer != NULL) {
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
72 _timer->register_gc_phase_end(stop_counter);
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
73 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
74
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
75 if (_doit) {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
76 const Tickspan duration = stop_counter - _start_counter;
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
77 double duration_in_seconds = TicksToTimeHelper::seconds(duration);
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
78 if (_print_cr) {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
79 gclog_or_tty->print_cr(", %3.7f secs]", duration_in_seconds);
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
80 } else {
13400
86e6d691f2e1 8028128: Add a type safe alternative for working with counter based data
mgronlun
parents: 10405
diff changeset
81 gclog_or_tty->print(", %3.7f secs]", duration_in_seconds);
10405
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
82 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
83 gclog_or_tty->flush();
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
84 }
f2110083203d 8005849: JEP 167: Event-Based JVM Tracing
sla
parents:
diff changeset
85 }