Wed, 15 Feb 2012 10:12:55 -0800
7145537: minor tweaks to LogEvents
Reviewed-by: kvn, twisti
1 /*
2 * Copyright (c) 1999, 2012, 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/systemDictionary.hpp"
27 #include "classfile/vmSymbols.hpp"
28 #include "code/codeCache.hpp"
29 #include "compiler/compileBroker.hpp"
30 #include "compiler/compileLog.hpp"
31 #include "compiler/compilerOracle.hpp"
32 #include "interpreter/linkResolver.hpp"
33 #include "memory/allocation.inline.hpp"
34 #include "oops/methodDataOop.hpp"
35 #include "oops/methodOop.hpp"
36 #include "oops/oop.inline.hpp"
37 #include "prims/nativeLookup.hpp"
38 #include "runtime/arguments.hpp"
39 #include "runtime/compilationPolicy.hpp"
40 #include "runtime/init.hpp"
41 #include "runtime/interfaceSupport.hpp"
42 #include "runtime/javaCalls.hpp"
43 #include "runtime/os.hpp"
44 #include "runtime/sharedRuntime.hpp"
45 #include "runtime/sweeper.hpp"
46 #include "utilities/dtrace.hpp"
47 #include "utilities/events.hpp"
48 #ifdef COMPILER1
49 #include "c1/c1_Compiler.hpp"
50 #endif
51 #ifdef COMPILER2
52 #include "opto/c2compiler.hpp"
53 #endif
54 #ifdef SHARK
55 #include "shark/sharkCompiler.hpp"
56 #endif
58 #ifdef DTRACE_ENABLED
60 // Only bother with this argument setup if dtrace is available
62 #ifndef USDT2
63 HS_DTRACE_PROBE_DECL8(hotspot, method__compile__begin,
64 char*, intptr_t, char*, intptr_t, char*, intptr_t, char*, intptr_t);
65 HS_DTRACE_PROBE_DECL9(hotspot, method__compile__end,
66 char*, intptr_t, char*, intptr_t, char*, intptr_t, char*, intptr_t, bool);
68 #define DTRACE_METHOD_COMPILE_BEGIN_PROBE(compiler, method) \
69 { \
70 char* comp_name = (char*)(compiler)->name(); \
71 Symbol* klass_name = (method)->klass_name(); \
72 Symbol* name = (method)->name(); \
73 Symbol* signature = (method)->signature(); \
74 HS_DTRACE_PROBE8(hotspot, method__compile__begin, \
75 comp_name, strlen(comp_name), \
76 klass_name->bytes(), klass_name->utf8_length(), \
77 name->bytes(), name->utf8_length(), \
78 signature->bytes(), signature->utf8_length()); \
79 }
81 #define DTRACE_METHOD_COMPILE_END_PROBE(compiler, method, success) \
82 { \
83 char* comp_name = (char*)(compiler)->name(); \
84 Symbol* klass_name = (method)->klass_name(); \
85 Symbol* name = (method)->name(); \
86 Symbol* signature = (method)->signature(); \
87 HS_DTRACE_PROBE9(hotspot, method__compile__end, \
88 comp_name, strlen(comp_name), \
89 klass_name->bytes(), klass_name->utf8_length(), \
90 name->bytes(), name->utf8_length(), \
91 signature->bytes(), signature->utf8_length(), (success)); \
92 }
94 #else /* USDT2 */
96 #define DTRACE_METHOD_COMPILE_BEGIN_PROBE(compiler, method) \
97 { \
98 char* comp_name = (char*)(compiler)->name(); \
99 Symbol* klass_name = (method)->klass_name(); \
100 Symbol* name = (method)->name(); \
101 Symbol* signature = (method)->signature(); \
102 HOTSPOT_METHOD_COMPILE_BEGIN( \
103 comp_name, strlen(comp_name), \
104 (char *) klass_name->bytes(), klass_name->utf8_length(), \
105 (char *) name->bytes(), name->utf8_length(), \
106 (char *) signature->bytes(), signature->utf8_length()); \
107 }
109 #define DTRACE_METHOD_COMPILE_END_PROBE(compiler, method, success) \
110 { \
111 char* comp_name = (char*)(compiler)->name(); \
112 Symbol* klass_name = (method)->klass_name(); \
113 Symbol* name = (method)->name(); \
114 Symbol* signature = (method)->signature(); \
115 HOTSPOT_METHOD_COMPILE_END( \
116 comp_name, strlen(comp_name), \
117 (char *) klass_name->bytes(), klass_name->utf8_length(), \
118 (char *) name->bytes(), name->utf8_length(), \
119 (char *) signature->bytes(), signature->utf8_length(), (success)); \
120 }
121 #endif /* USDT2 */
123 #else // ndef DTRACE_ENABLED
125 #define DTRACE_METHOD_COMPILE_BEGIN_PROBE(compiler, method)
126 #define DTRACE_METHOD_COMPILE_END_PROBE(compiler, method, success)
128 #endif // ndef DTRACE_ENABLED
130 bool CompileBroker::_initialized = false;
131 volatile bool CompileBroker::_should_block = false;
132 volatile jint CompileBroker::_should_compile_new_jobs = run_compilation;
134 // The installed compiler(s)
135 AbstractCompiler* CompileBroker::_compilers[2];
137 // These counters are used for assigning id's to each compilation
138 uint CompileBroker::_compilation_id = 0;
139 uint CompileBroker::_osr_compilation_id = 0;
141 // Debugging information
142 int CompileBroker::_last_compile_type = no_compile;
143 int CompileBroker::_last_compile_level = CompLevel_none;
144 char CompileBroker::_last_method_compiled[CompileBroker::name_buffer_length];
146 // Performance counters
147 PerfCounter* CompileBroker::_perf_total_compilation = NULL;
148 PerfCounter* CompileBroker::_perf_osr_compilation = NULL;
149 PerfCounter* CompileBroker::_perf_standard_compilation = NULL;
151 PerfCounter* CompileBroker::_perf_total_bailout_count = NULL;
152 PerfCounter* CompileBroker::_perf_total_invalidated_count = NULL;
153 PerfCounter* CompileBroker::_perf_total_compile_count = NULL;
154 PerfCounter* CompileBroker::_perf_total_osr_compile_count = NULL;
155 PerfCounter* CompileBroker::_perf_total_standard_compile_count = NULL;
157 PerfCounter* CompileBroker::_perf_sum_osr_bytes_compiled = NULL;
158 PerfCounter* CompileBroker::_perf_sum_standard_bytes_compiled = NULL;
159 PerfCounter* CompileBroker::_perf_sum_nmethod_size = NULL;
160 PerfCounter* CompileBroker::_perf_sum_nmethod_code_size = NULL;
162 PerfStringVariable* CompileBroker::_perf_last_method = NULL;
163 PerfStringVariable* CompileBroker::_perf_last_failed_method = NULL;
164 PerfStringVariable* CompileBroker::_perf_last_invalidated_method = NULL;
165 PerfVariable* CompileBroker::_perf_last_compile_type = NULL;
166 PerfVariable* CompileBroker::_perf_last_compile_size = NULL;
167 PerfVariable* CompileBroker::_perf_last_failed_type = NULL;
168 PerfVariable* CompileBroker::_perf_last_invalidated_type = NULL;
170 // Timers and counters for generating statistics
171 elapsedTimer CompileBroker::_t_total_compilation;
172 elapsedTimer CompileBroker::_t_osr_compilation;
173 elapsedTimer CompileBroker::_t_standard_compilation;
175 int CompileBroker::_total_bailout_count = 0;
176 int CompileBroker::_total_invalidated_count = 0;
177 int CompileBroker::_total_compile_count = 0;
178 int CompileBroker::_total_osr_compile_count = 0;
179 int CompileBroker::_total_standard_compile_count = 0;
181 int CompileBroker::_sum_osr_bytes_compiled = 0;
182 int CompileBroker::_sum_standard_bytes_compiled = 0;
183 int CompileBroker::_sum_nmethod_size = 0;
184 int CompileBroker::_sum_nmethod_code_size = 0;
186 CompileQueue* CompileBroker::_c2_method_queue = NULL;
187 CompileQueue* CompileBroker::_c1_method_queue = NULL;
188 CompileTask* CompileBroker::_task_free_list = NULL;
190 GrowableArray<CompilerThread*>* CompileBroker::_method_threads = NULL;
193 class CompilationLog : public StringEventLog {
194 public:
195 CompilationLog() : StringEventLog("Compilation events") {
196 }
198 void log_compile(JavaThread* thread, CompileTask* task) {
199 StringLogMessage lm;
200 stringStream msg = lm.stream();
201 // msg.time_stamp().update_to(tty->time_stamp().ticks());
202 task->print_compilation(&msg, true);
203 log(thread, "%s", (const char*)lm);
204 }
206 void log_nmethod(JavaThread* thread, nmethod* nm) {
207 log(thread, "nmethod %d%s " INTPTR_FORMAT " code ["INTPTR_FORMAT ", " INTPTR_FORMAT "]",
208 nm->compile_id(), nm->is_osr_method() ? "%" : "",
209 nm, nm->code_begin(), nm->code_end());
210 }
212 void log_failure(JavaThread* thread, CompileTask* task, const char* reason, const char* retry_message) {
213 StringLogMessage lm;
214 lm.print("%4d COMPILE SKIPPED: %s", task->compile_id(), reason);
215 if (retry_message != NULL) {
216 lm.append(" (%s)", retry_message);
217 }
218 lm.print("\n");
219 log(thread, "%s", (const char*)lm);
220 }
221 };
223 static CompilationLog* _compilation_log = NULL;
225 void compileBroker_init() {
226 if (LogEvents) {
227 _compilation_log = new CompilationLog();
228 }
229 }
231 CompileTaskWrapper::CompileTaskWrapper(CompileTask* task) {
232 CompilerThread* thread = CompilerThread::current();
233 thread->set_task(task);
234 CompileLog* log = thread->log();
235 if (log != NULL) task->log_task_start(log);
236 }
238 CompileTaskWrapper::~CompileTaskWrapper() {
239 CompilerThread* thread = CompilerThread::current();
240 CompileTask* task = thread->task();
241 CompileLog* log = thread->log();
242 if (log != NULL) task->log_task_done(log);
243 thread->set_task(NULL);
244 task->set_code_handle(NULL);
245 DEBUG_ONLY(thread->set_env((ciEnv*)badAddress));
246 if (task->is_blocking()) {
247 MutexLocker notifier(task->lock(), thread);
248 task->mark_complete();
249 // Notify the waiting thread that the compilation has completed.
250 task->lock()->notify_all();
251 } else {
252 task->mark_complete();
254 // By convention, the compiling thread is responsible for
255 // recycling a non-blocking CompileTask.
256 CompileBroker::free_task(task);
257 }
258 }
261 // ------------------------------------------------------------------
262 // CompileTask::initialize
263 void CompileTask::initialize(int compile_id,
264 methodHandle method,
265 int osr_bci,
266 int comp_level,
267 methodHandle hot_method,
268 int hot_count,
269 const char* comment,
270 bool is_blocking) {
271 assert(!_lock->is_locked(), "bad locking");
273 _compile_id = compile_id;
274 _method = JNIHandles::make_global(method);
275 _osr_bci = osr_bci;
276 _is_blocking = is_blocking;
277 _comp_level = comp_level;
278 _num_inlined_bytecodes = 0;
280 _is_complete = false;
281 _is_success = false;
282 _code_handle = NULL;
284 _hot_method = NULL;
285 _hot_count = hot_count;
286 _time_queued = 0; // tidy
287 _comment = comment;
289 if (LogCompilation) {
290 _time_queued = os::elapsed_counter();
291 if (hot_method.not_null()) {
292 if (hot_method == method) {
293 _hot_method = _method;
294 } else {
295 _hot_method = JNIHandles::make_global(hot_method);
296 }
297 }
298 }
300 _next = NULL;
301 }
303 // ------------------------------------------------------------------
304 // CompileTask::code/set_code
305 nmethod* CompileTask::code() const {
306 if (_code_handle == NULL) return NULL;
307 return _code_handle->code();
308 }
309 void CompileTask::set_code(nmethod* nm) {
310 if (_code_handle == NULL && nm == NULL) return;
311 guarantee(_code_handle != NULL, "");
312 _code_handle->set_code(nm);
313 if (nm == NULL) _code_handle = NULL; // drop the handle also
314 }
316 // ------------------------------------------------------------------
317 // CompileTask::free
318 void CompileTask::free() {
319 set_code(NULL);
320 assert(!_lock->is_locked(), "Should not be locked when freed");
321 if (_hot_method != NULL && _hot_method != _method) {
322 JNIHandles::destroy_global(_hot_method);
323 }
324 JNIHandles::destroy_global(_method);
325 }
328 // ------------------------------------------------------------------
329 // CompileTask::print
330 void CompileTask::print() {
331 tty->print("<CompileTask compile_id=%d ", _compile_id);
332 tty->print("method=");
333 ((methodOop)JNIHandles::resolve(_method))->print_name(tty);
334 tty->print_cr(" osr_bci=%d is_blocking=%s is_complete=%s is_success=%s>",
335 _osr_bci, bool_to_str(_is_blocking),
336 bool_to_str(_is_complete), bool_to_str(_is_success));
337 }
340 // ------------------------------------------------------------------
341 // CompileTask::print_line_on_error
342 //
343 // This function is called by fatal error handler when the thread
344 // causing troubles is a compiler thread.
345 //
346 // Do not grab any lock, do not allocate memory.
347 //
348 // Otherwise it's the same as CompileTask::print_line()
349 //
350 void CompileTask::print_line_on_error(outputStream* st, char* buf, int buflen) {
351 // print compiler name
352 st->print("%s:", CompileBroker::compiler(comp_level())->name());
353 print_compilation(st);
354 }
356 // ------------------------------------------------------------------
357 // CompileTask::print_line
358 void CompileTask::print_line() {
359 ttyLocker ttyl; // keep the following output all in one block
360 // print compiler name if requested
361 if (CIPrintCompilerName) tty->print("%s:", CompileBroker::compiler(comp_level())->name());
362 print_compilation();
363 }
366 // ------------------------------------------------------------------
367 // CompileTask::print_compilation_impl
368 void CompileTask::print_compilation_impl(outputStream* st, methodOop method, int compile_id, int comp_level,
369 bool is_osr_method, int osr_bci, bool is_blocking,
370 const char* msg, bool short_form) {
371 if (!short_form) {
372 st->print("%7d ", (int) st->time_stamp().milliseconds()); // print timestamp
373 }
374 st->print("%4d ", compile_id); // print compilation number
376 // For unloaded methods the transition to zombie occurs after the
377 // method is cleared so it's impossible to report accurate
378 // information for that case.
379 bool is_synchronized = false;
380 bool has_exception_handler = false;
381 bool is_native = false;
382 if (method != NULL) {
383 is_synchronized = method->is_synchronized();
384 has_exception_handler = method->has_exception_handler();
385 is_native = method->is_native();
386 }
387 // method attributes
388 const char compile_type = is_osr_method ? '%' : ' ';
389 const char sync_char = is_synchronized ? 's' : ' ';
390 const char exception_char = has_exception_handler ? '!' : ' ';
391 const char blocking_char = is_blocking ? 'b' : ' ';
392 const char native_char = is_native ? 'n' : ' ';
394 // print method attributes
395 st->print("%c%c%c%c%c ", compile_type, sync_char, exception_char, blocking_char, native_char);
397 if (TieredCompilation) {
398 if (comp_level != -1) st->print("%d ", comp_level);
399 else st->print("- ");
400 }
401 st->print(" "); // more indent
403 if (method == NULL) {
404 st->print("(method)");
405 } else {
406 method->print_short_name(st);
407 if (is_osr_method) {
408 st->print(" @ %d", osr_bci);
409 }
410 st->print(" (%d bytes)", method->code_size());
411 }
413 if (msg != NULL) {
414 st->print(" %s", msg);
415 }
416 if (!short_form) {
417 st->cr();
418 }
419 }
421 // ------------------------------------------------------------------
422 // CompileTask::print_inlining
423 void CompileTask::print_inlining(outputStream* st, ciMethod* method, int inline_level, int bci, const char* msg) {
424 // 1234567
425 st->print(" "); // print timestamp
426 // 1234
427 st->print(" "); // print compilation number
429 // method attributes
430 const char sync_char = method->is_synchronized() ? 's' : ' ';
431 const char exception_char = method->has_exception_handlers() ? '!' : ' ';
432 const char monitors_char = method->has_monitor_bytecodes() ? 'm' : ' ';
434 // print method attributes
435 st->print(" %c%c%c ", sync_char, exception_char, monitors_char);
437 if (TieredCompilation) {
438 st->print(" ");
439 }
440 st->print(" "); // more indent
441 st->print(" "); // initial inlining indent
443 for (int i = 0; i < inline_level; i++) st->print(" ");
445 st->print("@ %d ", bci); // print bci
446 method->print_short_name(st);
447 st->print(" (%d bytes)", method->code_size());
449 if (msg != NULL) {
450 st->print(" %s", msg);
451 }
452 st->cr();
453 }
455 // ------------------------------------------------------------------
456 // CompileTask::print_inline_indent
457 void CompileTask::print_inline_indent(int inline_level, outputStream* st) {
458 // 1234567
459 st->print(" "); // print timestamp
460 // 1234
461 st->print(" "); // print compilation number
462 // %s!bn
463 st->print(" "); // print method attributes
464 if (TieredCompilation) {
465 st->print(" ");
466 }
467 st->print(" "); // more indent
468 st->print(" "); // initial inlining indent
469 for (int i = 0; i < inline_level; i++) st->print(" ");
470 }
472 // ------------------------------------------------------------------
473 // CompileTask::print_compilation
474 void CompileTask::print_compilation(outputStream* st, bool short_form) {
475 oop rem = JNIHandles::resolve(method_handle());
476 assert(rem != NULL && rem->is_method(), "must be");
477 methodOop method = (methodOop) rem;
478 bool is_osr_method = osr_bci() != InvocationEntryBci;
479 print_compilation_impl(st, method, compile_id(), comp_level(), is_osr_method, osr_bci(), is_blocking(), NULL, short_form);
480 }
482 // ------------------------------------------------------------------
483 // CompileTask::log_task
484 void CompileTask::log_task(xmlStream* log) {
485 Thread* thread = Thread::current();
486 methodHandle method(thread,
487 (methodOop)JNIHandles::resolve(method_handle()));
488 ResourceMark rm(thread);
490 // <task id='9' method='M' osr_bci='X' level='1' blocking='1' stamp='1.234'>
491 if (_compile_id != 0) log->print(" compile_id='%d'", _compile_id);
492 if (_osr_bci != CompileBroker::standard_entry_bci) {
493 log->print(" compile_kind='osr'"); // same as nmethod::compile_kind
494 } // else compile_kind='c2c'
495 if (!method.is_null()) log->method(method);
496 if (_osr_bci != CompileBroker::standard_entry_bci) {
497 log->print(" osr_bci='%d'", _osr_bci);
498 }
499 if (_comp_level != CompLevel_highest_tier) {
500 log->print(" level='%d'", _comp_level);
501 }
502 if (_is_blocking) {
503 log->print(" blocking='1'");
504 }
505 log->stamp();
506 }
509 // ------------------------------------------------------------------
510 // CompileTask::log_task_queued
511 void CompileTask::log_task_queued() {
512 Thread* thread = Thread::current();
513 ttyLocker ttyl;
514 ResourceMark rm(thread);
516 xtty->begin_elem("task_queued");
517 log_task(xtty);
518 if (_comment != NULL) {
519 xtty->print(" comment='%s'", _comment);
520 }
521 if (_hot_method != NULL) {
522 methodHandle hot(thread,
523 (methodOop)JNIHandles::resolve(_hot_method));
524 methodHandle method(thread,
525 (methodOop)JNIHandles::resolve(_method));
526 if (hot() != method()) {
527 xtty->method(hot);
528 }
529 }
530 if (_hot_count != 0) {
531 xtty->print(" hot_count='%d'", _hot_count);
532 }
533 xtty->end_elem();
534 }
537 // ------------------------------------------------------------------
538 // CompileTask::log_task_start
539 void CompileTask::log_task_start(CompileLog* log) {
540 log->begin_head("task");
541 log_task(log);
542 log->end_head();
543 }
546 // ------------------------------------------------------------------
547 // CompileTask::log_task_done
548 void CompileTask::log_task_done(CompileLog* log) {
549 Thread* thread = Thread::current();
550 methodHandle method(thread,
551 (methodOop)JNIHandles::resolve(method_handle()));
552 ResourceMark rm(thread);
554 // <task_done ... stamp='1.234'> </task>
555 nmethod* nm = code();
556 log->begin_elem("task_done success='%d' nmsize='%d' count='%d'",
557 _is_success, nm == NULL ? 0 : nm->content_size(),
558 method->invocation_count());
559 int bec = method->backedge_count();
560 if (bec != 0) log->print(" backedge_count='%d'", bec);
561 // Note: "_is_complete" is about to be set, but is not.
562 if (_num_inlined_bytecodes != 0) {
563 log->print(" inlined_bytes='%d'", _num_inlined_bytecodes);
564 }
565 log->stamp();
566 log->end_elem();
567 log->tail("task");
568 log->clear_identities(); // next task will have different CI
569 if (log->unflushed_count() > 2000) {
570 log->flush();
571 }
572 log->mark_file_end();
573 }
577 // ------------------------------------------------------------------
578 // CompileQueue::add
579 //
580 // Add a CompileTask to a CompileQueue
581 void CompileQueue::add(CompileTask* task) {
582 assert(lock()->owned_by_self(), "must own lock");
584 task->set_next(NULL);
585 task->set_prev(NULL);
587 if (_last == NULL) {
588 // The compile queue is empty.
589 assert(_first == NULL, "queue is empty");
590 _first = task;
591 _last = task;
592 } else {
593 // Append the task to the queue.
594 assert(_last->next() == NULL, "not last");
595 _last->set_next(task);
596 task->set_prev(_last);
597 _last = task;
598 }
599 ++_size;
601 // Mark the method as being in the compile queue.
602 ((methodOop)JNIHandles::resolve(task->method_handle()))->set_queued_for_compilation();
604 if (CIPrintCompileQueue) {
605 print();
606 }
608 if (LogCompilation && xtty != NULL) {
609 task->log_task_queued();
610 }
612 // Notify CompilerThreads that a task is available.
613 lock()->notify_all();
614 }
616 // ------------------------------------------------------------------
617 // CompileQueue::get
618 //
619 // Get the next CompileTask from a CompileQueue
620 CompileTask* CompileQueue::get() {
621 NMethodSweeper::possibly_sweep();
623 MutexLocker locker(lock());
624 // Wait for an available CompileTask.
625 while (_first == NULL) {
626 // There is no work to be done right now. Wait.
627 if (UseCodeCacheFlushing && (!CompileBroker::should_compile_new_jobs() || CodeCache::needs_flushing())) {
628 // During the emergency sweeping periods, wake up and sweep occasionally
629 bool timedout = lock()->wait(!Mutex::_no_safepoint_check_flag, NmethodSweepCheckInterval*1000);
630 if (timedout) {
631 MutexUnlocker ul(lock());
632 // When otherwise not busy, run nmethod sweeping
633 NMethodSweeper::possibly_sweep();
634 }
635 } else {
636 // During normal operation no need to wake up on timer
637 lock()->wait();
638 }
639 }
640 CompileTask* task = CompilationPolicy::policy()->select_task(this);
641 remove(task);
642 return task;
643 }
645 void CompileQueue::remove(CompileTask* task)
646 {
647 assert(lock()->owned_by_self(), "must own lock");
648 if (task->prev() != NULL) {
649 task->prev()->set_next(task->next());
650 } else {
651 // max is the first element
652 assert(task == _first, "Sanity");
653 _first = task->next();
654 }
656 if (task->next() != NULL) {
657 task->next()->set_prev(task->prev());
658 } else {
659 // max is the last element
660 assert(task == _last, "Sanity");
661 _last = task->prev();
662 }
663 --_size;
664 }
666 // ------------------------------------------------------------------
667 // CompileQueue::print
668 void CompileQueue::print() {
669 tty->print_cr("Contents of %s", name());
670 tty->print_cr("----------------------");
671 CompileTask* task = _first;
672 while (task != NULL) {
673 task->print_line();
674 task = task->next();
675 }
676 tty->print_cr("----------------------");
677 }
679 CompilerCounters::CompilerCounters(const char* thread_name, int instance, TRAPS) {
681 _current_method[0] = '\0';
682 _compile_type = CompileBroker::no_compile;
684 if (UsePerfData) {
685 ResourceMark rm;
687 // create the thread instance name space string - don't create an
688 // instance subspace if instance is -1 - keeps the adapterThread
689 // counters from having a ".0" namespace.
690 const char* thread_i = (instance == -1) ? thread_name :
691 PerfDataManager::name_space(thread_name, instance);
694 char* name = PerfDataManager::counter_name(thread_i, "method");
695 _perf_current_method =
696 PerfDataManager::create_string_variable(SUN_CI, name,
697 cmname_buffer_length,
698 _current_method, CHECK);
700 name = PerfDataManager::counter_name(thread_i, "type");
701 _perf_compile_type = PerfDataManager::create_variable(SUN_CI, name,
702 PerfData::U_None,
703 (jlong)_compile_type,
704 CHECK);
706 name = PerfDataManager::counter_name(thread_i, "time");
707 _perf_time = PerfDataManager::create_counter(SUN_CI, name,
708 PerfData::U_Ticks, CHECK);
710 name = PerfDataManager::counter_name(thread_i, "compiles");
711 _perf_compiles = PerfDataManager::create_counter(SUN_CI, name,
712 PerfData::U_Events, CHECK);
713 }
714 }
716 // ------------------------------------------------------------------
717 // CompileBroker::compilation_init
718 //
719 // Initialize the Compilation object
720 void CompileBroker::compilation_init() {
721 _last_method_compiled[0] = '\0';
723 #ifndef SHARK
724 // Set the interface to the current compiler(s).
725 int c1_count = CompilationPolicy::policy()->compiler_count(CompLevel_simple);
726 int c2_count = CompilationPolicy::policy()->compiler_count(CompLevel_full_optimization);
727 #ifdef COMPILER1
728 if (c1_count > 0) {
729 _compilers[0] = new Compiler();
730 }
731 #endif // COMPILER1
733 #ifdef COMPILER2
734 if (c2_count > 0) {
735 _compilers[1] = new C2Compiler();
736 }
737 #endif // COMPILER2
739 #else // SHARK
740 int c1_count = 0;
741 int c2_count = 1;
743 _compilers[1] = new SharkCompiler();
744 #endif // SHARK
746 // Initialize the CompileTask free list
747 _task_free_list = NULL;
749 // Start the CompilerThreads
750 init_compiler_threads(c1_count, c2_count);
751 // totalTime performance counter is always created as it is required
752 // by the implementation of java.lang.management.CompilationMBean.
753 {
754 EXCEPTION_MARK;
755 _perf_total_compilation =
756 PerfDataManager::create_counter(JAVA_CI, "totalTime",
757 PerfData::U_Ticks, CHECK);
758 }
761 if (UsePerfData) {
763 EXCEPTION_MARK;
765 // create the jvmstat performance counters
766 _perf_osr_compilation =
767 PerfDataManager::create_counter(SUN_CI, "osrTime",
768 PerfData::U_Ticks, CHECK);
770 _perf_standard_compilation =
771 PerfDataManager::create_counter(SUN_CI, "standardTime",
772 PerfData::U_Ticks, CHECK);
774 _perf_total_bailout_count =
775 PerfDataManager::create_counter(SUN_CI, "totalBailouts",
776 PerfData::U_Events, CHECK);
778 _perf_total_invalidated_count =
779 PerfDataManager::create_counter(SUN_CI, "totalInvalidates",
780 PerfData::U_Events, CHECK);
782 _perf_total_compile_count =
783 PerfDataManager::create_counter(SUN_CI, "totalCompiles",
784 PerfData::U_Events, CHECK);
785 _perf_total_osr_compile_count =
786 PerfDataManager::create_counter(SUN_CI, "osrCompiles",
787 PerfData::U_Events, CHECK);
789 _perf_total_standard_compile_count =
790 PerfDataManager::create_counter(SUN_CI, "standardCompiles",
791 PerfData::U_Events, CHECK);
793 _perf_sum_osr_bytes_compiled =
794 PerfDataManager::create_counter(SUN_CI, "osrBytes",
795 PerfData::U_Bytes, CHECK);
797 _perf_sum_standard_bytes_compiled =
798 PerfDataManager::create_counter(SUN_CI, "standardBytes",
799 PerfData::U_Bytes, CHECK);
801 _perf_sum_nmethod_size =
802 PerfDataManager::create_counter(SUN_CI, "nmethodSize",
803 PerfData::U_Bytes, CHECK);
805 _perf_sum_nmethod_code_size =
806 PerfDataManager::create_counter(SUN_CI, "nmethodCodeSize",
807 PerfData::U_Bytes, CHECK);
809 _perf_last_method =
810 PerfDataManager::create_string_variable(SUN_CI, "lastMethod",
811 CompilerCounters::cmname_buffer_length,
812 "", CHECK);
814 _perf_last_failed_method =
815 PerfDataManager::create_string_variable(SUN_CI, "lastFailedMethod",
816 CompilerCounters::cmname_buffer_length,
817 "", CHECK);
819 _perf_last_invalidated_method =
820 PerfDataManager::create_string_variable(SUN_CI, "lastInvalidatedMethod",
821 CompilerCounters::cmname_buffer_length,
822 "", CHECK);
824 _perf_last_compile_type =
825 PerfDataManager::create_variable(SUN_CI, "lastType",
826 PerfData::U_None,
827 (jlong)CompileBroker::no_compile,
828 CHECK);
830 _perf_last_compile_size =
831 PerfDataManager::create_variable(SUN_CI, "lastSize",
832 PerfData::U_Bytes,
833 (jlong)CompileBroker::no_compile,
834 CHECK);
837 _perf_last_failed_type =
838 PerfDataManager::create_variable(SUN_CI, "lastFailedType",
839 PerfData::U_None,
840 (jlong)CompileBroker::no_compile,
841 CHECK);
843 _perf_last_invalidated_type =
844 PerfDataManager::create_variable(SUN_CI, "lastInvalidatedType",
845 PerfData::U_None,
846 (jlong)CompileBroker::no_compile,
847 CHECK);
848 }
850 _initialized = true;
851 }
855 // ------------------------------------------------------------------
856 // CompileBroker::make_compiler_thread
857 CompilerThread* CompileBroker::make_compiler_thread(const char* name, CompileQueue* queue, CompilerCounters* counters, TRAPS) {
858 CompilerThread* compiler_thread = NULL;
860 klassOop k =
861 SystemDictionary::resolve_or_fail(vmSymbols::java_lang_Thread(),
862 true, CHECK_0);
863 instanceKlassHandle klass (THREAD, k);
864 instanceHandle thread_oop = klass->allocate_instance_handle(CHECK_0);
865 Handle string = java_lang_String::create_from_str(name, CHECK_0);
867 // Initialize thread_oop to put it into the system threadGroup
868 Handle thread_group (THREAD, Universe::system_thread_group());
869 JavaValue result(T_VOID);
870 JavaCalls::call_special(&result, thread_oop,
871 klass,
872 vmSymbols::object_initializer_name(),
873 vmSymbols::threadgroup_string_void_signature(),
874 thread_group,
875 string,
876 CHECK_0);
878 {
879 MutexLocker mu(Threads_lock, THREAD);
880 compiler_thread = new CompilerThread(queue, counters);
881 // At this point the new CompilerThread data-races with this startup
882 // thread (which I believe is the primoridal thread and NOT the VM
883 // thread). This means Java bytecodes being executed at startup can
884 // queue compile jobs which will run at whatever default priority the
885 // newly created CompilerThread runs at.
888 // At this point it may be possible that no osthread was created for the
889 // JavaThread due to lack of memory. We would have to throw an exception
890 // in that case. However, since this must work and we do not allow
891 // exceptions anyway, check and abort if this fails.
893 if (compiler_thread == NULL || compiler_thread->osthread() == NULL){
894 vm_exit_during_initialization("java.lang.OutOfMemoryError",
895 "unable to create new native thread");
896 }
898 java_lang_Thread::set_thread(thread_oop(), compiler_thread);
900 // Note that this only sets the JavaThread _priority field, which by
901 // definition is limited to Java priorities and not OS priorities.
902 // The os-priority is set in the CompilerThread startup code itself
904 java_lang_Thread::set_priority(thread_oop(), NearMaxPriority);
906 // Note that we cannot call os::set_priority because it expects Java
907 // priorities and we are *explicitly* using OS priorities so that it's
908 // possible to set the compiler thread priority higher than any Java
909 // thread.
911 int native_prio = CompilerThreadPriority;
912 if (native_prio == -1) {
913 if (UseCriticalCompilerThreadPriority) {
914 native_prio = os::java_to_os_priority[CriticalPriority];
915 } else {
916 native_prio = os::java_to_os_priority[NearMaxPriority];
917 }
918 }
919 os::set_native_priority(compiler_thread, native_prio);
921 java_lang_Thread::set_daemon(thread_oop());
923 compiler_thread->set_threadObj(thread_oop());
924 Threads::add(compiler_thread);
925 Thread::start(compiler_thread);
926 }
928 // Let go of Threads_lock before yielding
929 os::yield(); // make sure that the compiler thread is started early (especially helpful on SOLARIS)
931 return compiler_thread;
932 }
935 // ------------------------------------------------------------------
936 // CompileBroker::init_compiler_threads
937 //
938 // Initialize the compilation queue
939 void CompileBroker::init_compiler_threads(int c1_compiler_count, int c2_compiler_count) {
940 EXCEPTION_MARK;
941 #if !defined(ZERO) && !defined(SHARK)
942 assert(c2_compiler_count > 0 || c1_compiler_count > 0, "No compilers?");
943 #endif // !ZERO && !SHARK
944 if (c2_compiler_count > 0) {
945 _c2_method_queue = new CompileQueue("C2MethodQueue", MethodCompileQueue_lock);
946 }
947 if (c1_compiler_count > 0) {
948 _c1_method_queue = new CompileQueue("C1MethodQueue", MethodCompileQueue_lock);
949 }
951 int compiler_count = c1_compiler_count + c2_compiler_count;
953 _method_threads =
954 new (ResourceObj::C_HEAP) GrowableArray<CompilerThread*>(compiler_count, true);
956 char name_buffer[256];
957 for (int i = 0; i < c2_compiler_count; i++) {
958 // Create a name for our thread.
959 sprintf(name_buffer, "C2 CompilerThread%d", i);
960 CompilerCounters* counters = new CompilerCounters("compilerThread", i, CHECK);
961 CompilerThread* new_thread = make_compiler_thread(name_buffer, _c2_method_queue, counters, CHECK);
962 _method_threads->append(new_thread);
963 }
965 for (int i = c2_compiler_count; i < compiler_count; i++) {
966 // Create a name for our thread.
967 sprintf(name_buffer, "C1 CompilerThread%d", i);
968 CompilerCounters* counters = new CompilerCounters("compilerThread", i, CHECK);
969 CompilerThread* new_thread = make_compiler_thread(name_buffer, _c1_method_queue, counters, CHECK);
970 _method_threads->append(new_thread);
971 }
973 if (UsePerfData) {
974 PerfDataManager::create_constant(SUN_CI, "threads", PerfData::U_Bytes,
975 compiler_count, CHECK);
976 }
977 }
979 // ------------------------------------------------------------------
980 // CompileBroker::is_idle
981 bool CompileBroker::is_idle() {
982 if (_c2_method_queue != NULL && !_c2_method_queue->is_empty()) {
983 return false;
984 } else if (_c1_method_queue != NULL && !_c1_method_queue->is_empty()) {
985 return false;
986 } else {
987 int num_threads = _method_threads->length();
988 for (int i=0; i<num_threads; i++) {
989 if (_method_threads->at(i)->task() != NULL) {
990 return false;
991 }
992 }
994 // No pending or active compilations.
995 return true;
996 }
997 }
1000 // ------------------------------------------------------------------
1001 // CompileBroker::compile_method
1002 //
1003 // Request compilation of a method.
1004 void CompileBroker::compile_method_base(methodHandle method,
1005 int osr_bci,
1006 int comp_level,
1007 methodHandle hot_method,
1008 int hot_count,
1009 const char* comment,
1010 Thread* thread) {
1011 // do nothing if compiler thread(s) is not available
1012 if (!_initialized ) {
1013 return;
1014 }
1016 guarantee(!method->is_abstract(), "cannot compile abstract methods");
1017 assert(method->method_holder()->klass_part()->oop_is_instance(),
1018 "sanity check");
1019 assert(!instanceKlass::cast(method->method_holder())->is_not_initialized(),
1020 "method holder must be initialized");
1022 if (CIPrintRequests) {
1023 tty->print("request: ");
1024 method->print_short_name(tty);
1025 if (osr_bci != InvocationEntryBci) {
1026 tty->print(" osr_bci: %d", osr_bci);
1027 }
1028 tty->print(" comment: %s count: %d", comment, hot_count);
1029 if (!hot_method.is_null()) {
1030 tty->print(" hot: ");
1031 if (hot_method() != method()) {
1032 hot_method->print_short_name(tty);
1033 } else {
1034 tty->print("yes");
1035 }
1036 }
1037 tty->cr();
1038 }
1040 // A request has been made for compilation. Before we do any
1041 // real work, check to see if the method has been compiled
1042 // in the meantime with a definitive result.
1043 if (compilation_is_complete(method, osr_bci, comp_level)) {
1044 return;
1045 }
1047 #ifndef PRODUCT
1048 if (osr_bci != -1 && !FLAG_IS_DEFAULT(OSROnlyBCI)) {
1049 if ((OSROnlyBCI > 0) ? (OSROnlyBCI != osr_bci) : (-OSROnlyBCI == osr_bci)) {
1050 // Positive OSROnlyBCI means only compile that bci. Negative means don't compile that BCI.
1051 return;
1052 }
1053 }
1054 #endif
1056 // If this method is already in the compile queue, then
1057 // we do not block the current thread.
1058 if (compilation_is_in_queue(method, osr_bci)) {
1059 // We may want to decay our counter a bit here to prevent
1060 // multiple denied requests for compilation. This is an
1061 // open compilation policy issue. Note: The other possibility,
1062 // in the case that this is a blocking compile request, is to have
1063 // all subsequent blocking requesters wait for completion of
1064 // ongoing compiles. Note that in this case we'll need a protocol
1065 // for freeing the associated compile tasks. [Or we could have
1066 // a single static monitor on which all these waiters sleep.]
1067 return;
1068 }
1070 // If the requesting thread is holding the pending list lock
1071 // then we just return. We can't risk blocking while holding
1072 // the pending list lock or a 3-way deadlock may occur
1073 // between the reference handler thread, a GC (instigated
1074 // by a compiler thread), and compiled method registration.
1075 if (instanceRefKlass::owns_pending_list_lock(JavaThread::current())) {
1076 return;
1077 }
1079 // Outputs from the following MutexLocker block:
1080 CompileTask* task = NULL;
1081 bool blocking = false;
1082 CompileQueue* queue = compile_queue(comp_level);
1084 // Acquire our lock.
1085 {
1086 MutexLocker locker(queue->lock(), thread);
1088 // Make sure the method has not slipped into the queues since
1089 // last we checked; note that those checks were "fast bail-outs".
1090 // Here we need to be more careful, see 14012000 below.
1091 if (compilation_is_in_queue(method, osr_bci)) {
1092 return;
1093 }
1095 // We need to check again to see if the compilation has
1096 // completed. A previous compilation may have registered
1097 // some result.
1098 if (compilation_is_complete(method, osr_bci, comp_level)) {
1099 return;
1100 }
1102 // We now know that this compilation is not pending, complete,
1103 // or prohibited. Assign a compile_id to this compilation
1104 // and check to see if it is in our [Start..Stop) range.
1105 uint compile_id = assign_compile_id(method, osr_bci);
1106 if (compile_id == 0) {
1107 // The compilation falls outside the allowed range.
1108 return;
1109 }
1111 // Should this thread wait for completion of the compile?
1112 blocking = is_compile_blocking(method, osr_bci);
1114 // We will enter the compilation in the queue.
1115 // 14012000: Note that this sets the queued_for_compile bits in
1116 // the target method. We can now reason that a method cannot be
1117 // queued for compilation more than once, as follows:
1118 // Before a thread queues a task for compilation, it first acquires
1119 // the compile queue lock, then checks if the method's queued bits
1120 // are set or it has already been compiled. Thus there can not be two
1121 // instances of a compilation task for the same method on the
1122 // compilation queue. Consider now the case where the compilation
1123 // thread has already removed a task for that method from the queue
1124 // and is in the midst of compiling it. In this case, the
1125 // queued_for_compile bits must be set in the method (and these
1126 // will be visible to the current thread, since the bits were set
1127 // under protection of the compile queue lock, which we hold now.
1128 // When the compilation completes, the compiler thread first sets
1129 // the compilation result and then clears the queued_for_compile
1130 // bits. Neither of these actions are protected by a barrier (or done
1131 // under the protection of a lock), so the only guarantee we have
1132 // (on machines with TSO (Total Store Order)) is that these values
1133 // will update in that order. As a result, the only combinations of
1134 // these bits that the current thread will see are, in temporal order:
1135 // <RESULT, QUEUE> :
1136 // <0, 1> : in compile queue, but not yet compiled
1137 // <1, 1> : compiled but queue bit not cleared
1138 // <1, 0> : compiled and queue bit cleared
1139 // Because we first check the queue bits then check the result bits,
1140 // we are assured that we cannot introduce a duplicate task.
1141 // Note that if we did the tests in the reverse order (i.e. check
1142 // result then check queued bit), we could get the result bit before
1143 // the compilation completed, and the queue bit after the compilation
1144 // completed, and end up introducing a "duplicate" (redundant) task.
1145 // In that case, the compiler thread should first check if a method
1146 // has already been compiled before trying to compile it.
1147 // NOTE: in the event that there are multiple compiler threads and
1148 // there is de-optimization/recompilation, things will get hairy,
1149 // and in that case it's best to protect both the testing (here) of
1150 // these bits, and their updating (here and elsewhere) under a
1151 // common lock.
1152 task = create_compile_task(queue,
1153 compile_id, method,
1154 osr_bci, comp_level,
1155 hot_method, hot_count, comment,
1156 blocking);
1157 }
1159 if (blocking) {
1160 wait_for_completion(task);
1161 }
1162 }
1165 nmethod* CompileBroker::compile_method(methodHandle method, int osr_bci,
1166 int comp_level,
1167 methodHandle hot_method, int hot_count,
1168 const char* comment, Thread* THREAD) {
1169 // make sure arguments make sense
1170 assert(method->method_holder()->klass_part()->oop_is_instance(), "not an instance method");
1171 assert(osr_bci == InvocationEntryBci || (0 <= osr_bci && osr_bci < method->code_size()), "bci out of range");
1172 assert(!method->is_abstract() && (osr_bci == InvocationEntryBci || !method->is_native()), "cannot compile abstract/native methods");
1173 assert(!instanceKlass::cast(method->method_holder())->is_not_initialized(), "method holder must be initialized");
1175 if (!TieredCompilation) {
1176 comp_level = CompLevel_highest_tier;
1177 }
1179 // return quickly if possible
1181 // lock, make sure that the compilation
1182 // isn't prohibited in a straightforward way.
1184 if (compiler(comp_level) == NULL || compilation_is_prohibited(method, osr_bci, comp_level)) {
1185 return NULL;
1186 }
1188 if (osr_bci == InvocationEntryBci) {
1189 // standard compilation
1190 nmethod* method_code = method->code();
1191 if (method_code != NULL) {
1192 if (compilation_is_complete(method, osr_bci, comp_level)) {
1193 return method_code;
1194 }
1195 }
1196 if (method->is_not_compilable(comp_level)) return NULL;
1198 if (UseCodeCacheFlushing) {
1199 nmethod* saved = CodeCache::find_and_remove_saved_code(method());
1200 if (saved != NULL) {
1201 method->set_code(method, saved);
1202 return saved;
1203 }
1204 }
1206 } else {
1207 // osr compilation
1208 #ifndef TIERED
1209 // seems like an assert of dubious value
1210 assert(comp_level == CompLevel_highest_tier,
1211 "all OSR compiles are assumed to be at a single compilation lavel");
1212 #endif // TIERED
1213 // We accept a higher level osr method
1214 nmethod* nm = method->lookup_osr_nmethod_for(osr_bci, comp_level, false);
1215 if (nm != NULL) return nm;
1216 if (method->is_not_osr_compilable()) return NULL;
1217 }
1219 assert(!HAS_PENDING_EXCEPTION, "No exception should be present");
1220 // some prerequisites that are compiler specific
1221 if (compiler(comp_level)->is_c2() || compiler(comp_level)->is_shark()) {
1222 method->constants()->resolve_string_constants(CHECK_AND_CLEAR_NULL);
1223 // Resolve all classes seen in the signature of the method
1224 // we are compiling.
1225 methodOopDesc::load_signature_classes(method, CHECK_AND_CLEAR_NULL);
1226 }
1228 // If the method is native, do the lookup in the thread requesting
1229 // the compilation. Native lookups can load code, which is not
1230 // permitted during compilation.
1231 //
1232 // Note: A native method implies non-osr compilation which is
1233 // checked with an assertion at the entry of this method.
1234 if (method->is_native()) {
1235 bool in_base_library;
1236 address adr = NativeLookup::lookup(method, in_base_library, THREAD);
1237 if (HAS_PENDING_EXCEPTION) {
1238 // In case of an exception looking up the method, we just forget
1239 // about it. The interpreter will kick-in and throw the exception.
1240 method->set_not_compilable(); // implies is_not_osr_compilable()
1241 CLEAR_PENDING_EXCEPTION;
1242 return NULL;
1243 }
1244 assert(method->has_native_function(), "must have native code by now");
1245 }
1247 // RedefineClasses() has replaced this method; just return
1248 if (method->is_old()) {
1249 return NULL;
1250 }
1252 // JVMTI -- post_compile_event requires jmethod_id() that may require
1253 // a lock the compiling thread can not acquire. Prefetch it here.
1254 if (JvmtiExport::should_post_compiled_method_load()) {
1255 method->jmethod_id();
1256 }
1258 // If the compiler is shut off due to code cache flushing or otherwise,
1259 // fail out now so blocking compiles dont hang the java thread
1260 if (!should_compile_new_jobs() || (UseCodeCacheFlushing && CodeCache::needs_flushing())) {
1261 CompilationPolicy::policy()->delay_compilation(method());
1262 return NULL;
1263 }
1265 // do the compilation
1266 if (method->is_native()) {
1267 if (!PreferInterpreterNativeStubs) {
1268 // Acquire our lock.
1269 int compile_id;
1270 {
1271 MutexLocker locker(MethodCompileQueue_lock, THREAD);
1272 compile_id = assign_compile_id(method, standard_entry_bci);
1273 }
1274 (void) AdapterHandlerLibrary::create_native_wrapper(method, compile_id);
1275 } else {
1276 return NULL;
1277 }
1278 } else {
1279 compile_method_base(method, osr_bci, comp_level, hot_method, hot_count, comment, THREAD);
1280 }
1282 // return requested nmethod
1283 // We accept a higher level osr method
1284 return osr_bci == InvocationEntryBci ? method->code() : method->lookup_osr_nmethod_for(osr_bci, comp_level, false);
1285 }
1288 // ------------------------------------------------------------------
1289 // CompileBroker::compilation_is_complete
1290 //
1291 // See if compilation of this method is already complete.
1292 bool CompileBroker::compilation_is_complete(methodHandle method,
1293 int osr_bci,
1294 int comp_level) {
1295 bool is_osr = (osr_bci != standard_entry_bci);
1296 if (is_osr) {
1297 if (method->is_not_osr_compilable()) {
1298 return true;
1299 } else {
1300 nmethod* result = method->lookup_osr_nmethod_for(osr_bci, comp_level, true);
1301 return (result != NULL);
1302 }
1303 } else {
1304 if (method->is_not_compilable(comp_level)) {
1305 return true;
1306 } else {
1307 nmethod* result = method->code();
1308 if (result == NULL) return false;
1309 return comp_level == result->comp_level();
1310 }
1311 }
1312 }
1315 // ------------------------------------------------------------------
1316 // CompileBroker::compilation_is_in_queue
1317 //
1318 // See if this compilation is already requested.
1319 //
1320 // Implementation note: there is only a single "is in queue" bit
1321 // for each method. This means that the check below is overly
1322 // conservative in the sense that an osr compilation in the queue
1323 // will block a normal compilation from entering the queue (and vice
1324 // versa). This can be remedied by a full queue search to disambiguate
1325 // cases. If it is deemed profitible, this may be done.
1326 bool CompileBroker::compilation_is_in_queue(methodHandle method,
1327 int osr_bci) {
1328 return method->queued_for_compilation();
1329 }
1331 // ------------------------------------------------------------------
1332 // CompileBroker::compilation_is_prohibited
1333 //
1334 // See if this compilation is not allowed.
1335 bool CompileBroker::compilation_is_prohibited(methodHandle method, int osr_bci, int comp_level) {
1336 bool is_native = method->is_native();
1337 // Some compilers may not support the compilation of natives.
1338 if (is_native &&
1339 (!CICompileNatives || !compiler(comp_level)->supports_native())) {
1340 method->set_not_compilable_quietly(comp_level);
1341 return true;
1342 }
1344 bool is_osr = (osr_bci != standard_entry_bci);
1345 // Some compilers may not support on stack replacement.
1346 if (is_osr &&
1347 (!CICompileOSR || !compiler(comp_level)->supports_osr())) {
1348 method->set_not_osr_compilable();
1349 return true;
1350 }
1352 // The method may be explicitly excluded by the user.
1353 bool quietly;
1354 if (CompilerOracle::should_exclude(method, quietly)) {
1355 if (!quietly) {
1356 // This does not happen quietly...
1357 ResourceMark rm;
1358 tty->print("### Excluding %s:%s",
1359 method->is_native() ? "generation of native wrapper" : "compile",
1360 (method->is_static() ? " static" : ""));
1361 method->print_short_name(tty);
1362 tty->cr();
1363 }
1364 method->set_not_compilable_quietly();
1365 }
1367 return false;
1368 }
1371 // ------------------------------------------------------------------
1372 // CompileBroker::assign_compile_id
1373 //
1374 // Assign a serialized id number to this compilation request. If the
1375 // number falls out of the allowed range, return a 0. OSR
1376 // compilations may be numbered separately from regular compilations
1377 // if certain debugging flags are used.
1378 uint CompileBroker::assign_compile_id(methodHandle method, int osr_bci) {
1379 assert(MethodCompileQueue_lock->owner() == Thread::current(),
1380 "must hold the compilation queue lock");
1381 bool is_osr = (osr_bci != standard_entry_bci);
1382 uint id;
1383 if (CICountOSR && is_osr) {
1384 id = ++_osr_compilation_id;
1385 if ((uint)CIStartOSR <= id && id < (uint)CIStopOSR) {
1386 return id;
1387 }
1388 } else {
1389 id = ++_compilation_id;
1390 if ((uint)CIStart <= id && id < (uint)CIStop) {
1391 return id;
1392 }
1393 }
1395 // Method was not in the appropriate compilation range.
1396 method->set_not_compilable_quietly();
1397 return 0;
1398 }
1401 // ------------------------------------------------------------------
1402 // CompileBroker::is_compile_blocking
1403 //
1404 // Should the current thread be blocked until this compilation request
1405 // has been fulfilled?
1406 bool CompileBroker::is_compile_blocking(methodHandle method, int osr_bci) {
1407 assert(!instanceRefKlass::owns_pending_list_lock(JavaThread::current()), "possible deadlock");
1408 return !BackgroundCompilation;
1409 }
1412 // ------------------------------------------------------------------
1413 // CompileBroker::preload_classes
1414 void CompileBroker::preload_classes(methodHandle method, TRAPS) {
1415 // Move this code over from c1_Compiler.cpp
1416 ShouldNotReachHere();
1417 }
1420 // ------------------------------------------------------------------
1421 // CompileBroker::create_compile_task
1422 //
1423 // Create a CompileTask object representing the current request for
1424 // compilation. Add this task to the queue.
1425 CompileTask* CompileBroker::create_compile_task(CompileQueue* queue,
1426 int compile_id,
1427 methodHandle method,
1428 int osr_bci,
1429 int comp_level,
1430 methodHandle hot_method,
1431 int hot_count,
1432 const char* comment,
1433 bool blocking) {
1434 CompileTask* new_task = allocate_task();
1435 new_task->initialize(compile_id, method, osr_bci, comp_level,
1436 hot_method, hot_count, comment,
1437 blocking);
1438 queue->add(new_task);
1439 return new_task;
1440 }
1443 // ------------------------------------------------------------------
1444 // CompileBroker::allocate_task
1445 //
1446 // Allocate a CompileTask, from the free list if possible.
1447 CompileTask* CompileBroker::allocate_task() {
1448 MutexLocker locker(CompileTaskAlloc_lock);
1449 CompileTask* task = NULL;
1450 if (_task_free_list != NULL) {
1451 task = _task_free_list;
1452 _task_free_list = task->next();
1453 task->set_next(NULL);
1454 } else {
1455 task = new CompileTask();
1456 task->set_next(NULL);
1457 }
1458 return task;
1459 }
1462 // ------------------------------------------------------------------
1463 // CompileBroker::free_task
1464 //
1465 // Add a task to the free list.
1466 void CompileBroker::free_task(CompileTask* task) {
1467 MutexLocker locker(CompileTaskAlloc_lock);
1468 task->free();
1469 task->set_next(_task_free_list);
1470 _task_free_list = task;
1471 }
1474 // ------------------------------------------------------------------
1475 // CompileBroker::wait_for_completion
1476 //
1477 // Wait for the given method CompileTask to complete.
1478 void CompileBroker::wait_for_completion(CompileTask* task) {
1479 if (CIPrintCompileQueue) {
1480 tty->print_cr("BLOCKING FOR COMPILE");
1481 }
1483 assert(task->is_blocking(), "can only wait on blocking task");
1485 JavaThread *thread = JavaThread::current();
1486 thread->set_blocked_on_compilation(true);
1488 methodHandle method(thread,
1489 (methodOop)JNIHandles::resolve(task->method_handle()));
1490 {
1491 MutexLocker waiter(task->lock(), thread);
1493 while (!task->is_complete())
1494 task->lock()->wait();
1495 }
1496 // It is harmless to check this status without the lock, because
1497 // completion is a stable property (until the task object is recycled).
1498 assert(task->is_complete(), "Compilation should have completed");
1499 assert(task->code_handle() == NULL, "must be reset");
1501 thread->set_blocked_on_compilation(false);
1503 // By convention, the waiter is responsible for recycling a
1504 // blocking CompileTask. Since there is only one waiter ever
1505 // waiting on a CompileTask, we know that no one else will
1506 // be using this CompileTask; we can free it.
1507 free_task(task);
1508 }
1510 // ------------------------------------------------------------------
1511 // CompileBroker::compiler_thread_loop
1512 //
1513 // The main loop run by a CompilerThread.
1514 void CompileBroker::compiler_thread_loop() {
1515 CompilerThread* thread = CompilerThread::current();
1516 CompileQueue* queue = thread->queue();
1518 // For the thread that initializes the ciObjectFactory
1519 // this resource mark holds all the shared objects
1520 ResourceMark rm;
1522 // First thread to get here will initialize the compiler interface
1524 if (!ciObjectFactory::is_initialized()) {
1525 ASSERT_IN_VM;
1526 MutexLocker only_one (CompileThread_lock, thread);
1527 if (!ciObjectFactory::is_initialized()) {
1528 ciObjectFactory::initialize();
1529 }
1530 }
1532 // Open a log.
1533 if (LogCompilation) {
1534 init_compiler_thread_log();
1535 }
1536 CompileLog* log = thread->log();
1537 if (log != NULL) {
1538 log->begin_elem("start_compile_thread thread='" UINTX_FORMAT "' process='%d'",
1539 os::current_thread_id(),
1540 os::current_process_id());
1541 log->stamp();
1542 log->end_elem();
1543 }
1545 while (true) {
1546 {
1547 // We need this HandleMark to avoid leaking VM handles.
1548 HandleMark hm(thread);
1550 if (CodeCache::largest_free_block() < CodeCacheMinimumFreeSpace) {
1551 // the code cache is really full
1552 handle_full_code_cache();
1553 } else if (UseCodeCacheFlushing && CodeCache::needs_flushing()) {
1554 // Attempt to start cleaning the code cache while there is still a little headroom
1555 NMethodSweeper::handle_full_code_cache(false);
1556 }
1558 CompileTask* task = queue->get();
1560 // Give compiler threads an extra quanta. They tend to be bursty and
1561 // this helps the compiler to finish up the job.
1562 if( CompilerThreadHintNoPreempt )
1563 os::hint_no_preempt();
1565 // trace per thread time and compile statistics
1566 CompilerCounters* counters = ((CompilerThread*)thread)->counters();
1567 PerfTraceTimedEvent(counters->time_counter(), counters->compile_counter());
1569 // Assign the task to the current thread. Mark this compilation
1570 // thread as active for the profiler.
1571 CompileTaskWrapper ctw(task);
1572 nmethodLocker result_handle; // (handle for the nmethod produced by this task)
1573 task->set_code_handle(&result_handle);
1574 methodHandle method(thread,
1575 (methodOop)JNIHandles::resolve(task->method_handle()));
1577 // Never compile a method if breakpoints are present in it
1578 if (method()->number_of_breakpoints() == 0) {
1579 // Compile the method.
1580 if ((UseCompiler || AlwaysCompileLoopMethods) && CompileBroker::should_compile_new_jobs()) {
1581 #ifdef COMPILER1
1582 // Allow repeating compilations for the purpose of benchmarking
1583 // compile speed. This is not useful for customers.
1584 if (CompilationRepeat != 0) {
1585 int compile_count = CompilationRepeat;
1586 while (compile_count > 0) {
1587 invoke_compiler_on_method(task);
1588 nmethod* nm = method->code();
1589 if (nm != NULL) {
1590 nm->make_zombie();
1591 method->clear_code();
1592 }
1593 compile_count--;
1594 }
1595 }
1596 #endif /* COMPILER1 */
1597 invoke_compiler_on_method(task);
1598 } else {
1599 // After compilation is disabled, remove remaining methods from queue
1600 method->clear_queued_for_compilation();
1601 }
1602 }
1603 }
1604 }
1605 }
1608 // ------------------------------------------------------------------
1609 // CompileBroker::init_compiler_thread_log
1610 //
1611 // Set up state required by +LogCompilation.
1612 void CompileBroker::init_compiler_thread_log() {
1613 CompilerThread* thread = CompilerThread::current();
1614 char fileBuf[4*K];
1615 FILE* fp = NULL;
1616 char* file = NULL;
1617 intx thread_id = os::current_thread_id();
1618 for (int try_temp_dir = 1; try_temp_dir >= 0; try_temp_dir--) {
1619 const char* dir = (try_temp_dir ? os::get_temp_directory() : NULL);
1620 if (dir == NULL) {
1621 jio_snprintf(fileBuf, sizeof(fileBuf), "hs_c" UINTX_FORMAT "_pid%u.log",
1622 thread_id, os::current_process_id());
1623 } else {
1624 jio_snprintf(fileBuf, sizeof(fileBuf),
1625 "%s%shs_c" UINTX_FORMAT "_pid%u.log", dir,
1626 os::file_separator(), thread_id, os::current_process_id());
1627 }
1628 fp = fopen(fileBuf, "at");
1629 if (fp != NULL) {
1630 file = NEW_C_HEAP_ARRAY(char, strlen(fileBuf)+1);
1631 strcpy(file, fileBuf);
1632 break;
1633 }
1634 }
1635 if (fp == NULL) {
1636 warning("Cannot open log file: %s", fileBuf);
1637 } else {
1638 if (LogCompilation && Verbose)
1639 tty->print_cr("Opening compilation log %s", file);
1640 CompileLog* log = new(ResourceObj::C_HEAP) CompileLog(file, fp, thread_id);
1641 thread->init_log(log);
1643 if (xtty != NULL) {
1644 ttyLocker ttyl;
1646 // Record any per thread log files
1647 xtty->elem("thread_logfile thread='%d' filename='%s'", thread_id, file);
1648 }
1649 }
1650 }
1652 // ------------------------------------------------------------------
1653 // CompileBroker::set_should_block
1654 //
1655 // Set _should_block.
1656 // Call this from the VM, with Threads_lock held and a safepoint requested.
1657 void CompileBroker::set_should_block() {
1658 assert(Threads_lock->owner() == Thread::current(), "must have threads lock");
1659 assert(SafepointSynchronize::is_at_safepoint(), "must be at a safepoint already");
1660 #ifndef PRODUCT
1661 if (PrintCompilation && (Verbose || WizardMode))
1662 tty->print_cr("notifying compiler thread pool to block");
1663 #endif
1664 _should_block = true;
1665 }
1667 // ------------------------------------------------------------------
1668 // CompileBroker::maybe_block
1669 //
1670 // Call this from the compiler at convenient points, to poll for _should_block.
1671 void CompileBroker::maybe_block() {
1672 if (_should_block) {
1673 #ifndef PRODUCT
1674 if (PrintCompilation && (Verbose || WizardMode))
1675 tty->print_cr("compiler thread " INTPTR_FORMAT " poll detects block request", Thread::current());
1676 #endif
1677 ThreadInVMfromNative tivfn(JavaThread::current());
1678 }
1679 }
1682 // ------------------------------------------------------------------
1683 // CompileBroker::invoke_compiler_on_method
1684 //
1685 // Compile a method.
1686 //
1687 void CompileBroker::invoke_compiler_on_method(CompileTask* task) {
1688 if (PrintCompilation) {
1689 ResourceMark rm;
1690 task->print_line();
1691 }
1692 elapsedTimer time;
1694 CompilerThread* thread = CompilerThread::current();
1695 ResourceMark rm(thread);
1697 if (LogEvents) {
1698 _compilation_log->log_compile(thread, task);
1699 }
1701 // Common flags.
1702 uint compile_id = task->compile_id();
1703 int osr_bci = task->osr_bci();
1704 bool is_osr = (osr_bci != standard_entry_bci);
1705 bool should_log = (thread->log() != NULL);
1706 bool should_break = false;
1707 {
1708 // create the handle inside it's own block so it can't
1709 // accidentally be referenced once the thread transitions to
1710 // native. The NoHandleMark before the transition should catch
1711 // any cases where this occurs in the future.
1712 methodHandle method(thread,
1713 (methodOop)JNIHandles::resolve(task->method_handle()));
1714 should_break = check_break_at(method, compile_id, is_osr);
1715 if (should_log && !CompilerOracle::should_log(method)) {
1716 should_log = false;
1717 }
1718 assert(!method->is_native(), "no longer compile natives");
1720 // Save information about this method in case of failure.
1721 set_last_compile(thread, method, is_osr, task->comp_level());
1723 DTRACE_METHOD_COMPILE_BEGIN_PROBE(compiler(task->comp_level()), method);
1724 }
1726 // Allocate a new set of JNI handles.
1727 push_jni_handle_block();
1728 jobject target_handle = JNIHandles::make_local(thread, JNIHandles::resolve(task->method_handle()));
1729 int compilable = ciEnv::MethodCompilable;
1730 {
1731 int system_dictionary_modification_counter;
1732 {
1733 MutexLocker locker(Compile_lock, thread);
1734 system_dictionary_modification_counter = SystemDictionary::number_of_modifications();
1735 }
1737 NoHandleMark nhm;
1738 ThreadToNativeFromVM ttn(thread);
1740 ciEnv ci_env(task, system_dictionary_modification_counter);
1741 if (should_break) {
1742 ci_env.set_break_at_compile(true);
1743 }
1744 if (should_log) {
1745 ci_env.set_log(thread->log());
1746 }
1747 assert(thread->env() == &ci_env, "set by ci_env");
1748 // The thread-env() field is cleared in ~CompileTaskWrapper.
1750 // Cache Jvmti state
1751 ci_env.cache_jvmti_state();
1753 // Cache DTrace flags
1754 ci_env.cache_dtrace_flags();
1756 ciMethod* target = ci_env.get_method_from_handle(target_handle);
1758 TraceTime t1("compilation", &time);
1760 compiler(task->comp_level())->compile_method(&ci_env, target, osr_bci);
1762 if (!ci_env.failing() && task->code() == NULL) {
1763 //assert(false, "compiler should always document failure");
1764 // The compiler elected, without comment, not to register a result.
1765 // Do not attempt further compilations of this method.
1766 ci_env.record_method_not_compilable("compile failed", !TieredCompilation);
1767 }
1769 // Copy this bit to the enclosing block:
1770 compilable = ci_env.compilable();
1772 if (ci_env.failing()) {
1773 const char* retry_message = ci_env.retry_message();
1774 if (_compilation_log != NULL) {
1775 _compilation_log->log_failure(thread, task, ci_env.failure_reason(), retry_message);
1776 }
1777 if (PrintCompilation) {
1778 tty->print("%4d COMPILE SKIPPED: %s", compile_id, ci_env.failure_reason());
1779 if (retry_message != NULL) {
1780 tty->print(" (%s)", retry_message);
1781 }
1782 tty->cr();
1783 }
1784 } else {
1785 task->mark_success();
1786 task->set_num_inlined_bytecodes(ci_env.num_inlined_bytecodes());
1787 if (_compilation_log != NULL) {
1788 nmethod* code = task->code();
1789 if (code != NULL) {
1790 _compilation_log->log_nmethod(thread, code);
1791 }
1792 }
1793 }
1794 }
1795 pop_jni_handle_block();
1797 methodHandle method(thread,
1798 (methodOop)JNIHandles::resolve(task->method_handle()));
1800 DTRACE_METHOD_COMPILE_END_PROBE(compiler(task->comp_level()), method, task->is_success());
1802 collect_statistics(thread, time, task);
1804 if (PrintCompilation && PrintCompilation2) {
1805 tty->print("%7d ", (int) tty->time_stamp().milliseconds()); // print timestamp
1806 tty->print("%4d ", compile_id); // print compilation number
1807 tty->print("%s ", (is_osr ? "%" : " "));
1808 int code_size = (task->code() == NULL) ? 0 : task->code()->total_size();
1809 tty->print_cr("size: %d time: %d inlined: %d bytes", code_size, (int)time.milliseconds(), task->num_inlined_bytecodes());
1810 }
1812 if (compilable == ciEnv::MethodCompilable_never) {
1813 if (is_osr) {
1814 method->set_not_osr_compilable();
1815 } else {
1816 method->set_not_compilable_quietly();
1817 }
1818 } else if (compilable == ciEnv::MethodCompilable_not_at_tier) {
1819 method->set_not_compilable_quietly(task->comp_level());
1820 }
1822 // Note that the queued_for_compilation bits are cleared without
1823 // protection of a mutex. [They were set by the requester thread,
1824 // when adding the task to the complie queue -- at which time the
1825 // compile queue lock was held. Subsequently, we acquired the compile
1826 // queue lock to get this task off the compile queue; thus (to belabour
1827 // the point somewhat) our clearing of the bits must be occurring
1828 // only after the setting of the bits. See also 14012000 above.
1829 method->clear_queued_for_compilation();
1831 #ifdef ASSERT
1832 if (CollectedHeap::fired_fake_oom()) {
1833 // The current compile received a fake OOM during compilation so
1834 // go ahead and exit the VM since the test apparently succeeded
1835 tty->print_cr("*** Shutting down VM after successful fake OOM");
1836 vm_exit(0);
1837 }
1838 #endif
1839 }
1841 // ------------------------------------------------------------------
1842 // CompileBroker::handle_full_code_cache
1843 //
1844 // The CodeCache is full. Print out warning and disable compilation or
1845 // try code cache cleaning so compilation can continue later.
1846 void CompileBroker::handle_full_code_cache() {
1847 UseInterpreter = true;
1848 if (UseCompiler || AlwaysCompileLoopMethods ) {
1849 if (xtty != NULL) {
1850 stringStream s;
1851 // Dump code cache state into a buffer before locking the tty,
1852 // because log_state() will use locks causing lock conflicts.
1853 CodeCache::log_state(&s);
1854 // Lock to prevent tearing
1855 ttyLocker ttyl;
1856 xtty->begin_elem("code_cache_full");
1857 xtty->print(s.as_string());
1858 xtty->stamp();
1859 xtty->end_elem();
1860 }
1861 warning("CodeCache is full. Compiler has been disabled.");
1862 warning("Try increasing the code cache size using -XX:ReservedCodeCacheSize=");
1863 CodeCache::print_bounds(tty);
1864 #ifndef PRODUCT
1865 if (CompileTheWorld || ExitOnFullCodeCache) {
1866 before_exit(JavaThread::current());
1867 exit_globals(); // will delete tty
1868 vm_direct_exit(CompileTheWorld ? 0 : 1);
1869 }
1870 #endif
1871 if (UseCodeCacheFlushing) {
1872 NMethodSweeper::handle_full_code_cache(true);
1873 } else {
1874 UseCompiler = false;
1875 AlwaysCompileLoopMethods = false;
1876 }
1877 }
1878 }
1880 // ------------------------------------------------------------------
1881 // CompileBroker::set_last_compile
1882 //
1883 // Record this compilation for debugging purposes.
1884 void CompileBroker::set_last_compile(CompilerThread* thread, methodHandle method, bool is_osr, int comp_level) {
1885 ResourceMark rm;
1886 char* method_name = method->name()->as_C_string();
1887 strncpy(_last_method_compiled, method_name, CompileBroker::name_buffer_length);
1888 char current_method[CompilerCounters::cmname_buffer_length];
1889 size_t maxLen = CompilerCounters::cmname_buffer_length;
1891 if (UsePerfData) {
1892 const char* class_name = method->method_holder()->klass_part()->name()->as_C_string();
1894 size_t s1len = strlen(class_name);
1895 size_t s2len = strlen(method_name);
1897 // check if we need to truncate the string
1898 if (s1len + s2len + 2 > maxLen) {
1900 // the strategy is to lop off the leading characters of the
1901 // class name and the trailing characters of the method name.
1903 if (s2len + 2 > maxLen) {
1904 // lop of the entire class name string, let snprintf handle
1905 // truncation of the method name.
1906 class_name += s1len; // null string
1907 }
1908 else {
1909 // lop off the extra characters from the front of the class name
1910 class_name += ((s1len + s2len + 2) - maxLen);
1911 }
1912 }
1914 jio_snprintf(current_method, maxLen, "%s %s", class_name, method_name);
1915 }
1917 if (CICountOSR && is_osr) {
1918 _last_compile_type = osr_compile;
1919 } else {
1920 _last_compile_type = normal_compile;
1921 }
1922 _last_compile_level = comp_level;
1924 if (UsePerfData) {
1925 CompilerCounters* counters = thread->counters();
1926 counters->set_current_method(current_method);
1927 counters->set_compile_type((jlong)_last_compile_type);
1928 }
1929 }
1932 // ------------------------------------------------------------------
1933 // CompileBroker::push_jni_handle_block
1934 //
1935 // Push on a new block of JNI handles.
1936 void CompileBroker::push_jni_handle_block() {
1937 JavaThread* thread = JavaThread::current();
1939 // Allocate a new block for JNI handles.
1940 // Inlined code from jni_PushLocalFrame()
1941 JNIHandleBlock* java_handles = thread->active_handles();
1942 JNIHandleBlock* compile_handles = JNIHandleBlock::allocate_block(thread);
1943 assert(compile_handles != NULL && java_handles != NULL, "should not be NULL");
1944 compile_handles->set_pop_frame_link(java_handles); // make sure java handles get gc'd.
1945 thread->set_active_handles(compile_handles);
1946 }
1949 // ------------------------------------------------------------------
1950 // CompileBroker::pop_jni_handle_block
1951 //
1952 // Pop off the current block of JNI handles.
1953 void CompileBroker::pop_jni_handle_block() {
1954 JavaThread* thread = JavaThread::current();
1956 // Release our JNI handle block
1957 JNIHandleBlock* compile_handles = thread->active_handles();
1958 JNIHandleBlock* java_handles = compile_handles->pop_frame_link();
1959 thread->set_active_handles(java_handles);
1960 compile_handles->set_pop_frame_link(NULL);
1961 JNIHandleBlock::release_block(compile_handles, thread); // may block
1962 }
1965 // ------------------------------------------------------------------
1966 // CompileBroker::check_break_at
1967 //
1968 // Should the compilation break at the current compilation.
1969 bool CompileBroker::check_break_at(methodHandle method, int compile_id, bool is_osr) {
1970 if (CICountOSR && is_osr && (compile_id == CIBreakAtOSR)) {
1971 return true;
1972 } else if( CompilerOracle::should_break_at(method) ) { // break when compiling
1973 return true;
1974 } else {
1975 return (compile_id == CIBreakAt);
1976 }
1977 }
1979 // ------------------------------------------------------------------
1980 // CompileBroker::collect_statistics
1981 //
1982 // Collect statistics about the compilation.
1984 void CompileBroker::collect_statistics(CompilerThread* thread, elapsedTimer time, CompileTask* task) {
1985 bool success = task->is_success();
1986 methodHandle method (thread, (methodOop)JNIHandles::resolve(task->method_handle()));
1987 uint compile_id = task->compile_id();
1988 bool is_osr = (task->osr_bci() != standard_entry_bci);
1989 nmethod* code = task->code();
1990 CompilerCounters* counters = thread->counters();
1992 assert(code == NULL || code->is_locked_by_vm(), "will survive the MutexLocker");
1993 MutexLocker locker(CompileStatistics_lock);
1995 // _perf variables are production performance counters which are
1996 // updated regardless of the setting of the CITime and CITimeEach flags
1997 //
1998 if (!success) {
1999 _total_bailout_count++;
2000 if (UsePerfData) {
2001 _perf_last_failed_method->set_value(counters->current_method());
2002 _perf_last_failed_type->set_value(counters->compile_type());
2003 _perf_total_bailout_count->inc();
2004 }
2005 } else if (code == NULL) {
2006 if (UsePerfData) {
2007 _perf_last_invalidated_method->set_value(counters->current_method());
2008 _perf_last_invalidated_type->set_value(counters->compile_type());
2009 _perf_total_invalidated_count->inc();
2010 }
2011 _total_invalidated_count++;
2012 } else {
2013 // Compilation succeeded
2015 // update compilation ticks - used by the implementation of
2016 // java.lang.management.CompilationMBean
2017 _perf_total_compilation->inc(time.ticks());
2019 if (CITime) {
2020 _t_total_compilation.add(time);
2021 if (is_osr) {
2022 _t_osr_compilation.add(time);
2023 _sum_osr_bytes_compiled += method->code_size() + task->num_inlined_bytecodes();
2024 } else {
2025 _t_standard_compilation.add(time);
2026 _sum_standard_bytes_compiled += method->code_size() + task->num_inlined_bytecodes();
2027 }
2028 }
2030 if (UsePerfData) {
2031 // save the name of the last method compiled
2032 _perf_last_method->set_value(counters->current_method());
2033 _perf_last_compile_type->set_value(counters->compile_type());
2034 _perf_last_compile_size->set_value(method->code_size() +
2035 task->num_inlined_bytecodes());
2036 if (is_osr) {
2037 _perf_osr_compilation->inc(time.ticks());
2038 _perf_sum_osr_bytes_compiled->inc(method->code_size() + task->num_inlined_bytecodes());
2039 } else {
2040 _perf_standard_compilation->inc(time.ticks());
2041 _perf_sum_standard_bytes_compiled->inc(method->code_size() + task->num_inlined_bytecodes());
2042 }
2043 }
2045 if (CITimeEach) {
2046 float bytes_per_sec = 1.0 * (method->code_size() + task->num_inlined_bytecodes()) / time.seconds();
2047 tty->print_cr("%3d seconds: %f bytes/sec : %f (bytes %d + %d inlined)",
2048 compile_id, time.seconds(), bytes_per_sec, method->code_size(), task->num_inlined_bytecodes());
2049 }
2051 // Collect counts of successful compilations
2052 _sum_nmethod_size += code->total_size();
2053 _sum_nmethod_code_size += code->insts_size();
2054 _total_compile_count++;
2056 if (UsePerfData) {
2057 _perf_sum_nmethod_size->inc( code->total_size());
2058 _perf_sum_nmethod_code_size->inc(code->insts_size());
2059 _perf_total_compile_count->inc();
2060 }
2062 if (is_osr) {
2063 if (UsePerfData) _perf_total_osr_compile_count->inc();
2064 _total_osr_compile_count++;
2065 } else {
2066 if (UsePerfData) _perf_total_standard_compile_count->inc();
2067 _total_standard_compile_count++;
2068 }
2069 }
2070 // set the current method for the thread to null
2071 if (UsePerfData) counters->set_current_method("");
2072 }
2076 void CompileBroker::print_times() {
2077 tty->cr();
2078 tty->print_cr("Accumulated compiler times (for compiled methods only)");
2079 tty->print_cr("------------------------------------------------");
2080 //0000000000111111111122222222223333333333444444444455555555556666666666
2081 //0123456789012345678901234567890123456789012345678901234567890123456789
2082 tty->print_cr(" Total compilation time : %6.3f s", CompileBroker::_t_total_compilation.seconds());
2083 tty->print_cr(" Standard compilation : %6.3f s, Average : %2.3f",
2084 CompileBroker::_t_standard_compilation.seconds(),
2085 CompileBroker::_t_standard_compilation.seconds() / CompileBroker::_total_standard_compile_count);
2086 tty->print_cr(" On stack replacement : %6.3f s, Average : %2.3f", CompileBroker::_t_osr_compilation.seconds(), CompileBroker::_t_osr_compilation.seconds() / CompileBroker::_total_osr_compile_count);
2088 if (compiler(CompLevel_simple) != NULL) {
2089 compiler(CompLevel_simple)->print_timers();
2090 }
2091 if (compiler(CompLevel_full_optimization) != NULL) {
2092 compiler(CompLevel_full_optimization)->print_timers();
2093 }
2094 tty->cr();
2095 int tcb = CompileBroker::_sum_osr_bytes_compiled + CompileBroker::_sum_standard_bytes_compiled;
2096 tty->print_cr(" Total compiled bytecodes : %6d bytes", tcb);
2097 tty->print_cr(" Standard compilation : %6d bytes", CompileBroker::_sum_standard_bytes_compiled);
2098 tty->print_cr(" On stack replacement : %6d bytes", CompileBroker::_sum_osr_bytes_compiled);
2099 int bps = (int)(tcb / CompileBroker::_t_total_compilation.seconds());
2100 tty->print_cr(" Average compilation speed: %6d bytes/s", bps);
2101 tty->cr();
2102 tty->print_cr(" nmethod code size : %6d bytes", CompileBroker::_sum_nmethod_code_size);
2103 tty->print_cr(" nmethod total size : %6d bytes", CompileBroker::_sum_nmethod_size);
2104 }
2107 // Debugging output for failure
2108 void CompileBroker::print_last_compile() {
2109 if ( _last_compile_level != CompLevel_none &&
2110 compiler(_last_compile_level) != NULL &&
2111 _last_method_compiled != NULL &&
2112 _last_compile_type != no_compile) {
2113 if (_last_compile_type == osr_compile) {
2114 tty->print_cr("Last parse: [osr]%d+++(%d) %s",
2115 _osr_compilation_id, _last_compile_level, _last_method_compiled);
2116 } else {
2117 tty->print_cr("Last parse: %d+++(%d) %s",
2118 _compilation_id, _last_compile_level, _last_method_compiled);
2119 }
2120 }
2121 }
2124 void CompileBroker::print_compiler_threads_on(outputStream* st) {
2125 #ifndef PRODUCT
2126 st->print_cr("Compiler thread printing unimplemented.");
2127 st->cr();
2128 #endif
2129 }