src/share/vm/services/runtimeService.cpp

Tue, 28 Oct 2014 18:41:34 +0400

author
vkempik
date
Tue, 28 Oct 2014 18:41:34 +0400
changeset 7326
6f06ebb09080
parent 5891
0db3ba3f6870
child 7535
7ae4e26cb1e0
permissions
-rw-r--r--

8059216: Make PrintGCApplicationStoppedTime print information about stopping threads
Reviewed-by: dholmes, brutisso

     1 /*
     2  * Copyright (c) 2003, 2013, 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 "services/attachListener.hpp"
    28 #include "services/management.hpp"
    29 #include "services/runtimeService.hpp"
    30 #include "utilities/dtrace.hpp"
    31 #include "utilities/exceptions.hpp"
    32 #include "utilities/macros.hpp"
    34 #ifndef USDT2
    35 HS_DTRACE_PROBE_DECL(hs_private, safepoint__begin);
    36 HS_DTRACE_PROBE_DECL(hs_private, safepoint__end);
    37 #endif /* !USDT2 */
    39 #if INCLUDE_MANAGEMENT
    40 TimeStamp RuntimeService::_app_timer;
    41 TimeStamp RuntimeService::_safepoint_timer;
    42 PerfCounter*  RuntimeService::_sync_time_ticks = NULL;
    43 PerfCounter*  RuntimeService::_total_safepoints = NULL;
    44 PerfCounter*  RuntimeService::_safepoint_time_ticks = NULL;
    45 PerfCounter*  RuntimeService::_application_time_ticks = NULL;
    46 PerfCounter*  RuntimeService::_thread_interrupt_signaled_count = NULL;
    47 PerfCounter*  RuntimeService::_interrupted_before_count = NULL;
    48 PerfCounter*  RuntimeService::_interrupted_during_count = NULL;
    49 double RuntimeService::_last_safepoint_sync_time_sec = 0.0;
    51 void RuntimeService::init() {
    52   // Make sure the VM version is initialized
    53   Abstract_VM_Version::initialize();
    55   if (UsePerfData) {
    56     EXCEPTION_MARK;
    58     _sync_time_ticks =
    59               PerfDataManager::create_counter(SUN_RT, "safepointSyncTime",
    60                                               PerfData::U_Ticks, CHECK);
    62     _total_safepoints =
    63               PerfDataManager::create_counter(SUN_RT, "safepoints",
    64                                               PerfData::U_Events, CHECK);
    66     _safepoint_time_ticks =
    67               PerfDataManager::create_counter(SUN_RT, "safepointTime",
    68                                               PerfData::U_Ticks, CHECK);
    70     _application_time_ticks =
    71               PerfDataManager::create_counter(SUN_RT, "applicationTime",
    72                                               PerfData::U_Ticks, CHECK);
    75     // create performance counters for jvm_version and its capabilities
    76     PerfDataManager::create_constant(SUN_RT, "jvmVersion", PerfData::U_None,
    77                                      (jlong) Abstract_VM_Version::jvm_version(), CHECK);
    79     // I/O interruption related counters
    81     // thread signaling via os::interrupt()
    83     _thread_interrupt_signaled_count =
    84                 PerfDataManager::create_counter(SUN_RT,
    85                  "threadInterruptSignaled", PerfData::U_Events, CHECK);
    87     // OS_INTRPT via "check before" in _INTERRUPTIBLE
    89     _interrupted_before_count =
    90                 PerfDataManager::create_counter(SUN_RT, "interruptedBeforeIO",
    91                                                 PerfData::U_Events, CHECK);
    93     // OS_INTRPT via "check during" in _INTERRUPTIBLE
    95     _interrupted_during_count =
    96                 PerfDataManager::create_counter(SUN_RT, "interruptedDuringIO",
    97                                                 PerfData::U_Events, CHECK);
    99     // The capabilities counter is a binary representation of the VM capabilities in string.
   100     // This string respresentation simplifies the implementation of the client side
   101     // to parse the value.
   102     char capabilities[65];
   103     size_t len = sizeof(capabilities);
   104     memset((void*) capabilities, '0', len);
   105     capabilities[len-1] = '\0';
   106     capabilities[0] = AttachListener::is_attach_supported() ? '1' : '0';
   107 #if INCLUDE_SERVICES
   108     capabilities[1] = '1';
   109 #endif // INCLUDE_SERVICES
   110     PerfDataManager::create_string_constant(SUN_RT, "jvmCapabilities",
   111                                             capabilities, CHECK);
   112   }
   113 }
   115 void RuntimeService::record_safepoint_begin() {
   116 #ifndef USDT2
   117   HS_DTRACE_PROBE(hs_private, safepoint__begin);
   118 #else /* USDT2 */
   119   HS_PRIVATE_SAFEPOINT_BEGIN();
   120 #endif /* USDT2 */
   122   // Print the time interval in which the app was executing
   123   if (PrintGCApplicationConcurrentTime && _app_timer.is_updated()) {
   124     gclog_or_tty->date_stamp(PrintGCDateStamps);
   125     gclog_or_tty->stamp(PrintGCTimeStamps);
   126     gclog_or_tty->print_cr("Application time: %3.7f seconds",
   127                                 last_application_time_sec());
   128   }
   130   // update the time stamp to begin recording safepoint time
   131   _safepoint_timer.update();
   132   _last_safepoint_sync_time_sec = 0.0;
   133   if (UsePerfData) {
   134     _total_safepoints->inc();
   135     if (_app_timer.is_updated()) {
   136       _application_time_ticks->inc(_app_timer.ticks_since_update());
   137     }
   138   }
   139 }
   141 void RuntimeService::record_safepoint_synchronized() {
   142   if (UsePerfData) {
   143     _sync_time_ticks->inc(_safepoint_timer.ticks_since_update());
   144   }
   145   if (PrintGCApplicationStoppedTime) {
   146     _last_safepoint_sync_time_sec = last_safepoint_time_sec();
   147   }
   148 }
   150 void RuntimeService::record_safepoint_end() {
   151 #ifndef USDT2
   152   HS_DTRACE_PROBE(hs_private, safepoint__end);
   153 #else /* USDT2 */
   154   HS_PRIVATE_SAFEPOINT_END();
   155 #endif /* USDT2 */
   157   // Print the time interval for which the app was stopped
   158   // during the current safepoint operation.
   159   if (PrintGCApplicationStoppedTime) {
   160     gclog_or_tty->date_stamp(PrintGCDateStamps);
   161     gclog_or_tty->stamp(PrintGCTimeStamps);
   162     gclog_or_tty->print_cr("Total time for which application threads "
   163                            "were stopped: %3.7f seconds, "
   164                            "Stopping threads took: %3.7f seconds",
   165                            last_safepoint_time_sec(),
   166                            _last_safepoint_sync_time_sec);
   167   }
   169   // update the time stamp to begin recording app time
   170   _app_timer.update();
   171   if (UsePerfData) {
   172     _safepoint_time_ticks->inc(_safepoint_timer.ticks_since_update());
   173   }
   174 }
   176 void RuntimeService::record_application_start() {
   177   // update the time stamp to begin recording app time
   178   _app_timer.update();
   179 }
   181 // Don't need to record application end because we currently
   182 // exit at a safepoint and record_safepoint_begin() handles updating
   183 // the application time counter at VM exit.
   185 jlong RuntimeService::safepoint_sync_time_ms() {
   186   return UsePerfData ?
   187     Management::ticks_to_ms(_sync_time_ticks->get_value()) : -1;
   188 }
   190 jlong RuntimeService::safepoint_count() {
   191   return UsePerfData ?
   192     _total_safepoints->get_value() : -1;
   193 }
   194 jlong RuntimeService::safepoint_time_ms() {
   195   return UsePerfData ?
   196     Management::ticks_to_ms(_safepoint_time_ticks->get_value()) : -1;
   197 }
   199 jlong RuntimeService::application_time_ms() {
   200   return UsePerfData ?
   201     Management::ticks_to_ms(_application_time_ticks->get_value()) : -1;
   202 }
   204 void RuntimeService::record_interrupted_before_count() {
   205   if (UsePerfData) {
   206     _interrupted_before_count->inc();
   207   }
   208 }
   210 void RuntimeService::record_interrupted_during_count() {
   211   if (UsePerfData) {
   212     _interrupted_during_count->inc();
   213   }
   214 }
   216 void RuntimeService::record_thread_interrupt_signaled_count() {
   217   if (UsePerfData) {
   218     _thread_interrupt_signaled_count->inc();
   219   }
   220 }
   222 #endif // INCLUDE_MANAGEMENT

mercurial