annotate src/share/vm/runtime/timer.cpp @ 3979:4dfb2df418f2

6484982: G1: process references during evacuation pauses Summary: G1 now uses two reference processors - one is used by concurrent marking and the other is used by STW GCs (both full and incremental evacuation pauses). In an evacuation pause, the reference processor is embedded into the closures used to scan objects. Doing so causes causes reference objects to be 'discovered' by the reference processor. At the end of the evacuation pause, these discovered reference objects are processed - preserving (and copying) referent objects (and their reachable graphs) as appropriate. Reviewed-by: ysr, jwilhelm, brutisso, stefank, tonyp
author johnc
date Thu, 22 Sep 2011 10:57:37 -0700
parents f95d63e2154a
children f08d439fab8c
Ignore whitespace changes - Everywhere: Within whitespace: At end of lines:
rev   line source
0
a61af66fc99e Initial load
duke
parents:
diff changeset
1 /*
1972
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
2 * Copyright (c) 1997, 2010, Oracle and/or its affiliates. All rights reserved.
0
a61af66fc99e Initial load
duke
parents:
diff changeset
3 * DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER.
a61af66fc99e Initial load
duke
parents:
diff changeset
4 *
a61af66fc99e Initial load
duke
parents:
diff changeset
5 * This code is free software; you can redistribute it and/or modify it
a61af66fc99e Initial load
duke
parents:
diff changeset
6 * under the terms of the GNU General Public License version 2 only, as
a61af66fc99e Initial load
duke
parents:
diff changeset
7 * published by the Free Software Foundation.
a61af66fc99e Initial load
duke
parents:
diff changeset
8 *
a61af66fc99e Initial load
duke
parents:
diff changeset
9 * This code is distributed in the hope that it will be useful, but WITHOUT
a61af66fc99e Initial load
duke
parents:
diff changeset
10 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
a61af66fc99e Initial load
duke
parents:
diff changeset
11 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License
a61af66fc99e Initial load
duke
parents:
diff changeset
12 * version 2 for more details (a copy is included in the LICENSE file that
a61af66fc99e Initial load
duke
parents:
diff changeset
13 * accompanied this code).
a61af66fc99e Initial load
duke
parents:
diff changeset
14 *
a61af66fc99e Initial load
duke
parents:
diff changeset
15 * You should have received a copy of the GNU General Public License version
a61af66fc99e Initial load
duke
parents:
diff changeset
16 * 2 along with this work; if not, write to the Free Software Foundation,
a61af66fc99e Initial load
duke
parents:
diff changeset
17 * Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA.
a61af66fc99e Initial load
duke
parents:
diff changeset
18 *
1552
c18cbe5936b8 6941466: Oracle rebranding changes for Hotspot repositories
trims
parents: 0
diff changeset
19 * Please contact Oracle, 500 Oracle Parkway, Redwood Shores, CA 94065 USA
c18cbe5936b8 6941466: Oracle rebranding changes for Hotspot repositories
trims
parents: 0
diff changeset
20 * or visit www.oracle.com if you need additional information or have any
c18cbe5936b8 6941466: Oracle rebranding changes for Hotspot repositories
trims
parents: 0
diff changeset
21 * questions.
0
a61af66fc99e Initial load
duke
parents:
diff changeset
22 *
a61af66fc99e Initial load
duke
parents:
diff changeset
23 */
a61af66fc99e Initial load
duke
parents:
diff changeset
24
1972
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
25 #include "precompiled.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
26 #include "oops/oop.inline.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
27 #include "runtime/timer.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
28 #include "utilities/ostream.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
29 #ifdef TARGET_OS_FAMILY_linux
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
30 # include "os_linux.inline.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
31 #endif
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
32 #ifdef TARGET_OS_FAMILY_solaris
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
33 # include "os_solaris.inline.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
34 #endif
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
35 #ifdef TARGET_OS_FAMILY_windows
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
36 # include "os_windows.inline.hpp"
f95d63e2154a 6989984: Use standard include model for Hospot
stefank
parents: 1552
diff changeset
37 #endif
0
a61af66fc99e Initial load
duke
parents:
diff changeset
38
a61af66fc99e Initial load
duke
parents:
diff changeset
39
a61af66fc99e Initial load
duke
parents:
diff changeset
40 void elapsedTimer::add(elapsedTimer t) {
a61af66fc99e Initial load
duke
parents:
diff changeset
41 _counter += t._counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
42 }
a61af66fc99e Initial load
duke
parents:
diff changeset
43
a61af66fc99e Initial load
duke
parents:
diff changeset
44 void elapsedTimer::start() {
a61af66fc99e Initial load
duke
parents:
diff changeset
45 if (!_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
46 _active = true;
a61af66fc99e Initial load
duke
parents:
diff changeset
47 _start_counter = os::elapsed_counter();
a61af66fc99e Initial load
duke
parents:
diff changeset
48 }
a61af66fc99e Initial load
duke
parents:
diff changeset
49 }
a61af66fc99e Initial load
duke
parents:
diff changeset
50
a61af66fc99e Initial load
duke
parents:
diff changeset
51 void elapsedTimer::stop() {
a61af66fc99e Initial load
duke
parents:
diff changeset
52 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
53 _counter += os::elapsed_counter() - _start_counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
54 _active = false;
a61af66fc99e Initial load
duke
parents:
diff changeset
55 }
a61af66fc99e Initial load
duke
parents:
diff changeset
56 }
a61af66fc99e Initial load
duke
parents:
diff changeset
57
a61af66fc99e Initial load
duke
parents:
diff changeset
58 double elapsedTimer::seconds() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
59 double count = (double) _counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
60 double freq = (double) os::elapsed_frequency();
a61af66fc99e Initial load
duke
parents:
diff changeset
61 return count/freq;
a61af66fc99e Initial load
duke
parents:
diff changeset
62 }
a61af66fc99e Initial load
duke
parents:
diff changeset
63
a61af66fc99e Initial load
duke
parents:
diff changeset
64 jlong elapsedTimer::milliseconds() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
65 jlong ticks_per_ms = os::elapsed_frequency() / 1000;
a61af66fc99e Initial load
duke
parents:
diff changeset
66 return _counter / ticks_per_ms;
a61af66fc99e Initial load
duke
parents:
diff changeset
67 }
a61af66fc99e Initial load
duke
parents:
diff changeset
68
a61af66fc99e Initial load
duke
parents:
diff changeset
69 jlong elapsedTimer::active_ticks() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
70 if (!_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
71 return ticks();
a61af66fc99e Initial load
duke
parents:
diff changeset
72 }
a61af66fc99e Initial load
duke
parents:
diff changeset
73 jlong counter = _counter + os::elapsed_counter() - _start_counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
74 return counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
75 }
a61af66fc99e Initial load
duke
parents:
diff changeset
76
a61af66fc99e Initial load
duke
parents:
diff changeset
77 void TimeStamp::update_to(jlong ticks) {
a61af66fc99e Initial load
duke
parents:
diff changeset
78 _counter = ticks;
a61af66fc99e Initial load
duke
parents:
diff changeset
79 if (_counter == 0) _counter = 1;
a61af66fc99e Initial load
duke
parents:
diff changeset
80 assert(is_updated(), "must not look clear");
a61af66fc99e Initial load
duke
parents:
diff changeset
81 }
a61af66fc99e Initial load
duke
parents:
diff changeset
82
a61af66fc99e Initial load
duke
parents:
diff changeset
83 void TimeStamp::update() {
a61af66fc99e Initial load
duke
parents:
diff changeset
84 update_to(os::elapsed_counter());
a61af66fc99e Initial load
duke
parents:
diff changeset
85 }
a61af66fc99e Initial load
duke
parents:
diff changeset
86
a61af66fc99e Initial load
duke
parents:
diff changeset
87 double TimeStamp::seconds() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
88 assert(is_updated(), "must not be clear");
a61af66fc99e Initial load
duke
parents:
diff changeset
89 jlong new_count = os::elapsed_counter();
a61af66fc99e Initial load
duke
parents:
diff changeset
90 double count = (double) new_count - _counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
91 double freq = (double) os::elapsed_frequency();
a61af66fc99e Initial load
duke
parents:
diff changeset
92 return count/freq;
a61af66fc99e Initial load
duke
parents:
diff changeset
93 }
a61af66fc99e Initial load
duke
parents:
diff changeset
94
a61af66fc99e Initial load
duke
parents:
diff changeset
95 jlong TimeStamp::milliseconds() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
96 assert(is_updated(), "must not be clear");
a61af66fc99e Initial load
duke
parents:
diff changeset
97
a61af66fc99e Initial load
duke
parents:
diff changeset
98 jlong new_count = os::elapsed_counter();
a61af66fc99e Initial load
duke
parents:
diff changeset
99 jlong count = new_count - _counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
100 jlong ticks_per_ms = os::elapsed_frequency() / 1000;
a61af66fc99e Initial load
duke
parents:
diff changeset
101 return count / ticks_per_ms;
a61af66fc99e Initial load
duke
parents:
diff changeset
102 }
a61af66fc99e Initial load
duke
parents:
diff changeset
103
a61af66fc99e Initial load
duke
parents:
diff changeset
104 jlong TimeStamp::ticks_since_update() const {
a61af66fc99e Initial load
duke
parents:
diff changeset
105 assert(is_updated(), "must not be clear");
a61af66fc99e Initial load
duke
parents:
diff changeset
106 return os::elapsed_counter() - _counter;
a61af66fc99e Initial load
duke
parents:
diff changeset
107 }
a61af66fc99e Initial load
duke
parents:
diff changeset
108
a61af66fc99e Initial load
duke
parents:
diff changeset
109 TraceTime::TraceTime(const char* title,
a61af66fc99e Initial load
duke
parents:
diff changeset
110 bool doit,
a61af66fc99e Initial load
duke
parents:
diff changeset
111 bool print_cr,
a61af66fc99e Initial load
duke
parents:
diff changeset
112 outputStream* logfile) {
a61af66fc99e Initial load
duke
parents:
diff changeset
113 _active = doit;
a61af66fc99e Initial load
duke
parents:
diff changeset
114 _verbose = true;
a61af66fc99e Initial load
duke
parents:
diff changeset
115 _print_cr = print_cr;
a61af66fc99e Initial load
duke
parents:
diff changeset
116 _logfile = (logfile != NULL) ? logfile : tty;
a61af66fc99e Initial load
duke
parents:
diff changeset
117
a61af66fc99e Initial load
duke
parents:
diff changeset
118 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
119 _accum = NULL;
a61af66fc99e Initial load
duke
parents:
diff changeset
120 if (PrintGCTimeStamps) {
a61af66fc99e Initial load
duke
parents:
diff changeset
121 _logfile->stamp();
a61af66fc99e Initial load
duke
parents:
diff changeset
122 _logfile->print(": ");
a61af66fc99e Initial load
duke
parents:
diff changeset
123 }
a61af66fc99e Initial load
duke
parents:
diff changeset
124 _logfile->print("[%s", title);
a61af66fc99e Initial load
duke
parents:
diff changeset
125 _logfile->flush();
a61af66fc99e Initial load
duke
parents:
diff changeset
126 _t.start();
a61af66fc99e Initial load
duke
parents:
diff changeset
127 }
a61af66fc99e Initial load
duke
parents:
diff changeset
128 }
a61af66fc99e Initial load
duke
parents:
diff changeset
129
a61af66fc99e Initial load
duke
parents:
diff changeset
130 TraceTime::TraceTime(const char* title,
a61af66fc99e Initial load
duke
parents:
diff changeset
131 elapsedTimer* accumulator,
a61af66fc99e Initial load
duke
parents:
diff changeset
132 bool doit,
a61af66fc99e Initial load
duke
parents:
diff changeset
133 bool verbose,
a61af66fc99e Initial load
duke
parents:
diff changeset
134 outputStream* logfile) {
a61af66fc99e Initial load
duke
parents:
diff changeset
135 _active = doit;
a61af66fc99e Initial load
duke
parents:
diff changeset
136 _verbose = verbose;
a61af66fc99e Initial load
duke
parents:
diff changeset
137 _print_cr = true;
a61af66fc99e Initial load
duke
parents:
diff changeset
138 _logfile = (logfile != NULL) ? logfile : tty;
a61af66fc99e Initial load
duke
parents:
diff changeset
139 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
140 if (_verbose) {
a61af66fc99e Initial load
duke
parents:
diff changeset
141 if (PrintGCTimeStamps) {
a61af66fc99e Initial load
duke
parents:
diff changeset
142 _logfile->stamp();
a61af66fc99e Initial load
duke
parents:
diff changeset
143 _logfile->print(": ");
a61af66fc99e Initial load
duke
parents:
diff changeset
144 }
a61af66fc99e Initial load
duke
parents:
diff changeset
145 _logfile->print("[%s", title);
a61af66fc99e Initial load
duke
parents:
diff changeset
146 _logfile->flush();
a61af66fc99e Initial load
duke
parents:
diff changeset
147 }
a61af66fc99e Initial load
duke
parents:
diff changeset
148 _accum = accumulator;
a61af66fc99e Initial load
duke
parents:
diff changeset
149 _t.start();
a61af66fc99e Initial load
duke
parents:
diff changeset
150 }
a61af66fc99e Initial load
duke
parents:
diff changeset
151 }
a61af66fc99e Initial load
duke
parents:
diff changeset
152
a61af66fc99e Initial load
duke
parents:
diff changeset
153 TraceTime::~TraceTime() {
a61af66fc99e Initial load
duke
parents:
diff changeset
154 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
155 _t.stop();
a61af66fc99e Initial load
duke
parents:
diff changeset
156 if (_accum!=NULL) _accum->add(_t);
a61af66fc99e Initial load
duke
parents:
diff changeset
157 if (_verbose) {
a61af66fc99e Initial load
duke
parents:
diff changeset
158 if (_print_cr) {
a61af66fc99e Initial load
duke
parents:
diff changeset
159 _logfile->print_cr(", %3.7f secs]", _t.seconds());
a61af66fc99e Initial load
duke
parents:
diff changeset
160 } else {
a61af66fc99e Initial load
duke
parents:
diff changeset
161 _logfile->print(", %3.7f secs]", _t.seconds());
a61af66fc99e Initial load
duke
parents:
diff changeset
162 }
a61af66fc99e Initial load
duke
parents:
diff changeset
163 _logfile->flush();
a61af66fc99e Initial load
duke
parents:
diff changeset
164 }
a61af66fc99e Initial load
duke
parents:
diff changeset
165 }
a61af66fc99e Initial load
duke
parents:
diff changeset
166 }
a61af66fc99e Initial load
duke
parents:
diff changeset
167
a61af66fc99e Initial load
duke
parents:
diff changeset
168 TraceCPUTime::TraceCPUTime(bool doit,
a61af66fc99e Initial load
duke
parents:
diff changeset
169 bool print_cr,
a61af66fc99e Initial load
duke
parents:
diff changeset
170 outputStream *logfile) :
a61af66fc99e Initial load
duke
parents:
diff changeset
171 _active(doit),
a61af66fc99e Initial load
duke
parents:
diff changeset
172 _print_cr(print_cr),
a61af66fc99e Initial load
duke
parents:
diff changeset
173 _starting_user_time(0.0),
a61af66fc99e Initial load
duke
parents:
diff changeset
174 _starting_system_time(0.0),
a61af66fc99e Initial load
duke
parents:
diff changeset
175 _starting_real_time(0.0),
a61af66fc99e Initial load
duke
parents:
diff changeset
176 _logfile(logfile),
a61af66fc99e Initial load
duke
parents:
diff changeset
177 _error(false) {
a61af66fc99e Initial load
duke
parents:
diff changeset
178 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
179 if (logfile != NULL) {
a61af66fc99e Initial load
duke
parents:
diff changeset
180 _logfile = logfile;
a61af66fc99e Initial load
duke
parents:
diff changeset
181 } else {
a61af66fc99e Initial load
duke
parents:
diff changeset
182 _logfile = tty;
a61af66fc99e Initial load
duke
parents:
diff changeset
183 }
a61af66fc99e Initial load
duke
parents:
diff changeset
184
a61af66fc99e Initial load
duke
parents:
diff changeset
185 _error = !os::getTimesSecs(&_starting_real_time,
a61af66fc99e Initial load
duke
parents:
diff changeset
186 &_starting_user_time,
a61af66fc99e Initial load
duke
parents:
diff changeset
187 &_starting_system_time);
a61af66fc99e Initial load
duke
parents:
diff changeset
188 }
a61af66fc99e Initial load
duke
parents:
diff changeset
189 }
a61af66fc99e Initial load
duke
parents:
diff changeset
190
a61af66fc99e Initial load
duke
parents:
diff changeset
191 TraceCPUTime::~TraceCPUTime() {
a61af66fc99e Initial load
duke
parents:
diff changeset
192 if (_active) {
a61af66fc99e Initial load
duke
parents:
diff changeset
193 bool valid = false;
a61af66fc99e Initial load
duke
parents:
diff changeset
194 if (!_error) {
a61af66fc99e Initial load
duke
parents:
diff changeset
195 double real_secs; // walk clock time
a61af66fc99e Initial load
duke
parents:
diff changeset
196 double system_secs; // system time
a61af66fc99e Initial load
duke
parents:
diff changeset
197 double user_secs; // user time for all threads
a61af66fc99e Initial load
duke
parents:
diff changeset
198
a61af66fc99e Initial load
duke
parents:
diff changeset
199 double real_time, user_time, system_time;
a61af66fc99e Initial load
duke
parents:
diff changeset
200 valid = os::getTimesSecs(&real_time, &user_time, &system_time);
a61af66fc99e Initial load
duke
parents:
diff changeset
201 if (valid) {
a61af66fc99e Initial load
duke
parents:
diff changeset
202
a61af66fc99e Initial load
duke
parents:
diff changeset
203 user_secs = user_time - _starting_user_time;
a61af66fc99e Initial load
duke
parents:
diff changeset
204 system_secs = system_time - _starting_system_time;
a61af66fc99e Initial load
duke
parents:
diff changeset
205 real_secs = real_time - _starting_real_time;
a61af66fc99e Initial load
duke
parents:
diff changeset
206
a61af66fc99e Initial load
duke
parents:
diff changeset
207 _logfile->print(" [Times: user=%3.2f sys=%3.2f, real=%3.2f secs] ",
a61af66fc99e Initial load
duke
parents:
diff changeset
208 user_secs, system_secs, real_secs);
a61af66fc99e Initial load
duke
parents:
diff changeset
209
a61af66fc99e Initial load
duke
parents:
diff changeset
210 } else {
a61af66fc99e Initial load
duke
parents:
diff changeset
211 _logfile->print("[Invalid result in TraceCPUTime]");
a61af66fc99e Initial load
duke
parents:
diff changeset
212 }
a61af66fc99e Initial load
duke
parents:
diff changeset
213 } else {
a61af66fc99e Initial load
duke
parents:
diff changeset
214 _logfile->print("[Error in TraceCPUTime]");
a61af66fc99e Initial load
duke
parents:
diff changeset
215 }
a61af66fc99e Initial load
duke
parents:
diff changeset
216 if (_print_cr) {
a61af66fc99e Initial load
duke
parents:
diff changeset
217 _logfile->print_cr("");
a61af66fc99e Initial load
duke
parents:
diff changeset
218 }
a61af66fc99e Initial load
duke
parents:
diff changeset
219 }
a61af66fc99e Initial load
duke
parents:
diff changeset
220 }