src/share/vm/runtime/fprofiler.cpp

Wed, 06 Jul 2011 13:02:54 -0700

author
jcoomes
date
Wed, 06 Jul 2011 13:02:54 -0700
changeset 2997
bf6481e5f96d
parent 2708
1d1603768966
child 3900
d2a62e0f25eb
permissions
-rw-r--r--

7061225: os::print_cpu_info() should support os-specific data
Reviewed-by: dholmes, never, jwilhelm, kvn

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

mercurial