src/share/vm/runtime/fprofiler.cpp

Fri, 27 Feb 2009 13:27:09 -0800

author
twisti
date
Fri, 27 Feb 2009 13:27:09 -0800
changeset 1040
98cb887364d3
parent 631
d1605aabd0a1
child 1907
c18cbe5936b8
permissions
-rw-r--r--

6810672: Comment typos
Summary: I have collected some typos I have found while looking at the code.
Reviewed-by: kvn, never

duke@435 1 /*
xdono@631 2 * Copyright 1997-2008 Sun Microsystems, Inc. All Rights Reserved.
duke@435 3 * DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER.
duke@435 4 *
duke@435 5 * This code is free software; you can redistribute it and/or modify it
duke@435 6 * under the terms of the GNU General Public License version 2 only, as
duke@435 7 * published by the Free Software Foundation.
duke@435 8 *
duke@435 9 * This code is distributed in the hope that it will be useful, but WITHOUT
duke@435 10 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
duke@435 11 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License
duke@435 12 * version 2 for more details (a copy is included in the LICENSE file that
duke@435 13 * accompanied this code).
duke@435 14 *
duke@435 15 * You should have received a copy of the GNU General Public License version
duke@435 16 * 2 along with this work; if not, write to the Free Software Foundation,
duke@435 17 * Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA.
duke@435 18 *
duke@435 19 * Please contact Sun Microsystems, Inc., 4150 Network Circle, Santa Clara,
duke@435 20 * CA 95054 USA or visit www.sun.com if you need additional information or
duke@435 21 * have any questions.
duke@435 22 *
duke@435 23 */
duke@435 24
duke@435 25 # include "incls/_precompiled.incl"
duke@435 26 # include "incls/_fprofiler.cpp.incl"
duke@435 27
duke@435 28 // Static fields of FlatProfiler
duke@435 29 int FlatProfiler::received_gc_ticks = 0;
duke@435 30 int FlatProfiler::vm_operation_ticks = 0;
duke@435 31 int FlatProfiler::threads_lock_ticks = 0;
duke@435 32 int FlatProfiler::class_loader_ticks = 0;
duke@435 33 int FlatProfiler::extra_ticks = 0;
duke@435 34 int FlatProfiler::blocked_ticks = 0;
duke@435 35 int FlatProfiler::deopt_ticks = 0;
duke@435 36 int FlatProfiler::unknown_ticks = 0;
duke@435 37 int FlatProfiler::interpreter_ticks = 0;
duke@435 38 int FlatProfiler::compiler_ticks = 0;
duke@435 39 int FlatProfiler::received_ticks = 0;
duke@435 40 int FlatProfiler::delivered_ticks = 0;
duke@435 41 int* FlatProfiler::bytecode_ticks = NULL;
duke@435 42 int* FlatProfiler::bytecode_ticks_stub = NULL;
duke@435 43 int FlatProfiler::all_int_ticks = 0;
duke@435 44 int FlatProfiler::all_comp_ticks = 0;
duke@435 45 int FlatProfiler::all_ticks = 0;
duke@435 46 bool FlatProfiler::full_profile_flag = false;
duke@435 47 ThreadProfiler* FlatProfiler::thread_profiler = NULL;
duke@435 48 ThreadProfiler* FlatProfiler::vm_thread_profiler = NULL;
duke@435 49 FlatProfilerTask* FlatProfiler::task = NULL;
duke@435 50 elapsedTimer FlatProfiler::timer;
duke@435 51 int FlatProfiler::interval_ticks_previous = 0;
duke@435 52 IntervalData* FlatProfiler::interval_data = NULL;
duke@435 53
duke@435 54 ThreadProfiler::ThreadProfiler() {
duke@435 55 // Space for the ProfilerNodes
duke@435 56 const int area_size = 1 * ProfilerNodeSize * 1024;
duke@435 57 area_bottom = AllocateHeap(area_size, "fprofiler");
duke@435 58 area_top = area_bottom;
duke@435 59 area_limit = area_bottom + area_size;
duke@435 60
duke@435 61 // ProfilerNode pointer table
duke@435 62 table = NEW_C_HEAP_ARRAY(ProfilerNode*, table_size);
duke@435 63 initialize();
duke@435 64 engaged = false;
duke@435 65 }
duke@435 66
duke@435 67 ThreadProfiler::~ThreadProfiler() {
duke@435 68 FreeHeap(area_bottom);
duke@435 69 area_bottom = NULL;
duke@435 70 area_top = NULL;
duke@435 71 area_limit = NULL;
duke@435 72 FreeHeap(table);
duke@435 73 table = NULL;
duke@435 74 }
duke@435 75
duke@435 76 // Statics for ThreadProfiler
duke@435 77 int ThreadProfiler::table_size = 1024;
duke@435 78
duke@435 79 int ThreadProfiler::entry(int value) {
duke@435 80 value = (value > 0) ? value : -value;
duke@435 81 return value % table_size;
duke@435 82 }
duke@435 83
duke@435 84 ThreadProfilerMark::ThreadProfilerMark(ThreadProfilerMark::Region r) {
duke@435 85 _r = r;
duke@435 86 _pp = NULL;
duke@435 87 assert(((r > ThreadProfilerMark::noRegion) && (r < ThreadProfilerMark::maxRegion)), "ThreadProfilerMark::Region out of bounds");
duke@435 88 Thread* tp = Thread::current();
duke@435 89 if (tp != NULL && tp->is_Java_thread()) {
duke@435 90 JavaThread* jtp = (JavaThread*) tp;
duke@435 91 ThreadProfiler* pp = jtp->get_thread_profiler();
duke@435 92 _pp = pp;
duke@435 93 if (pp != NULL) {
duke@435 94 pp->region_flag[r] = true;
duke@435 95 }
duke@435 96 }
duke@435 97 }
duke@435 98
duke@435 99 ThreadProfilerMark::~ThreadProfilerMark() {
duke@435 100 if (_pp != NULL) {
duke@435 101 _pp->region_flag[_r] = false;
duke@435 102 }
duke@435 103 _pp = NULL;
duke@435 104 }
duke@435 105
duke@435 106 // Random other statics
duke@435 107 static const int col1 = 2; // position of output column 1
duke@435 108 static const int col2 = 11; // position of output column 2
duke@435 109 static const int col3 = 25; // position of output column 3
duke@435 110 static const int col4 = 55; // position of output column 4
duke@435 111
duke@435 112
duke@435 113 // Used for detailed profiling of nmethods.
duke@435 114 class PCRecorder : AllStatic {
duke@435 115 private:
duke@435 116 static int* counters;
duke@435 117 static address base;
duke@435 118 enum {
duke@435 119 bucket_size = 16
duke@435 120 };
duke@435 121 static int index_for(address pc) { return (pc - base)/bucket_size; }
duke@435 122 static address pc_for(int index) { return base + (index * bucket_size); }
duke@435 123 static int size() {
duke@435 124 return ((int)CodeCache::max_capacity())/bucket_size * BytesPerWord;
duke@435 125 }
duke@435 126 public:
duke@435 127 static address bucket_start_for(address pc) {
duke@435 128 if (counters == NULL) return NULL;
duke@435 129 return pc_for(index_for(pc));
duke@435 130 }
duke@435 131 static int bucket_count_for(address pc) { return counters[index_for(pc)]; }
duke@435 132 static void init();
duke@435 133 static void record(address pc);
duke@435 134 static void print();
duke@435 135 static void print_blobs(CodeBlob* cb);
duke@435 136 };
duke@435 137
duke@435 138 int* PCRecorder::counters = NULL;
duke@435 139 address PCRecorder::base = NULL;
duke@435 140
duke@435 141 void PCRecorder::init() {
duke@435 142 MutexLockerEx lm(CodeCache_lock, Mutex::_no_safepoint_check_flag);
duke@435 143 int s = size();
duke@435 144 counters = NEW_C_HEAP_ARRAY(int, s);
duke@435 145 for (int index = 0; index < s; index++) {
duke@435 146 counters[index] = 0;
duke@435 147 }
duke@435 148 base = CodeCache::first_address();
duke@435 149 }
duke@435 150
duke@435 151 void PCRecorder::record(address pc) {
duke@435 152 if (counters == NULL) return;
duke@435 153 assert(CodeCache::contains(pc), "must be in CodeCache");
duke@435 154 counters[index_for(pc)]++;
duke@435 155 }
duke@435 156
duke@435 157
duke@435 158 address FlatProfiler::bucket_start_for(address pc) {
duke@435 159 return PCRecorder::bucket_start_for(pc);
duke@435 160 }
duke@435 161
duke@435 162 int FlatProfiler::bucket_count_for(address pc) {
duke@435 163 return PCRecorder::bucket_count_for(pc);
duke@435 164 }
duke@435 165
duke@435 166 void PCRecorder::print() {
duke@435 167 if (counters == NULL) return;
duke@435 168
duke@435 169 tty->cr();
duke@435 170 tty->print_cr("Printing compiled methods with PC buckets having more than %d ticks", ProfilerPCTickThreshold);
duke@435 171 tty->print_cr("===================================================================");
duke@435 172 tty->cr();
duke@435 173
duke@435 174 GrowableArray<CodeBlob*>* candidates = new GrowableArray<CodeBlob*>(20);
duke@435 175
duke@435 176
duke@435 177 int s;
duke@435 178 {
duke@435 179 MutexLockerEx lm(CodeCache_lock, Mutex::_no_safepoint_check_flag);
duke@435 180 s = size();
duke@435 181 }
duke@435 182
duke@435 183 for (int index = 0; index < s; index++) {
duke@435 184 int count = counters[index];
duke@435 185 if (count > ProfilerPCTickThreshold) {
duke@435 186 address pc = pc_for(index);
duke@435 187 CodeBlob* cb = CodeCache::find_blob_unsafe(pc);
duke@435 188 if (cb != NULL && candidates->find(cb) < 0) {
duke@435 189 candidates->push(cb);
duke@435 190 }
duke@435 191 }
duke@435 192 }
duke@435 193 for (int i = 0; i < candidates->length(); i++) {
duke@435 194 print_blobs(candidates->at(i));
duke@435 195 }
duke@435 196 }
duke@435 197
duke@435 198 void PCRecorder::print_blobs(CodeBlob* cb) {
duke@435 199 if (cb != NULL) {
duke@435 200 cb->print();
duke@435 201 if (cb->is_nmethod()) {
duke@435 202 ((nmethod*)cb)->print_code();
duke@435 203 }
duke@435 204 tty->cr();
duke@435 205 } else {
duke@435 206 tty->print_cr("stub code");
duke@435 207 }
duke@435 208 }
duke@435 209
duke@435 210 class tick_counter { // holds tick info for one node
duke@435 211 public:
duke@435 212 int ticks_in_code;
duke@435 213 int ticks_in_native;
duke@435 214
duke@435 215 tick_counter() { ticks_in_code = ticks_in_native = 0; }
duke@435 216 tick_counter(int code, int native) { ticks_in_code = code; ticks_in_native = native; }
duke@435 217
duke@435 218 int total() const {
duke@435 219 return (ticks_in_code + ticks_in_native);
duke@435 220 }
duke@435 221
duke@435 222 void add(tick_counter* a) {
duke@435 223 ticks_in_code += a->ticks_in_code;
duke@435 224 ticks_in_native += a->ticks_in_native;
duke@435 225 }
duke@435 226
duke@435 227 void update(TickPosition where) {
duke@435 228 switch(where) {
duke@435 229 case tp_code: ticks_in_code++; break;
duke@435 230 case tp_native: ticks_in_native++; break;
duke@435 231 }
duke@435 232 }
duke@435 233
duke@435 234 void print_code(outputStream* st, int total_ticks) {
duke@435 235 st->print("%5.1f%% %5d ", total() * 100.0 / total_ticks, ticks_in_code);
duke@435 236 }
duke@435 237
duke@435 238 void print_native(outputStream* st) {
duke@435 239 st->print(" + %5d ", ticks_in_native);
duke@435 240 }
duke@435 241 };
duke@435 242
duke@435 243 class ProfilerNode {
duke@435 244 private:
duke@435 245 ProfilerNode* _next;
duke@435 246 public:
duke@435 247 tick_counter ticks;
duke@435 248
duke@435 249 public:
duke@435 250
duke@435 251 void* operator new(size_t size, ThreadProfiler* tp);
duke@435 252 void operator delete(void* p);
duke@435 253
duke@435 254 ProfilerNode() {
duke@435 255 _next = NULL;
duke@435 256 }
duke@435 257
duke@435 258 virtual ~ProfilerNode() {
duke@435 259 if (_next)
duke@435 260 delete _next;
duke@435 261 }
duke@435 262
duke@435 263 void set_next(ProfilerNode* n) { _next = n; }
duke@435 264 ProfilerNode* next() { return _next; }
duke@435 265
duke@435 266 void update(TickPosition where) { ticks.update(where);}
duke@435 267 int total_ticks() { return ticks.total(); }
duke@435 268
duke@435 269 virtual bool is_interpreted() const { return false; }
duke@435 270 virtual bool is_compiled() const { return false; }
duke@435 271 virtual bool is_stub() const { return false; }
duke@435 272 virtual bool is_runtime_stub() const{ return false; }
duke@435 273 virtual void oops_do(OopClosure* f) = 0;
duke@435 274
duke@435 275 virtual bool interpreted_match(methodOop m) const { return false; }
duke@435 276 virtual bool compiled_match(methodOop m ) const { return false; }
duke@435 277 virtual bool stub_match(methodOop m, const char* name) const { return false; }
duke@435 278 virtual bool adapter_match() const { return false; }
duke@435 279 virtual bool runtimeStub_match(const CodeBlob* stub, const char* name) const { return false; }
duke@435 280 virtual bool unknown_compiled_match(const CodeBlob* cb) const { return false; }
duke@435 281
duke@435 282 static void print_title(outputStream* st) {
duke@435 283 st->print(" + native");
duke@435 284 st->fill_to(col3);
duke@435 285 st->print("Method");
duke@435 286 st->fill_to(col4);
duke@435 287 st->cr();
duke@435 288 }
duke@435 289
duke@435 290 static void print_total(outputStream* st, tick_counter* t, int total, const char* msg) {
duke@435 291 t->print_code(st, total);
duke@435 292 st->fill_to(col2);
duke@435 293 t->print_native(st);
duke@435 294 st->fill_to(col3);
duke@435 295 st->print(msg);
duke@435 296 st->cr();
duke@435 297 }
duke@435 298
duke@435 299 virtual methodOop method() = 0;
duke@435 300
duke@435 301 virtual void print_method_on(outputStream* st) {
duke@435 302 int limit;
duke@435 303 int i;
duke@435 304 methodOop m = method();
duke@435 305 symbolOop k = m->klass_name();
duke@435 306 // Print the class name with dots instead of slashes
duke@435 307 limit = k->utf8_length();
duke@435 308 for (i = 0 ; i < limit ; i += 1) {
duke@435 309 char c = (char) k->byte_at(i);
duke@435 310 if (c == '/') {
duke@435 311 c = '.';
duke@435 312 }
duke@435 313 st->print("%c", c);
duke@435 314 }
duke@435 315 if (limit > 0) {
duke@435 316 st->print(".");
duke@435 317 }
duke@435 318 symbolOop n = m->name();
duke@435 319 limit = n->utf8_length();
duke@435 320 for (i = 0 ; i < limit ; i += 1) {
duke@435 321 char c = (char) n->byte_at(i);
duke@435 322 st->print("%c", c);
duke@435 323 }
duke@435 324 if( Verbose ) {
duke@435 325 // Disambiguate overloaded methods
duke@435 326 symbolOop sig = m->signature();
duke@435 327 sig->print_symbol_on(st);
duke@435 328 }
duke@435 329 }
duke@435 330
duke@435 331 virtual void print(outputStream* st, int total_ticks) {
duke@435 332 ticks.print_code(st, total_ticks);
duke@435 333 st->fill_to(col2);
duke@435 334 ticks.print_native(st);
duke@435 335 st->fill_to(col3);
duke@435 336 print_method_on(st);
duke@435 337 st->cr();
duke@435 338 }
duke@435 339
duke@435 340 // for hashing into the table
duke@435 341 static int hash(methodOop method) {
duke@435 342 // The point here is to try to make something fairly unique
duke@435 343 // out of the fields we can read without grabbing any locks
duke@435 344 // since the method may be locked when we need the hash.
duke@435 345 return (
duke@435 346 method->code_size() ^
duke@435 347 method->max_stack() ^
duke@435 348 method->max_locals() ^
duke@435 349 method->size_of_parameters());
duke@435 350 }
duke@435 351
duke@435 352 // for sorting
duke@435 353 static int compare(ProfilerNode** a, ProfilerNode** b) {
duke@435 354 return (*b)->total_ticks() - (*a)->total_ticks();
duke@435 355 }
duke@435 356 };
duke@435 357
duke@435 358 void* ProfilerNode::operator new(size_t size, ThreadProfiler* tp){
duke@435 359 void* result = (void*) tp->area_top;
duke@435 360 tp->area_top += size;
duke@435 361
duke@435 362 if (tp->area_top > tp->area_limit) {
duke@435 363 fatal("flat profiler buffer overflow");
duke@435 364 }
duke@435 365 return result;
duke@435 366 }
duke@435 367
duke@435 368 void ProfilerNode::operator delete(void* p){
duke@435 369 }
duke@435 370
duke@435 371 class interpretedNode : public ProfilerNode {
duke@435 372 private:
duke@435 373 methodOop _method;
duke@435 374 public:
duke@435 375 interpretedNode(methodOop method, TickPosition where) : ProfilerNode() {
duke@435 376 _method = method;
duke@435 377 update(where);
duke@435 378 }
duke@435 379
duke@435 380 bool is_interpreted() const { return true; }
duke@435 381
duke@435 382 bool interpreted_match(methodOop m) const {
duke@435 383 return _method == m;
duke@435 384 }
duke@435 385
duke@435 386 void oops_do(OopClosure* f) {
duke@435 387 f->do_oop((oop*)&_method);
duke@435 388 }
duke@435 389
duke@435 390 methodOop method() { return _method; }
duke@435 391
duke@435 392 static void print_title(outputStream* st) {
duke@435 393 st->fill_to(col1);
duke@435 394 st->print("%11s", "Interpreted");
duke@435 395 ProfilerNode::print_title(st);
duke@435 396 }
duke@435 397
duke@435 398 void print(outputStream* st, int total_ticks) {
duke@435 399 ProfilerNode::print(st, total_ticks);
duke@435 400 }
duke@435 401
duke@435 402 void print_method_on(outputStream* st) {
duke@435 403 ProfilerNode::print_method_on(st);
duke@435 404 if (Verbose) method()->invocation_counter()->print_short();
duke@435 405 }
duke@435 406 };
duke@435 407
duke@435 408 class compiledNode : public ProfilerNode {
duke@435 409 private:
duke@435 410 methodOop _method;
duke@435 411 public:
duke@435 412 compiledNode(methodOop method, TickPosition where) : ProfilerNode() {
duke@435 413 _method = method;
duke@435 414 update(where);
duke@435 415 }
duke@435 416 bool is_compiled() const { return true; }
duke@435 417
duke@435 418 bool compiled_match(methodOop m) const {
duke@435 419 return _method == m;
duke@435 420 }
duke@435 421
duke@435 422 methodOop method() { return _method; }
duke@435 423
duke@435 424 void oops_do(OopClosure* f) {
duke@435 425 f->do_oop((oop*)&_method);
duke@435 426 }
duke@435 427
duke@435 428 static void print_title(outputStream* st) {
duke@435 429 st->fill_to(col1);
duke@435 430 st->print("%11s", "Compiled");
duke@435 431 ProfilerNode::print_title(st);
duke@435 432 }
duke@435 433
duke@435 434 void print(outputStream* st, int total_ticks) {
duke@435 435 ProfilerNode::print(st, total_ticks);
duke@435 436 }
duke@435 437
duke@435 438 void print_method_on(outputStream* st) {
duke@435 439 ProfilerNode::print_method_on(st);
duke@435 440 }
duke@435 441 };
duke@435 442
duke@435 443 class stubNode : public ProfilerNode {
duke@435 444 private:
duke@435 445 methodOop _method;
duke@435 446 const char* _symbol; // The name of the nearest VM symbol (for +ProfileVM). Points to a unique string
duke@435 447 public:
duke@435 448 stubNode(methodOop method, const char* name, TickPosition where) : ProfilerNode() {
duke@435 449 _method = method;
duke@435 450 _symbol = name;
duke@435 451 update(where);
duke@435 452 }
duke@435 453
duke@435 454 bool is_stub() const { return true; }
duke@435 455
duke@435 456 bool stub_match(methodOop m, const char* name) const {
duke@435 457 return (_method == m) && (_symbol == name);
duke@435 458 }
duke@435 459
duke@435 460 void oops_do(OopClosure* f) {
duke@435 461 f->do_oop((oop*)&_method);
duke@435 462 }
duke@435 463
duke@435 464 methodOop method() { return _method; }
duke@435 465
duke@435 466 static void print_title(outputStream* st) {
duke@435 467 st->fill_to(col1);
duke@435 468 st->print("%11s", "Stub");
duke@435 469 ProfilerNode::print_title(st);
duke@435 470 }
duke@435 471
duke@435 472 void print(outputStream* st, int total_ticks) {
duke@435 473 ProfilerNode::print(st, total_ticks);
duke@435 474 }
duke@435 475
duke@435 476 void print_method_on(outputStream* st) {
duke@435 477 ProfilerNode::print_method_on(st);
duke@435 478 print_symbol_on(st);
duke@435 479 }
duke@435 480
duke@435 481 void print_symbol_on(outputStream* st) {
duke@435 482 if(_symbol) {
duke@435 483 st->print(" (%s)", _symbol);
duke@435 484 }
duke@435 485 }
duke@435 486 };
duke@435 487
duke@435 488 class adapterNode : public ProfilerNode {
duke@435 489 public:
duke@435 490 adapterNode(TickPosition where) : ProfilerNode() {
duke@435 491 update(where);
duke@435 492 }
duke@435 493 bool is_compiled() const { return true; }
duke@435 494
duke@435 495 bool adapter_match() const { return true; }
duke@435 496
duke@435 497 methodOop method() { return NULL; }
duke@435 498
duke@435 499 void oops_do(OopClosure* f) {
duke@435 500 ;
duke@435 501 }
duke@435 502
duke@435 503 void print(outputStream* st, int total_ticks) {
duke@435 504 ProfilerNode::print(st, total_ticks);
duke@435 505 }
duke@435 506
duke@435 507 void print_method_on(outputStream* st) {
duke@435 508 st->print("%s", "adapters");
duke@435 509 }
duke@435 510 };
duke@435 511
duke@435 512 class runtimeStubNode : public ProfilerNode {
duke@435 513 private:
duke@435 514 const CodeBlob* _stub;
duke@435 515 const char* _symbol; // The name of the nearest VM symbol when ProfileVM is on. Points to a unique string.
duke@435 516 public:
duke@435 517 runtimeStubNode(const CodeBlob* stub, const char* name, TickPosition where) : ProfilerNode(), _stub(stub), _symbol(name) {
duke@435 518 assert(stub->is_runtime_stub(), "wrong code blob");
duke@435 519 update(where);
duke@435 520 }
duke@435 521
duke@435 522 bool is_runtime_stub() const { return true; }
duke@435 523
duke@435 524 bool runtimeStub_match(const CodeBlob* stub, const char* name) const {
duke@435 525 assert(stub->is_runtime_stub(), "wrong code blob");
duke@435 526 return ((RuntimeStub*)_stub)->entry_point() == ((RuntimeStub*)stub)->entry_point() &&
duke@435 527 (_symbol == name);
duke@435 528 }
duke@435 529
duke@435 530 methodOop method() { return NULL; }
duke@435 531
duke@435 532 static void print_title(outputStream* st) {
duke@435 533 st->fill_to(col1);
duke@435 534 st->print("%11s", "Runtime stub");
duke@435 535 ProfilerNode::print_title(st);
duke@435 536 }
duke@435 537
duke@435 538 void oops_do(OopClosure* f) {
duke@435 539 ;
duke@435 540 }
duke@435 541
duke@435 542 void print(outputStream* st, int total_ticks) {
duke@435 543 ProfilerNode::print(st, total_ticks);
duke@435 544 }
duke@435 545
duke@435 546 void print_method_on(outputStream* st) {
duke@435 547 st->print("%s", ((RuntimeStub*)_stub)->name());
duke@435 548 print_symbol_on(st);
duke@435 549 }
duke@435 550
duke@435 551 void print_symbol_on(outputStream* st) {
duke@435 552 if(_symbol) {
duke@435 553 st->print(" (%s)", _symbol);
duke@435 554 }
duke@435 555 }
duke@435 556 };
duke@435 557
duke@435 558
duke@435 559 class unknown_compiledNode : public ProfilerNode {
duke@435 560 const char *_name;
duke@435 561 public:
duke@435 562 unknown_compiledNode(const CodeBlob* cb, TickPosition where) : ProfilerNode() {
duke@435 563 if ( cb->is_buffer_blob() )
duke@435 564 _name = ((BufferBlob*)cb)->name();
duke@435 565 else
duke@435 566 _name = ((SingletonBlob*)cb)->name();
duke@435 567 update(where);
duke@435 568 }
duke@435 569 bool is_compiled() const { return true; }
duke@435 570
duke@435 571 bool unknown_compiled_match(const CodeBlob* cb) const {
duke@435 572 if ( cb->is_buffer_blob() )
duke@435 573 return !strcmp(((BufferBlob*)cb)->name(), _name);
duke@435 574 else
duke@435 575 return !strcmp(((SingletonBlob*)cb)->name(), _name);
duke@435 576 }
duke@435 577
duke@435 578 methodOop method() { return NULL; }
duke@435 579
duke@435 580 void oops_do(OopClosure* f) {
duke@435 581 ;
duke@435 582 }
duke@435 583
duke@435 584 void print(outputStream* st, int total_ticks) {
duke@435 585 ProfilerNode::print(st, total_ticks);
duke@435 586 }
duke@435 587
duke@435 588 void print_method_on(outputStream* st) {
duke@435 589 st->print("%s", _name);
duke@435 590 }
duke@435 591 };
duke@435 592
duke@435 593 class vmNode : public ProfilerNode {
duke@435 594 private:
duke@435 595 const char* _name; // "optional" name obtained by os means such as dll lookup
duke@435 596 public:
duke@435 597 vmNode(const TickPosition where) : ProfilerNode() {
duke@435 598 _name = NULL;
duke@435 599 update(where);
duke@435 600 }
duke@435 601
duke@435 602 vmNode(const char* name, const TickPosition where) : ProfilerNode() {
duke@435 603 _name = name;
duke@435 604 update(where);
duke@435 605 }
duke@435 606
duke@435 607 const char *name() const { return _name; }
duke@435 608 bool is_compiled() const { return true; }
duke@435 609
duke@435 610 bool vm_match(const char* name) const { return strcmp(name, _name) == 0; }
duke@435 611
duke@435 612 methodOop method() { return NULL; }
duke@435 613
duke@435 614 static int hash(const char* name){
duke@435 615 // Compute a simple hash
duke@435 616 const char* cp = name;
duke@435 617 int h = 0;
duke@435 618
duke@435 619 if(name != NULL){
duke@435 620 while(*cp != '\0'){
duke@435 621 h = (h << 1) ^ *cp;
duke@435 622 cp++;
duke@435 623 }
duke@435 624 }
duke@435 625 return h;
duke@435 626 }
duke@435 627
duke@435 628 void oops_do(OopClosure* f) {
duke@435 629 ;
duke@435 630 }
duke@435 631
duke@435 632 void print(outputStream* st, int total_ticks) {
duke@435 633 ProfilerNode::print(st, total_ticks);
duke@435 634 }
duke@435 635
duke@435 636 void print_method_on(outputStream* st) {
duke@435 637 if(_name==NULL){
duke@435 638 st->print("%s", "unknown code");
duke@435 639 }
duke@435 640 else {
duke@435 641 st->print("%s", _name);
duke@435 642 }
duke@435 643 }
duke@435 644 };
duke@435 645
duke@435 646 void ThreadProfiler::interpreted_update(methodOop method, TickPosition where) {
duke@435 647 int index = entry(ProfilerNode::hash(method));
duke@435 648 if (!table[index]) {
duke@435 649 table[index] = new (this) interpretedNode(method, where);
duke@435 650 } else {
duke@435 651 ProfilerNode* prev = table[index];
duke@435 652 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 653 if (node->interpreted_match(method)) {
duke@435 654 node->update(where);
duke@435 655 return;
duke@435 656 }
duke@435 657 prev = node;
duke@435 658 }
duke@435 659 prev->set_next(new (this) interpretedNode(method, where));
duke@435 660 }
duke@435 661 }
duke@435 662
duke@435 663 void ThreadProfiler::compiled_update(methodOop method, TickPosition where) {
duke@435 664 int index = entry(ProfilerNode::hash(method));
duke@435 665 if (!table[index]) {
duke@435 666 table[index] = new (this) compiledNode(method, where);
duke@435 667 } else {
duke@435 668 ProfilerNode* prev = table[index];
duke@435 669 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 670 if (node->compiled_match(method)) {
duke@435 671 node->update(where);
duke@435 672 return;
duke@435 673 }
duke@435 674 prev = node;
duke@435 675 }
duke@435 676 prev->set_next(new (this) compiledNode(method, where));
duke@435 677 }
duke@435 678 }
duke@435 679
duke@435 680 void ThreadProfiler::stub_update(methodOop method, const char* name, TickPosition where) {
duke@435 681 int index = entry(ProfilerNode::hash(method));
duke@435 682 if (!table[index]) {
duke@435 683 table[index] = new (this) stubNode(method, name, where);
duke@435 684 } else {
duke@435 685 ProfilerNode* prev = table[index];
duke@435 686 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 687 if (node->stub_match(method, name)) {
duke@435 688 node->update(where);
duke@435 689 return;
duke@435 690 }
duke@435 691 prev = node;
duke@435 692 }
duke@435 693 prev->set_next(new (this) stubNode(method, name, where));
duke@435 694 }
duke@435 695 }
duke@435 696
duke@435 697 void ThreadProfiler::adapter_update(TickPosition where) {
duke@435 698 int index = 0;
duke@435 699 if (!table[index]) {
duke@435 700 table[index] = new (this) adapterNode(where);
duke@435 701 } else {
duke@435 702 ProfilerNode* prev = table[index];
duke@435 703 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 704 if (node->adapter_match()) {
duke@435 705 node->update(where);
duke@435 706 return;
duke@435 707 }
duke@435 708 prev = node;
duke@435 709 }
duke@435 710 prev->set_next(new (this) adapterNode(where));
duke@435 711 }
duke@435 712 }
duke@435 713
duke@435 714 void ThreadProfiler::runtime_stub_update(const CodeBlob* stub, const char* name, TickPosition where) {
duke@435 715 int index = 0;
duke@435 716 if (!table[index]) {
duke@435 717 table[index] = new (this) runtimeStubNode(stub, name, where);
duke@435 718 } else {
duke@435 719 ProfilerNode* prev = table[index];
duke@435 720 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 721 if (node->runtimeStub_match(stub, name)) {
duke@435 722 node->update(where);
duke@435 723 return;
duke@435 724 }
duke@435 725 prev = node;
duke@435 726 }
duke@435 727 prev->set_next(new (this) runtimeStubNode(stub, name, where));
duke@435 728 }
duke@435 729 }
duke@435 730
duke@435 731
duke@435 732 void ThreadProfiler::unknown_compiled_update(const CodeBlob* cb, TickPosition where) {
duke@435 733 int index = 0;
duke@435 734 if (!table[index]) {
duke@435 735 table[index] = new (this) unknown_compiledNode(cb, where);
duke@435 736 } else {
duke@435 737 ProfilerNode* prev = table[index];
duke@435 738 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 739 if (node->unknown_compiled_match(cb)) {
duke@435 740 node->update(where);
duke@435 741 return;
duke@435 742 }
duke@435 743 prev = node;
duke@435 744 }
duke@435 745 prev->set_next(new (this) unknown_compiledNode(cb, where));
duke@435 746 }
duke@435 747 }
duke@435 748
duke@435 749 void ThreadProfiler::vm_update(TickPosition where) {
duke@435 750 vm_update(NULL, where);
duke@435 751 }
duke@435 752
duke@435 753 void ThreadProfiler::vm_update(const char* name, TickPosition where) {
duke@435 754 int index = entry(vmNode::hash(name));
duke@435 755 assert(index >= 0, "Must be positive");
duke@435 756 // Note that we call strdup below since the symbol may be resource allocated
duke@435 757 if (!table[index]) {
duke@435 758 table[index] = new (this) vmNode(os::strdup(name), where);
duke@435 759 } else {
duke@435 760 ProfilerNode* prev = table[index];
duke@435 761 for(ProfilerNode* node = prev; node; node = node->next()) {
duke@435 762 if (((vmNode *)node)->vm_match(name)) {
duke@435 763 node->update(where);
duke@435 764 return;
duke@435 765 }
duke@435 766 prev = node;
duke@435 767 }
duke@435 768 prev->set_next(new (this) vmNode(os::strdup(name), where));
duke@435 769 }
duke@435 770 }
duke@435 771
duke@435 772
duke@435 773 class FlatProfilerTask : public PeriodicTask {
duke@435 774 public:
duke@435 775 FlatProfilerTask(int interval_time) : PeriodicTask(interval_time) {}
duke@435 776 void task();
duke@435 777 };
duke@435 778
duke@435 779 void FlatProfiler::record_vm_operation() {
duke@435 780 if (Universe::heap()->is_gc_active()) {
duke@435 781 FlatProfiler::received_gc_ticks += 1;
duke@435 782 return;
duke@435 783 }
duke@435 784
duke@435 785 if (DeoptimizationMarker::is_active()) {
duke@435 786 FlatProfiler::deopt_ticks += 1;
duke@435 787 return;
duke@435 788 }
duke@435 789
duke@435 790 FlatProfiler::vm_operation_ticks += 1;
duke@435 791 }
duke@435 792
duke@435 793 void FlatProfiler::record_vm_tick() {
duke@435 794 // Profile the VM Thread itself if needed
duke@435 795 // This is done without getting the Threads_lock and we can go deep
duke@435 796 // inside Safepoint, etc.
duke@435 797 if( ProfileVM ) {
duke@435 798 ResourceMark rm;
duke@435 799 ExtendedPC epc;
duke@435 800 const char *name = NULL;
duke@435 801 char buf[256];
duke@435 802 buf[0] = '\0';
duke@435 803
duke@435 804 vm_thread_profiler->inc_thread_ticks();
duke@435 805
duke@435 806 // Get a snapshot of a current VMThread pc (and leave it running!)
duke@435 807 // The call may fail if, for instance the VM thread is interrupted while
duke@435 808 // holding the Interrupt_lock or for other reasons.
duke@435 809 epc = os::get_thread_pc(VMThread::vm_thread());
duke@435 810 if(epc.pc() != NULL) {
duke@435 811 if (os::dll_address_to_function_name(epc.pc(), buf, sizeof(buf), NULL)) {
duke@435 812 name = buf;
duke@435 813 }
duke@435 814 }
duke@435 815 if (name != NULL) {
duke@435 816 vm_thread_profiler->vm_update(name, tp_native);
duke@435 817 }
duke@435 818 }
duke@435 819 }
duke@435 820
duke@435 821 void FlatProfiler::record_thread_ticks() {
duke@435 822
duke@435 823 int maxthreads, suspendedthreadcount;
duke@435 824 JavaThread** threadsList;
duke@435 825 bool interval_expired = false;
duke@435 826
duke@435 827 if (ProfileIntervals &&
duke@435 828 (FlatProfiler::received_ticks >= interval_ticks_previous + ProfileIntervalsTicks)) {
duke@435 829 interval_expired = true;
duke@435 830 interval_ticks_previous = FlatProfiler::received_ticks;
duke@435 831 }
duke@435 832
duke@435 833 // Try not to wait for the Threads_lock
duke@435 834 if (Threads_lock->try_lock()) {
duke@435 835 { // Threads_lock scope
duke@435 836 maxthreads = Threads::number_of_threads();
duke@435 837 threadsList = NEW_C_HEAP_ARRAY(JavaThread *, maxthreads);
duke@435 838 suspendedthreadcount = 0;
duke@435 839 for (JavaThread* tp = Threads::first(); tp != NULL; tp = tp->next()) {
duke@435 840 if (tp->is_Compiler_thread()) {
duke@435 841 // Only record ticks for active compiler threads
duke@435 842 CompilerThread* cthread = (CompilerThread*)tp;
duke@435 843 if (cthread->task() != NULL) {
duke@435 844 // The compiler is active. If we need to access any of the fields
duke@435 845 // of the compiler task we should suspend the CompilerThread first.
duke@435 846 FlatProfiler::compiler_ticks += 1;
duke@435 847 continue;
duke@435 848 }
duke@435 849 }
duke@435 850
duke@435 851 // First externally suspend all threads by marking each for
duke@435 852 // external suspension - so it will stop at its next transition
duke@435 853 // Then do a safepoint
duke@435 854 ThreadProfiler* pp = tp->get_thread_profiler();
duke@435 855 if (pp != NULL && pp->engaged) {
duke@435 856 MutexLockerEx ml(tp->SR_lock(), Mutex::_no_safepoint_check_flag);
duke@435 857 if (!tp->is_external_suspend() && !tp->is_exiting()) {
duke@435 858 tp->set_external_suspend();
duke@435 859 threadsList[suspendedthreadcount++] = tp;
duke@435 860 }
duke@435 861 }
duke@435 862 }
duke@435 863 Threads_lock->unlock();
duke@435 864 }
duke@435 865 // Suspend each thread. This call should just return
duke@435 866 // for any threads that have already self-suspended
duke@435 867 // Net result should be one safepoint
duke@435 868 for (int j = 0; j < suspendedthreadcount; j++) {
duke@435 869 JavaThread *tp = threadsList[j];
duke@435 870 if (tp) {
duke@435 871 tp->java_suspend();
duke@435 872 }
duke@435 873 }
duke@435 874
duke@435 875 // We are responsible for resuming any thread on this list
duke@435 876 for (int i = 0; i < suspendedthreadcount; i++) {
duke@435 877 JavaThread *tp = threadsList[i];
duke@435 878 if (tp) {
duke@435 879 ThreadProfiler* pp = tp->get_thread_profiler();
duke@435 880 if (pp != NULL && pp->engaged) {
duke@435 881 HandleMark hm;
duke@435 882 FlatProfiler::delivered_ticks += 1;
duke@435 883 if (interval_expired) {
duke@435 884 FlatProfiler::interval_record_thread(pp);
duke@435 885 }
duke@435 886 // This is the place where we check to see if a user thread is
duke@435 887 // blocked waiting for compilation.
duke@435 888 if (tp->blocked_on_compilation()) {
duke@435 889 pp->compiler_ticks += 1;
duke@435 890 pp->interval_data_ref()->inc_compiling();
duke@435 891 } else {
duke@435 892 pp->record_tick(tp);
duke@435 893 }
duke@435 894 }
duke@435 895 MutexLocker ml(Threads_lock);
duke@435 896 tp->java_resume();
duke@435 897 }
duke@435 898 }
duke@435 899 if (interval_expired) {
duke@435 900 FlatProfiler::interval_print();
duke@435 901 FlatProfiler::interval_reset();
duke@435 902 }
duke@435 903 } else {
duke@435 904 // Couldn't get the threads lock, just record that rather than blocking
duke@435 905 FlatProfiler::threads_lock_ticks += 1;
duke@435 906 }
duke@435 907
duke@435 908 }
duke@435 909
duke@435 910 void FlatProfilerTask::task() {
duke@435 911 FlatProfiler::received_ticks += 1;
duke@435 912
duke@435 913 if (ProfileVM) {
duke@435 914 FlatProfiler::record_vm_tick();
duke@435 915 }
duke@435 916
duke@435 917 VM_Operation* op = VMThread::vm_operation();
duke@435 918 if (op != NULL) {
duke@435 919 FlatProfiler::record_vm_operation();
duke@435 920 if (SafepointSynchronize::is_at_safepoint()) {
duke@435 921 return;
duke@435 922 }
duke@435 923 }
duke@435 924 FlatProfiler::record_thread_ticks();
duke@435 925 }
duke@435 926
sgoldman@542 927 void ThreadProfiler::record_interpreted_tick(JavaThread* thread, frame fr, TickPosition where, int* ticks) {
duke@435 928 FlatProfiler::all_int_ticks++;
duke@435 929 if (!FlatProfiler::full_profile()) {
duke@435 930 return;
duke@435 931 }
duke@435 932
sgoldman@542 933 if (!fr.is_interpreted_frame_valid(thread)) {
duke@435 934 // tick came at a bad time
duke@435 935 interpreter_ticks += 1;
duke@435 936 FlatProfiler::interpreter_ticks += 1;
duke@435 937 return;
duke@435 938 }
duke@435 939
sgoldman@542 940 // The frame has been fully validated so we can trust the method and bci
sgoldman@542 941
sgoldman@542 942 methodOop method = *fr.interpreter_frame_method_addr();
sgoldman@542 943
duke@435 944 interpreted_update(method, where);
duke@435 945
duke@435 946 // update byte code table
duke@435 947 InterpreterCodelet* desc = Interpreter::codelet_containing(fr.pc());
duke@435 948 if (desc != NULL && desc->bytecode() >= 0) {
duke@435 949 ticks[desc->bytecode()]++;
duke@435 950 }
duke@435 951 }
duke@435 952
duke@435 953 void ThreadProfiler::record_compiled_tick(JavaThread* thread, frame fr, TickPosition where) {
duke@435 954 const char *name = NULL;
duke@435 955 TickPosition localwhere = where;
duke@435 956
duke@435 957 FlatProfiler::all_comp_ticks++;
duke@435 958 if (!FlatProfiler::full_profile()) return;
duke@435 959
duke@435 960 CodeBlob* cb = fr.cb();
duke@435 961
duke@435 962 // For runtime stubs, record as native rather than as compiled
duke@435 963 if (cb->is_runtime_stub()) {
duke@435 964 RegisterMap map(thread, false);
duke@435 965 fr = fr.sender(&map);
duke@435 966 cb = fr.cb();
duke@435 967 localwhere = tp_native;
duke@435 968 }
duke@435 969 methodOop method = (cb->is_nmethod()) ? ((nmethod *)cb)->method() :
duke@435 970 (methodOop)NULL;
duke@435 971
duke@435 972 if (method == NULL) {
duke@435 973 if (cb->is_runtime_stub())
duke@435 974 runtime_stub_update(cb, name, localwhere);
duke@435 975 else
duke@435 976 unknown_compiled_update(cb, localwhere);
duke@435 977 }
duke@435 978 else {
duke@435 979 if (method->is_native()) {
duke@435 980 stub_update(method, name, localwhere);
duke@435 981 } else {
duke@435 982 compiled_update(method, localwhere);
duke@435 983 }
duke@435 984 }
duke@435 985 }
duke@435 986
duke@435 987 extern "C" void find(int x);
duke@435 988
duke@435 989
duke@435 990 void ThreadProfiler::record_tick_for_running_frame(JavaThread* thread, frame fr) {
twisti@1040 991 // The tick happened in real code -> non VM code
duke@435 992 if (fr.is_interpreted_frame()) {
duke@435 993 interval_data_ref()->inc_interpreted();
sgoldman@542 994 record_interpreted_tick(thread, fr, tp_code, FlatProfiler::bytecode_ticks);
duke@435 995 return;
duke@435 996 }
duke@435 997
duke@435 998 if (CodeCache::contains(fr.pc())) {
duke@435 999 interval_data_ref()->inc_compiled();
duke@435 1000 PCRecorder::record(fr.pc());
duke@435 1001 record_compiled_tick(thread, fr, tp_code);
duke@435 1002 return;
duke@435 1003 }
duke@435 1004
duke@435 1005 if (VtableStubs::stub_containing(fr.pc()) != NULL) {
duke@435 1006 unknown_ticks_array[ut_vtable_stubs] += 1;
duke@435 1007 return;
duke@435 1008 }
duke@435 1009
duke@435 1010 frame caller = fr.profile_find_Java_sender_frame(thread);
duke@435 1011
duke@435 1012 if (caller.sp() != NULL && caller.pc() != NULL) {
duke@435 1013 record_tick_for_calling_frame(thread, caller);
duke@435 1014 return;
duke@435 1015 }
duke@435 1016
duke@435 1017 unknown_ticks_array[ut_running_frame] += 1;
duke@435 1018 FlatProfiler::unknown_ticks += 1;
duke@435 1019 }
duke@435 1020
duke@435 1021 void ThreadProfiler::record_tick_for_calling_frame(JavaThread* thread, frame fr) {
twisti@1040 1022 // The tick happened in VM code
duke@435 1023 interval_data_ref()->inc_native();
duke@435 1024 if (fr.is_interpreted_frame()) {
sgoldman@542 1025 record_interpreted_tick(thread, fr, tp_native, FlatProfiler::bytecode_ticks_stub);
duke@435 1026 return;
duke@435 1027 }
duke@435 1028 if (CodeCache::contains(fr.pc())) {
duke@435 1029 record_compiled_tick(thread, fr, tp_native);
duke@435 1030 return;
duke@435 1031 }
duke@435 1032
duke@435 1033 frame caller = fr.profile_find_Java_sender_frame(thread);
duke@435 1034
duke@435 1035 if (caller.sp() != NULL && caller.pc() != NULL) {
duke@435 1036 record_tick_for_calling_frame(thread, caller);
duke@435 1037 return;
duke@435 1038 }
duke@435 1039
duke@435 1040 unknown_ticks_array[ut_calling_frame] += 1;
duke@435 1041 FlatProfiler::unknown_ticks += 1;
duke@435 1042 }
duke@435 1043
duke@435 1044 void ThreadProfiler::record_tick(JavaThread* thread) {
duke@435 1045 FlatProfiler::all_ticks++;
duke@435 1046 thread_ticks += 1;
duke@435 1047
duke@435 1048 // Here's another way to track global state changes.
duke@435 1049 // When the class loader starts it marks the ThreadProfiler to tell it it is in the class loader
duke@435 1050 // and we check that here.
duke@435 1051 // This is more direct, and more than one thread can be in the class loader at a time,
duke@435 1052 // but it does mean the class loader has to know about the profiler.
duke@435 1053 if (region_flag[ThreadProfilerMark::classLoaderRegion]) {
duke@435 1054 class_loader_ticks += 1;
duke@435 1055 FlatProfiler::class_loader_ticks += 1;
duke@435 1056 return;
duke@435 1057 } else if (region_flag[ThreadProfilerMark::extraRegion]) {
duke@435 1058 extra_ticks += 1;
duke@435 1059 FlatProfiler::extra_ticks += 1;
duke@435 1060 return;
duke@435 1061 }
duke@435 1062 // Note that the WatcherThread can now stop for safepoints
duke@435 1063 uint32_t debug_bits = 0;
duke@435 1064 if (!thread->wait_for_ext_suspend_completion(SuspendRetryCount,
duke@435 1065 SuspendRetryDelay, &debug_bits)) {
duke@435 1066 unknown_ticks_array[ut_unknown_thread_state] += 1;
duke@435 1067 FlatProfiler::unknown_ticks += 1;
duke@435 1068 return;
duke@435 1069 }
duke@435 1070
duke@435 1071 frame fr;
duke@435 1072
duke@435 1073 switch (thread->thread_state()) {
duke@435 1074 case _thread_in_native:
duke@435 1075 case _thread_in_native_trans:
duke@435 1076 case _thread_in_vm:
duke@435 1077 case _thread_in_vm_trans:
duke@435 1078 if (thread->profile_last_Java_frame(&fr)) {
duke@435 1079 if (fr.is_runtime_frame()) {
duke@435 1080 RegisterMap map(thread, false);
duke@435 1081 fr = fr.sender(&map);
duke@435 1082 }
duke@435 1083 record_tick_for_calling_frame(thread, fr);
duke@435 1084 } else {
duke@435 1085 unknown_ticks_array[ut_no_last_Java_frame] += 1;
duke@435 1086 FlatProfiler::unknown_ticks += 1;
duke@435 1087 }
duke@435 1088 break;
duke@435 1089 // handle_special_runtime_exit_condition self-suspends threads in Java
duke@435 1090 case _thread_in_Java:
duke@435 1091 case _thread_in_Java_trans:
duke@435 1092 if (thread->profile_last_Java_frame(&fr)) {
duke@435 1093 if (fr.is_safepoint_blob_frame()) {
duke@435 1094 RegisterMap map(thread, false);
duke@435 1095 fr = fr.sender(&map);
duke@435 1096 }
duke@435 1097 record_tick_for_running_frame(thread, fr);
duke@435 1098 } else {
duke@435 1099 unknown_ticks_array[ut_no_last_Java_frame] += 1;
duke@435 1100 FlatProfiler::unknown_ticks += 1;
duke@435 1101 }
duke@435 1102 break;
duke@435 1103 case _thread_blocked:
duke@435 1104 case _thread_blocked_trans:
duke@435 1105 if (thread->osthread() && thread->osthread()->get_state() == RUNNABLE) {
duke@435 1106 if (thread->profile_last_Java_frame(&fr)) {
duke@435 1107 if (fr.is_safepoint_blob_frame()) {
duke@435 1108 RegisterMap map(thread, false);
duke@435 1109 fr = fr.sender(&map);
duke@435 1110 record_tick_for_running_frame(thread, fr);
duke@435 1111 } else {
duke@435 1112 record_tick_for_calling_frame(thread, fr);
duke@435 1113 }
duke@435 1114 } else {
duke@435 1115 unknown_ticks_array[ut_no_last_Java_frame] += 1;
duke@435 1116 FlatProfiler::unknown_ticks += 1;
duke@435 1117 }
duke@435 1118 } else {
duke@435 1119 blocked_ticks += 1;
duke@435 1120 FlatProfiler::blocked_ticks += 1;
duke@435 1121 }
duke@435 1122 break;
duke@435 1123 case _thread_uninitialized:
duke@435 1124 case _thread_new:
duke@435 1125 // not used, included for completeness
duke@435 1126 case _thread_new_trans:
duke@435 1127 unknown_ticks_array[ut_no_last_Java_frame] += 1;
duke@435 1128 FlatProfiler::unknown_ticks += 1;
duke@435 1129 break;
duke@435 1130 default:
duke@435 1131 unknown_ticks_array[ut_unknown_thread_state] += 1;
duke@435 1132 FlatProfiler::unknown_ticks += 1;
duke@435 1133 break;
duke@435 1134 }
duke@435 1135 return;
duke@435 1136 }
duke@435 1137
duke@435 1138 void ThreadProfiler::engage() {
duke@435 1139 engaged = true;
duke@435 1140 timer.start();
duke@435 1141 }
duke@435 1142
duke@435 1143 void ThreadProfiler::disengage() {
duke@435 1144 engaged = false;
duke@435 1145 timer.stop();
duke@435 1146 }
duke@435 1147
duke@435 1148 void ThreadProfiler::initialize() {
duke@435 1149 for (int index = 0; index < table_size; index++) {
duke@435 1150 table[index] = NULL;
duke@435 1151 }
duke@435 1152 thread_ticks = 0;
duke@435 1153 blocked_ticks = 0;
duke@435 1154 compiler_ticks = 0;
duke@435 1155 interpreter_ticks = 0;
duke@435 1156 for (int ut = 0; ut < ut_end; ut += 1) {
duke@435 1157 unknown_ticks_array[ut] = 0;
duke@435 1158 }
duke@435 1159 region_flag[ThreadProfilerMark::classLoaderRegion] = false;
duke@435 1160 class_loader_ticks = 0;
duke@435 1161 region_flag[ThreadProfilerMark::extraRegion] = false;
duke@435 1162 extra_ticks = 0;
duke@435 1163 timer.start();
duke@435 1164 interval_data_ref()->reset();
duke@435 1165 }
duke@435 1166
duke@435 1167 void ThreadProfiler::reset() {
duke@435 1168 timer.stop();
duke@435 1169 if (table != NULL) {
duke@435 1170 for (int index = 0; index < table_size; index++) {
duke@435 1171 ProfilerNode* n = table[index];
duke@435 1172 if (n != NULL) {
duke@435 1173 delete n;
duke@435 1174 }
duke@435 1175 }
duke@435 1176 }
duke@435 1177 initialize();
duke@435 1178 }
duke@435 1179
duke@435 1180 void FlatProfiler::allocate_table() {
duke@435 1181 { // Bytecode table
duke@435 1182 bytecode_ticks = NEW_C_HEAP_ARRAY(int, Bytecodes::number_of_codes);
duke@435 1183 bytecode_ticks_stub = NEW_C_HEAP_ARRAY(int, Bytecodes::number_of_codes);
duke@435 1184 for(int index = 0; index < Bytecodes::number_of_codes; index++) {
duke@435 1185 bytecode_ticks[index] = 0;
duke@435 1186 bytecode_ticks_stub[index] = 0;
duke@435 1187 }
duke@435 1188 }
duke@435 1189
duke@435 1190 if (ProfilerRecordPC) PCRecorder::init();
duke@435 1191
duke@435 1192 interval_data = NEW_C_HEAP_ARRAY(IntervalData, interval_print_size);
duke@435 1193 FlatProfiler::interval_reset();
duke@435 1194 }
duke@435 1195
duke@435 1196 void FlatProfiler::engage(JavaThread* mainThread, bool fullProfile) {
duke@435 1197 full_profile_flag = fullProfile;
duke@435 1198 if (bytecode_ticks == NULL) {
duke@435 1199 allocate_table();
duke@435 1200 }
duke@435 1201 if(ProfileVM && (vm_thread_profiler == NULL)){
duke@435 1202 vm_thread_profiler = new ThreadProfiler();
duke@435 1203 }
duke@435 1204 if (task == NULL) {
duke@435 1205 task = new FlatProfilerTask(WatcherThread::delay_interval);
duke@435 1206 task->enroll();
duke@435 1207 }
duke@435 1208 timer.start();
duke@435 1209 if (mainThread != NULL) {
duke@435 1210 // When mainThread was created, it might not have a ThreadProfiler
duke@435 1211 ThreadProfiler* pp = mainThread->get_thread_profiler();
duke@435 1212 if (pp == NULL) {
duke@435 1213 mainThread->set_thread_profiler(new ThreadProfiler());
duke@435 1214 } else {
duke@435 1215 pp->reset();
duke@435 1216 }
duke@435 1217 mainThread->get_thread_profiler()->engage();
duke@435 1218 }
duke@435 1219 // This is where we would assign thread_profiler
duke@435 1220 // if we wanted only one thread_profiler for all threads.
duke@435 1221 thread_profiler = NULL;
duke@435 1222 }
duke@435 1223
duke@435 1224 void FlatProfiler::disengage() {
duke@435 1225 if (!task) {
duke@435 1226 return;
duke@435 1227 }
duke@435 1228 timer.stop();
duke@435 1229 task->disenroll();
duke@435 1230 delete task;
duke@435 1231 task = NULL;
duke@435 1232 if (thread_profiler != NULL) {
duke@435 1233 thread_profiler->disengage();
duke@435 1234 } else {
duke@435 1235 MutexLocker tl(Threads_lock);
duke@435 1236 for (JavaThread* tp = Threads::first(); tp != NULL; tp = tp->next()) {
duke@435 1237 ThreadProfiler* pp = tp->get_thread_profiler();
duke@435 1238 if (pp != NULL) {
duke@435 1239 pp->disengage();
duke@435 1240 }
duke@435 1241 }
duke@435 1242 }
duke@435 1243 }
duke@435 1244
duke@435 1245 void FlatProfiler::reset() {
duke@435 1246 if (task) {
duke@435 1247 disengage();
duke@435 1248 }
duke@435 1249
duke@435 1250 class_loader_ticks = 0;
duke@435 1251 extra_ticks = 0;
duke@435 1252 received_gc_ticks = 0;
duke@435 1253 vm_operation_ticks = 0;
duke@435 1254 compiler_ticks = 0;
duke@435 1255 deopt_ticks = 0;
duke@435 1256 interpreter_ticks = 0;
duke@435 1257 blocked_ticks = 0;
duke@435 1258 unknown_ticks = 0;
duke@435 1259 received_ticks = 0;
duke@435 1260 delivered_ticks = 0;
duke@435 1261 timer.stop();
duke@435 1262 }
duke@435 1263
duke@435 1264 bool FlatProfiler::is_active() {
duke@435 1265 return task != NULL;
duke@435 1266 }
duke@435 1267
duke@435 1268 void FlatProfiler::print_byte_code_statistics() {
duke@435 1269 GrowableArray <ProfilerNode*>* array = new GrowableArray<ProfilerNode*>(200);
duke@435 1270
duke@435 1271 tty->print_cr(" Bytecode ticks:");
duke@435 1272 for (int index = 0; index < Bytecodes::number_of_codes; index++) {
duke@435 1273 if (FlatProfiler::bytecode_ticks[index] > 0 || FlatProfiler::bytecode_ticks_stub[index] > 0) {
duke@435 1274 tty->print_cr(" %4d %4d = %s",
duke@435 1275 FlatProfiler::bytecode_ticks[index],
duke@435 1276 FlatProfiler::bytecode_ticks_stub[index],
duke@435 1277 Bytecodes::name( (Bytecodes::Code) index));
duke@435 1278 }
duke@435 1279 }
duke@435 1280 tty->cr();
duke@435 1281 }
duke@435 1282
duke@435 1283 void print_ticks(const char* title, int ticks, int total) {
duke@435 1284 if (ticks > 0) {
duke@435 1285 tty->print("%5.1f%% %5d", ticks * 100.0 / total, ticks);
duke@435 1286 tty->fill_to(col3);
duke@435 1287 tty->print("%s", title);
duke@435 1288 tty->cr();
duke@435 1289 }
duke@435 1290 }
duke@435 1291
duke@435 1292 void ThreadProfiler::print(const char* thread_name) {
duke@435 1293 ResourceMark rm;
duke@435 1294 MutexLocker ppl(ProfilePrint_lock);
duke@435 1295 int index = 0; // Declared outside for loops for portability
duke@435 1296
duke@435 1297 if (table == NULL) {
duke@435 1298 return;
duke@435 1299 }
duke@435 1300
duke@435 1301 if (thread_ticks <= 0) {
duke@435 1302 return;
duke@435 1303 }
duke@435 1304
duke@435 1305 const char* title = "too soon to tell";
duke@435 1306 double secs = timer.seconds();
duke@435 1307
duke@435 1308 GrowableArray <ProfilerNode*>* array = new GrowableArray<ProfilerNode*>(200);
duke@435 1309 for(index = 0; index < table_size; index++) {
duke@435 1310 for(ProfilerNode* node = table[index]; node; node = node->next())
duke@435 1311 array->append(node);
duke@435 1312 }
duke@435 1313
duke@435 1314 array->sort(&ProfilerNode::compare);
duke@435 1315
duke@435 1316 // compute total (sanity check)
duke@435 1317 int active =
duke@435 1318 class_loader_ticks +
duke@435 1319 compiler_ticks +
duke@435 1320 interpreter_ticks +
duke@435 1321 unknown_ticks();
duke@435 1322 for (index = 0; index < array->length(); index++) {
duke@435 1323 active += array->at(index)->ticks.total();
duke@435 1324 }
duke@435 1325 int total = active + blocked_ticks;
duke@435 1326
duke@435 1327 tty->cr();
duke@435 1328 tty->print_cr("Flat profile of %3.2f secs (%d total ticks): %s", secs, total, thread_name);
duke@435 1329 if (total != thread_ticks) {
duke@435 1330 print_ticks("Lost ticks", thread_ticks-total, thread_ticks);
duke@435 1331 }
duke@435 1332 tty->cr();
duke@435 1333
duke@435 1334 // print interpreted methods
duke@435 1335 tick_counter interpreted_ticks;
duke@435 1336 bool has_interpreted_ticks = false;
duke@435 1337 int print_count = 0;
duke@435 1338 for (index = 0; index < array->length(); index++) {
duke@435 1339 ProfilerNode* n = array->at(index);
duke@435 1340 if (n->is_interpreted()) {
duke@435 1341 interpreted_ticks.add(&n->ticks);
duke@435 1342 if (!has_interpreted_ticks) {
duke@435 1343 interpretedNode::print_title(tty);
duke@435 1344 has_interpreted_ticks = true;
duke@435 1345 }
duke@435 1346 if (print_count++ < ProfilerNumberOfInterpretedMethods) {
duke@435 1347 n->print(tty, active);
duke@435 1348 }
duke@435 1349 }
duke@435 1350 }
duke@435 1351 if (has_interpreted_ticks) {
duke@435 1352 if (print_count <= ProfilerNumberOfInterpretedMethods) {
duke@435 1353 title = "Total interpreted";
duke@435 1354 } else {
duke@435 1355 title = "Total interpreted (including elided)";
duke@435 1356 }
duke@435 1357 interpretedNode::print_total(tty, &interpreted_ticks, active, title);
duke@435 1358 tty->cr();
duke@435 1359 }
duke@435 1360
duke@435 1361 // print compiled methods
duke@435 1362 tick_counter compiled_ticks;
duke@435 1363 bool has_compiled_ticks = false;
duke@435 1364 print_count = 0;
duke@435 1365 for (index = 0; index < array->length(); index++) {
duke@435 1366 ProfilerNode* n = array->at(index);
duke@435 1367 if (n->is_compiled()) {
duke@435 1368 compiled_ticks.add(&n->ticks);
duke@435 1369 if (!has_compiled_ticks) {
duke@435 1370 compiledNode::print_title(tty);
duke@435 1371 has_compiled_ticks = true;
duke@435 1372 }
duke@435 1373 if (print_count++ < ProfilerNumberOfCompiledMethods) {
duke@435 1374 n->print(tty, active);
duke@435 1375 }
duke@435 1376 }
duke@435 1377 }
duke@435 1378 if (has_compiled_ticks) {
duke@435 1379 if (print_count <= ProfilerNumberOfCompiledMethods) {
duke@435 1380 title = "Total compiled";
duke@435 1381 } else {
duke@435 1382 title = "Total compiled (including elided)";
duke@435 1383 }
duke@435 1384 compiledNode::print_total(tty, &compiled_ticks, active, title);
duke@435 1385 tty->cr();
duke@435 1386 }
duke@435 1387
duke@435 1388 // print stub methods
duke@435 1389 tick_counter stub_ticks;
duke@435 1390 bool has_stub_ticks = false;
duke@435 1391 print_count = 0;
duke@435 1392 for (index = 0; index < array->length(); index++) {
duke@435 1393 ProfilerNode* n = array->at(index);
duke@435 1394 if (n->is_stub()) {
duke@435 1395 stub_ticks.add(&n->ticks);
duke@435 1396 if (!has_stub_ticks) {
duke@435 1397 stubNode::print_title(tty);
duke@435 1398 has_stub_ticks = true;
duke@435 1399 }
duke@435 1400 if (print_count++ < ProfilerNumberOfStubMethods) {
duke@435 1401 n->print(tty, active);
duke@435 1402 }
duke@435 1403 }
duke@435 1404 }
duke@435 1405 if (has_stub_ticks) {
duke@435 1406 if (print_count <= ProfilerNumberOfStubMethods) {
duke@435 1407 title = "Total stub";
duke@435 1408 } else {
duke@435 1409 title = "Total stub (including elided)";
duke@435 1410 }
duke@435 1411 stubNode::print_total(tty, &stub_ticks, active, title);
duke@435 1412 tty->cr();
duke@435 1413 }
duke@435 1414
duke@435 1415 // print runtime stubs
duke@435 1416 tick_counter runtime_stub_ticks;
duke@435 1417 bool has_runtime_stub_ticks = false;
duke@435 1418 print_count = 0;
duke@435 1419 for (index = 0; index < array->length(); index++) {
duke@435 1420 ProfilerNode* n = array->at(index);
duke@435 1421 if (n->is_runtime_stub()) {
duke@435 1422 runtime_stub_ticks.add(&n->ticks);
duke@435 1423 if (!has_runtime_stub_ticks) {
duke@435 1424 runtimeStubNode::print_title(tty);
duke@435 1425 has_runtime_stub_ticks = true;
duke@435 1426 }
duke@435 1427 if (print_count++ < ProfilerNumberOfRuntimeStubNodes) {
duke@435 1428 n->print(tty, active);
duke@435 1429 }
duke@435 1430 }
duke@435 1431 }
duke@435 1432 if (has_runtime_stub_ticks) {
duke@435 1433 if (print_count <= ProfilerNumberOfRuntimeStubNodes) {
duke@435 1434 title = "Total runtime stubs";
duke@435 1435 } else {
duke@435 1436 title = "Total runtime stubs (including elided)";
duke@435 1437 }
duke@435 1438 runtimeStubNode::print_total(tty, &runtime_stub_ticks, active, title);
duke@435 1439 tty->cr();
duke@435 1440 }
duke@435 1441
duke@435 1442 if (blocked_ticks + class_loader_ticks + interpreter_ticks + compiler_ticks + unknown_ticks() != 0) {
duke@435 1443 tty->fill_to(col1);
duke@435 1444 tty->print_cr("Thread-local ticks:");
duke@435 1445 print_ticks("Blocked (of total)", blocked_ticks, total);
duke@435 1446 print_ticks("Class loader", class_loader_ticks, active);
duke@435 1447 print_ticks("Extra", extra_ticks, active);
duke@435 1448 print_ticks("Interpreter", interpreter_ticks, active);
duke@435 1449 print_ticks("Compilation", compiler_ticks, active);
duke@435 1450 print_ticks("Unknown: vtable stubs", unknown_ticks_array[ut_vtable_stubs], active);
duke@435 1451 print_ticks("Unknown: null method", unknown_ticks_array[ut_null_method], active);
duke@435 1452 print_ticks("Unknown: running frame", unknown_ticks_array[ut_running_frame], active);
duke@435 1453 print_ticks("Unknown: calling frame", unknown_ticks_array[ut_calling_frame], active);
duke@435 1454 print_ticks("Unknown: no pc", unknown_ticks_array[ut_no_pc], active);
duke@435 1455 print_ticks("Unknown: no last frame", unknown_ticks_array[ut_no_last_Java_frame], active);
duke@435 1456 print_ticks("Unknown: thread_state", unknown_ticks_array[ut_unknown_thread_state], active);
duke@435 1457 tty->cr();
duke@435 1458 }
duke@435 1459
duke@435 1460 if (WizardMode) {
duke@435 1461 tty->print_cr("Node area used: %dKb", (area_top - area_bottom) / 1024);
duke@435 1462 }
duke@435 1463 reset();
duke@435 1464 }
duke@435 1465
duke@435 1466 /*
duke@435 1467 ThreadProfiler::print_unknown(){
duke@435 1468 if (table == NULL) {
duke@435 1469 return;
duke@435 1470 }
duke@435 1471
duke@435 1472 if (thread_ticks <= 0) {
duke@435 1473 return;
duke@435 1474 }
duke@435 1475 } */
duke@435 1476
duke@435 1477 void FlatProfiler::print(int unused) {
duke@435 1478 ResourceMark rm;
duke@435 1479 if (thread_profiler != NULL) {
duke@435 1480 thread_profiler->print("All threads");
duke@435 1481 } else {
duke@435 1482 MutexLocker tl(Threads_lock);
duke@435 1483 for (JavaThread* tp = Threads::first(); tp != NULL; tp = tp->next()) {
duke@435 1484 ThreadProfiler* pp = tp->get_thread_profiler();
duke@435 1485 if (pp != NULL) {
duke@435 1486 pp->print(tp->get_thread_name());
duke@435 1487 }
duke@435 1488 }
duke@435 1489 }
duke@435 1490
duke@435 1491 if (ProfilerPrintByteCodeStatistics) {
duke@435 1492 print_byte_code_statistics();
duke@435 1493 }
duke@435 1494
duke@435 1495 if (non_method_ticks() > 0) {
duke@435 1496 tty->cr();
duke@435 1497 tty->print_cr("Global summary of %3.2f seconds:", timer.seconds());
duke@435 1498 print_ticks("Received ticks", received_ticks, received_ticks);
duke@435 1499 print_ticks("Received GC ticks", received_gc_ticks, received_ticks);
duke@435 1500 print_ticks("Compilation", compiler_ticks, received_ticks);
duke@435 1501 print_ticks("Deoptimization", deopt_ticks, received_ticks);
duke@435 1502 print_ticks("Other VM operations", vm_operation_ticks, received_ticks);
duke@435 1503 #ifndef PRODUCT
duke@435 1504 print_ticks("Blocked ticks", blocked_ticks, received_ticks);
duke@435 1505 print_ticks("Threads_lock blocks", threads_lock_ticks, received_ticks);
duke@435 1506 print_ticks("Delivered ticks", delivered_ticks, received_ticks);
duke@435 1507 print_ticks("All ticks", all_ticks, received_ticks);
duke@435 1508 #endif
duke@435 1509 print_ticks("Class loader", class_loader_ticks, received_ticks);
duke@435 1510 print_ticks("Extra ", extra_ticks, received_ticks);
duke@435 1511 print_ticks("Interpreter", interpreter_ticks, received_ticks);
duke@435 1512 print_ticks("Unknown code", unknown_ticks, received_ticks);
duke@435 1513 }
duke@435 1514
duke@435 1515 PCRecorder::print();
duke@435 1516
duke@435 1517 if(ProfileVM){
duke@435 1518 tty->cr();
duke@435 1519 vm_thread_profiler->print("VM Thread");
duke@435 1520 }
duke@435 1521 }
duke@435 1522
duke@435 1523 void IntervalData::print_header(outputStream* st) {
duke@435 1524 st->print("i/c/n/g");
duke@435 1525 }
duke@435 1526
duke@435 1527 void IntervalData::print_data(outputStream* st) {
duke@435 1528 st->print("%d/%d/%d/%d", interpreted(), compiled(), native(), compiling());
duke@435 1529 }
duke@435 1530
duke@435 1531 void FlatProfiler::interval_record_thread(ThreadProfiler* tp) {
duke@435 1532 IntervalData id = tp->interval_data();
duke@435 1533 int total = id.total();
duke@435 1534 tp->interval_data_ref()->reset();
duke@435 1535
duke@435 1536 // Insertion sort the data, if it's relevant.
duke@435 1537 for (int i = 0; i < interval_print_size; i += 1) {
duke@435 1538 if (total > interval_data[i].total()) {
duke@435 1539 for (int j = interval_print_size - 1; j > i; j -= 1) {
duke@435 1540 interval_data[j] = interval_data[j-1];
duke@435 1541 }
duke@435 1542 interval_data[i] = id;
duke@435 1543 break;
duke@435 1544 }
duke@435 1545 }
duke@435 1546 }
duke@435 1547
duke@435 1548 void FlatProfiler::interval_print() {
duke@435 1549 if ((interval_data[0].total() > 0)) {
duke@435 1550 tty->stamp();
duke@435 1551 tty->print("\t");
duke@435 1552 IntervalData::print_header(tty);
duke@435 1553 for (int i = 0; i < interval_print_size; i += 1) {
duke@435 1554 if (interval_data[i].total() > 0) {
duke@435 1555 tty->print("\t");
duke@435 1556 interval_data[i].print_data(tty);
duke@435 1557 }
duke@435 1558 }
duke@435 1559 tty->cr();
duke@435 1560 }
duke@435 1561 }
duke@435 1562
duke@435 1563 void FlatProfiler::interval_reset() {
duke@435 1564 for (int i = 0; i < interval_print_size; i += 1) {
duke@435 1565 interval_data[i].reset();
duke@435 1566 }
duke@435 1567 }
duke@435 1568
duke@435 1569 void ThreadProfiler::oops_do(OopClosure* f) {
duke@435 1570 if (table == NULL) return;
duke@435 1571
duke@435 1572 for(int index = 0; index < table_size; index++) {
duke@435 1573 for(ProfilerNode* node = table[index]; node; node = node->next())
duke@435 1574 node->oops_do(f);
duke@435 1575 }
duke@435 1576 }
duke@435 1577
duke@435 1578 void FlatProfiler::oops_do(OopClosure* f) {
duke@435 1579 if (thread_profiler != NULL) {
duke@435 1580 thread_profiler->oops_do(f);
duke@435 1581 } else {
duke@435 1582 for (JavaThread* tp = Threads::first(); tp != NULL; tp = tp->next()) {
duke@435 1583 ThreadProfiler* pp = tp->get_thread_profiler();
duke@435 1584 if (pp != NULL) {
duke@435 1585 pp->oops_do(f);
duke@435 1586 }
duke@435 1587 }
duke@435 1588 }
duke@435 1589 }

mercurial