src/share/vm/opto/phase.cpp

Wed, 27 Apr 2016 01:25:04 +0800

author
aoqi
date
Wed, 27 Apr 2016 01:25:04 +0800
changeset 0
f90c822e73f8
child 6876
710a3c8b516e
permissions
-rw-r--r--

Initial load
http://hg.openjdk.java.net/jdk8u/jdk8u/hotspot/
changeset: 6782:28b50d07f6f8
tag: jdk8u25-b17

aoqi@0 1 /*
aoqi@0 2 * Copyright (c) 1997, 2013, Oracle and/or its affiliates. All rights reserved.
aoqi@0 3 * DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER.
aoqi@0 4 *
aoqi@0 5 * This code is free software; you can redistribute it and/or modify it
aoqi@0 6 * under the terms of the GNU General Public License version 2 only, as
aoqi@0 7 * published by the Free Software Foundation.
aoqi@0 8 *
aoqi@0 9 * This code is distributed in the hope that it will be useful, but WITHOUT
aoqi@0 10 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
aoqi@0 11 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License
aoqi@0 12 * version 2 for more details (a copy is included in the LICENSE file that
aoqi@0 13 * accompanied this code).
aoqi@0 14 *
aoqi@0 15 * You should have received a copy of the GNU General Public License version
aoqi@0 16 * 2 along with this work; if not, write to the Free Software Foundation,
aoqi@0 17 * Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA.
aoqi@0 18 *
aoqi@0 19 * Please contact Oracle, 500 Oracle Parkway, Redwood Shores, CA 94065 USA
aoqi@0 20 * or visit www.oracle.com if you need additional information or have any
aoqi@0 21 * questions.
aoqi@0 22 *
aoqi@0 23 */
aoqi@0 24
aoqi@0 25 #include "precompiled.hpp"
aoqi@0 26 #include "code/nmethod.hpp"
aoqi@0 27 #include "compiler/compileBroker.hpp"
aoqi@0 28 #include "opto/compile.hpp"
aoqi@0 29 #include "opto/matcher.hpp"
aoqi@0 30 #include "opto/node.hpp"
aoqi@0 31 #include "opto/phase.hpp"
aoqi@0 32
aoqi@0 33 #ifndef PRODUCT
aoqi@0 34 int Phase::_total_bytes_compiled = 0;
aoqi@0 35
aoqi@0 36 elapsedTimer Phase::_t_totalCompilation;
aoqi@0 37 elapsedTimer Phase::_t_methodCompilation;
aoqi@0 38 elapsedTimer Phase::_t_stubCompilation;
aoqi@0 39 #endif
aoqi@0 40
aoqi@0 41 // The next timers used for LogCompilation
aoqi@0 42 elapsedTimer Phase::_t_parser;
aoqi@0 43 elapsedTimer Phase::_t_optimizer;
aoqi@0 44 elapsedTimer Phase::_t_escapeAnalysis;
aoqi@0 45 elapsedTimer Phase::_t_connectionGraph;
aoqi@0 46 elapsedTimer Phase::_t_idealLoop;
aoqi@0 47 elapsedTimer Phase::_t_ccp;
aoqi@0 48 elapsedTimer Phase::_t_matcher;
aoqi@0 49 elapsedTimer Phase::_t_registerAllocation;
aoqi@0 50 elapsedTimer Phase::_t_output;
aoqi@0 51
aoqi@0 52 #ifndef PRODUCT
aoqi@0 53 elapsedTimer Phase::_t_graphReshaping;
aoqi@0 54 elapsedTimer Phase::_t_scheduler;
aoqi@0 55 elapsedTimer Phase::_t_blockOrdering;
aoqi@0 56 elapsedTimer Phase::_t_macroEliminate;
aoqi@0 57 elapsedTimer Phase::_t_macroExpand;
aoqi@0 58 elapsedTimer Phase::_t_peephole;
aoqi@0 59 elapsedTimer Phase::_t_postalloc_expand;
aoqi@0 60 elapsedTimer Phase::_t_codeGeneration;
aoqi@0 61 elapsedTimer Phase::_t_registerMethod;
aoqi@0 62 elapsedTimer Phase::_t_temporaryTimer1;
aoqi@0 63 elapsedTimer Phase::_t_temporaryTimer2;
aoqi@0 64 elapsedTimer Phase::_t_idealLoopVerify;
aoqi@0 65
aoqi@0 66 // Subtimers for _t_optimizer
aoqi@0 67 elapsedTimer Phase::_t_iterGVN;
aoqi@0 68 elapsedTimer Phase::_t_iterGVN2;
aoqi@0 69 elapsedTimer Phase::_t_incrInline;
aoqi@0 70
aoqi@0 71 // Subtimers for _t_registerAllocation
aoqi@0 72 elapsedTimer Phase::_t_ctorChaitin;
aoqi@0 73 elapsedTimer Phase::_t_buildIFGphysical;
aoqi@0 74 elapsedTimer Phase::_t_computeLive;
aoqi@0 75 elapsedTimer Phase::_t_regAllocSplit;
aoqi@0 76 elapsedTimer Phase::_t_postAllocCopyRemoval;
aoqi@0 77 elapsedTimer Phase::_t_fixupSpills;
aoqi@0 78
aoqi@0 79 // Subtimers for _t_output
aoqi@0 80 elapsedTimer Phase::_t_instrSched;
aoqi@0 81 elapsedTimer Phase::_t_buildOopMaps;
aoqi@0 82 #endif
aoqi@0 83
aoqi@0 84 //------------------------------Phase------------------------------------------
aoqi@0 85 Phase::Phase( PhaseNumber pnum ) : _pnum(pnum), C( pnum == Compiler ? NULL : Compile::current()) {
aoqi@0 86 // Poll for requests from shutdown mechanism to quiesce compiler (4448539, 4448544).
aoqi@0 87 // This is an effective place to poll, since the compiler is full of phases.
aoqi@0 88 // In particular, every inlining site uses a recursively created Parse phase.
aoqi@0 89 CompileBroker::maybe_block();
aoqi@0 90 }
aoqi@0 91
aoqi@0 92 #ifndef PRODUCT
aoqi@0 93 static const double minimum_reported_time = 0.0001; // seconds
aoqi@0 94 static const double expected_method_compile_coverage = 0.97; // %
aoqi@0 95 static const double minimum_meaningful_method_compile = 2.00; // seconds
aoqi@0 96
aoqi@0 97 void Phase::print_timers() {
aoqi@0 98 tty->print_cr ("Accumulated compiler times:");
aoqi@0 99 tty->print_cr ("---------------------------");
aoqi@0 100 tty->print_cr (" Total compilation: %3.3f sec.", Phase::_t_totalCompilation.seconds());
aoqi@0 101 tty->print (" method compilation : %3.3f sec", Phase::_t_methodCompilation.seconds());
aoqi@0 102 tty->print ("/%d bytes",_total_bytes_compiled);
aoqi@0 103 tty->print_cr (" (%3.0f bytes per sec) ", Phase::_total_bytes_compiled / Phase::_t_methodCompilation.seconds());
aoqi@0 104 tty->print_cr (" stub compilation : %3.3f sec.", Phase::_t_stubCompilation.seconds());
aoqi@0 105 tty->print_cr (" Phases:");
aoqi@0 106 tty->print_cr (" parse : %3.3f sec", Phase::_t_parser.seconds());
aoqi@0 107 tty->print_cr (" optimizer : %3.3f sec", Phase::_t_optimizer.seconds());
aoqi@0 108 if( Verbose || WizardMode ) {
aoqi@0 109 if (DoEscapeAnalysis) {
aoqi@0 110 // EA is part of Optimizer.
aoqi@0 111 tty->print_cr (" escape analysis: %3.3f sec", Phase::_t_escapeAnalysis.seconds());
aoqi@0 112 tty->print_cr (" connection graph: %3.3f sec", Phase::_t_connectionGraph.seconds());
aoqi@0 113 tty->print_cr (" macroEliminate : %3.3f sec", Phase::_t_macroEliminate.seconds());
aoqi@0 114 }
aoqi@0 115 tty->print_cr (" iterGVN : %3.3f sec", Phase::_t_iterGVN.seconds());
aoqi@0 116 tty->print_cr (" incrInline : %3.3f sec", Phase::_t_incrInline.seconds());
aoqi@0 117 tty->print_cr (" idealLoop : %3.3f sec", Phase::_t_idealLoop.seconds());
aoqi@0 118 tty->print_cr (" idealLoopVerify: %3.3f sec", Phase::_t_idealLoopVerify.seconds());
aoqi@0 119 tty->print_cr (" ccp : %3.3f sec", Phase::_t_ccp.seconds());
aoqi@0 120 tty->print_cr (" iterGVN2 : %3.3f sec", Phase::_t_iterGVN2.seconds());
aoqi@0 121 tty->print_cr (" macroExpand : %3.3f sec", Phase::_t_macroExpand.seconds());
aoqi@0 122 tty->print_cr (" graphReshape : %3.3f sec", Phase::_t_graphReshaping.seconds());
aoqi@0 123 double optimizer_subtotal = Phase::_t_iterGVN.seconds() + Phase::_t_iterGVN2.seconds() +
aoqi@0 124 Phase::_t_escapeAnalysis.seconds() + Phase::_t_macroEliminate.seconds() +
aoqi@0 125 Phase::_t_idealLoop.seconds() + Phase::_t_ccp.seconds() +
aoqi@0 126 Phase::_t_macroExpand.seconds() + Phase::_t_graphReshaping.seconds();
aoqi@0 127 double percent_of_optimizer = ((optimizer_subtotal == 0.0) ? 0.0 : (optimizer_subtotal / Phase::_t_optimizer.seconds() * 100.0));
aoqi@0 128 tty->print_cr (" subtotal : %3.3f sec, %3.2f %%", optimizer_subtotal, percent_of_optimizer);
aoqi@0 129 }
aoqi@0 130 tty->print_cr (" matcher : %3.3f sec", Phase::_t_matcher.seconds());
aoqi@0 131 tty->print_cr (" scheduler : %3.3f sec", Phase::_t_scheduler.seconds());
aoqi@0 132 tty->print_cr (" regalloc : %3.3f sec", Phase::_t_registerAllocation.seconds());
aoqi@0 133 if( Verbose || WizardMode ) {
aoqi@0 134 tty->print_cr (" ctorChaitin : %3.3f sec", Phase::_t_ctorChaitin.seconds());
aoqi@0 135 tty->print_cr (" buildIFG : %3.3f sec", Phase::_t_buildIFGphysical.seconds());
aoqi@0 136 tty->print_cr (" computeLive : %3.3f sec", Phase::_t_computeLive.seconds());
aoqi@0 137 tty->print_cr (" regAllocSplit : %3.3f sec", Phase::_t_regAllocSplit.seconds());
aoqi@0 138 tty->print_cr (" postAllocCopyRemoval: %3.3f sec", Phase::_t_postAllocCopyRemoval.seconds());
aoqi@0 139 tty->print_cr (" fixupSpills : %3.3f sec", Phase::_t_fixupSpills.seconds());
aoqi@0 140 double regalloc_subtotal = Phase::_t_ctorChaitin.seconds() +
aoqi@0 141 Phase::_t_buildIFGphysical.seconds() + Phase::_t_computeLive.seconds() +
aoqi@0 142 Phase::_t_regAllocSplit.seconds() + Phase::_t_fixupSpills.seconds() +
aoqi@0 143 Phase::_t_postAllocCopyRemoval.seconds();
aoqi@0 144 double percent_of_regalloc = ((regalloc_subtotal == 0.0) ? 0.0 : (regalloc_subtotal / Phase::_t_registerAllocation.seconds() * 100.0));
aoqi@0 145 tty->print_cr (" subtotal : %3.3f sec, %3.2f %%", regalloc_subtotal, percent_of_regalloc);
aoqi@0 146 }
aoqi@0 147 tty->print_cr (" blockOrdering : %3.3f sec", Phase::_t_blockOrdering.seconds());
aoqi@0 148 tty->print_cr (" peephole : %3.3f sec", Phase::_t_peephole.seconds());
aoqi@0 149 if (Matcher::require_postalloc_expand) {
aoqi@0 150 tty->print_cr (" postalloc_expand: %3.3f sec", Phase::_t_postalloc_expand.seconds());
aoqi@0 151 }
aoqi@0 152 tty->print_cr (" codeGen : %3.3f sec", Phase::_t_codeGeneration.seconds());
aoqi@0 153 tty->print_cr (" install_code : %3.3f sec", Phase::_t_registerMethod.seconds());
aoqi@0 154 tty->print_cr (" -------------- : ----------");
aoqi@0 155 double phase_subtotal = Phase::_t_parser.seconds() +
aoqi@0 156 Phase::_t_optimizer.seconds() + Phase::_t_graphReshaping.seconds() +
aoqi@0 157 Phase::_t_matcher.seconds() + Phase::_t_scheduler.seconds() +
aoqi@0 158 Phase::_t_registerAllocation.seconds() + Phase::_t_blockOrdering.seconds() +
aoqi@0 159 Phase::_t_codeGeneration.seconds() + Phase::_t_registerMethod.seconds();
aoqi@0 160 double percent_of_method_compile = ((phase_subtotal == 0.0) ? 0.0 : phase_subtotal / Phase::_t_methodCompilation.seconds()) * 100.0;
aoqi@0 161 // counters inside Compile::CodeGen include time for adapters and stubs
aoqi@0 162 // so phase-total can be greater than 100%
aoqi@0 163 tty->print_cr (" total : %3.3f sec, %3.2f %%", phase_subtotal, percent_of_method_compile);
aoqi@0 164
aoqi@0 165 assert( percent_of_method_compile > expected_method_compile_coverage ||
aoqi@0 166 phase_subtotal < minimum_meaningful_method_compile,
aoqi@0 167 "Must account for method compilation");
aoqi@0 168
aoqi@0 169 if( Phase::_t_temporaryTimer1.seconds() > minimum_reported_time ) {
aoqi@0 170 tty->cr();
aoqi@0 171 tty->print_cr (" temporaryTimer1: %3.3f sec", Phase::_t_temporaryTimer1.seconds());
aoqi@0 172 }
aoqi@0 173 if( Phase::_t_temporaryTimer2.seconds() > minimum_reported_time ) {
aoqi@0 174 tty->cr();
aoqi@0 175 tty->print_cr (" temporaryTimer2: %3.3f sec", Phase::_t_temporaryTimer2.seconds());
aoqi@0 176 }
aoqi@0 177 tty->print_cr (" output : %3.3f sec", Phase::_t_output.seconds());
aoqi@0 178 tty->print_cr (" isched : %3.3f sec", Phase::_t_instrSched.seconds());
aoqi@0 179 tty->print_cr (" bldOopMaps : %3.3f sec", Phase::_t_buildOopMaps.seconds());
aoqi@0 180 }
aoqi@0 181 #endif

mercurial