src/share/vm/utilities/ostream.cpp

Sat, 11 Dec 2010 13:20:56 -0500

author
zgu
date
Sat, 11 Dec 2010 13:20:56 -0500
changeset 2364
2d4762ec74af
parent 2314
f95d63e2154a
child 2322
828eafbd85cc
permissions
-rw-r--r--

7003748: Decode C stack frames when symbols are presented (PhoneHome project)
Summary: Implemented in-process C native stack frame decoding when symbols are available.
Reviewed-by: coleenp, never

duke@435 1 /*
stefank@2314 2 * Copyright (c) 1997, 2010, Oracle and/or its affiliates. All rights reserved.
duke@435 3 * DO NOT ALTER OR REMOVE COPYRIGHT NOTICES OR THIS FILE HEADER.
duke@435 4 *
duke@435 5 * This code is free software; you can redistribute it and/or modify it
duke@435 6 * under the terms of the GNU General Public License version 2 only, as
duke@435 7 * published by the Free Software Foundation.
duke@435 8 *
duke@435 9 * This code is distributed in the hope that it will be useful, but WITHOUT
duke@435 10 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
duke@435 11 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License
duke@435 12 * version 2 for more details (a copy is included in the LICENSE file that
duke@435 13 * accompanied this code).
duke@435 14 *
duke@435 15 * You should have received a copy of the GNU General Public License version
duke@435 16 * 2 along with this work; if not, write to the Free Software Foundation,
duke@435 17 * Inc., 51 Franklin St, Fifth Floor, Boston, MA 02110-1301 USA.
duke@435 18 *
trims@1907 19 * Please contact Oracle, 500 Oracle Parkway, Redwood Shores, CA 94065 USA
trims@1907 20 * or visit www.oracle.com if you need additional information or have any
trims@1907 21 * questions.
duke@435 22 *
duke@435 23 */
duke@435 24
stefank@2314 25 #include "precompiled.hpp"
stefank@2314 26 #include "compiler/compileLog.hpp"
stefank@2314 27 #include "oops/oop.inline.hpp"
stefank@2314 28 #include "runtime/arguments.hpp"
stefank@2314 29 #include "runtime/hpi.hpp"
stefank@2314 30 #include "utilities/defaultStream.hpp"
stefank@2314 31 #include "utilities/ostream.hpp"
stefank@2314 32 #include "utilities/top.hpp"
stefank@2314 33 #include "utilities/xmlstream.hpp"
stefank@2314 34 #ifdef TARGET_OS_FAMILY_linux
stefank@2314 35 # include "hpi_linux.hpp"
stefank@2314 36 # include "os_linux.inline.hpp"
stefank@2314 37 #endif
stefank@2314 38 #ifdef TARGET_OS_FAMILY_solaris
stefank@2314 39 # include "hpi_solaris.hpp"
stefank@2314 40 # include "os_solaris.inline.hpp"
stefank@2314 41 #endif
stefank@2314 42 #ifdef TARGET_OS_FAMILY_windows
stefank@2314 43 # include "hpi_windows.hpp"
stefank@2314 44 # include "os_windows.inline.hpp"
stefank@2314 45 #endif
duke@435 46
duke@435 47 extern "C" void jio_print(const char* s); // Declarationtion of jvm method
duke@435 48
duke@435 49 outputStream::outputStream(int width) {
duke@435 50 _width = width;
duke@435 51 _position = 0;
duke@435 52 _newlines = 0;
duke@435 53 _precount = 0;
duke@435 54 _indentation = 0;
duke@435 55 }
duke@435 56
duke@435 57 outputStream::outputStream(int width, bool has_time_stamps) {
duke@435 58 _width = width;
duke@435 59 _position = 0;
duke@435 60 _newlines = 0;
duke@435 61 _precount = 0;
duke@435 62 _indentation = 0;
duke@435 63 if (has_time_stamps) _stamp.update();
duke@435 64 }
duke@435 65
duke@435 66 void outputStream::update_position(const char* s, size_t len) {
duke@435 67 for (size_t i = 0; i < len; i++) {
duke@435 68 char ch = s[i];
duke@435 69 if (ch == '\n') {
duke@435 70 _newlines += 1;
duke@435 71 _precount += _position + 1;
duke@435 72 _position = 0;
duke@435 73 } else if (ch == '\t') {
jrose@535 74 int tw = 8 - (_position & 7);
jrose@535 75 _position += tw;
jrose@535 76 _precount -= tw-1; // invariant: _precount + _position == total count
duke@435 77 } else {
duke@435 78 _position += 1;
duke@435 79 }
duke@435 80 }
duke@435 81 }
duke@435 82
duke@435 83 // Execute a vsprintf, using the given buffer if necessary.
duke@435 84 // Return a pointer to the formatted string.
duke@435 85 const char* outputStream::do_vsnprintf(char* buffer, size_t buflen,
duke@435 86 const char* format, va_list ap,
duke@435 87 bool add_cr,
duke@435 88 size_t& result_len) {
duke@435 89 const char* result;
duke@435 90 if (add_cr) buflen--;
duke@435 91 if (!strchr(format, '%')) {
duke@435 92 // constant format string
duke@435 93 result = format;
duke@435 94 result_len = strlen(result);
duke@435 95 if (add_cr && result_len >= buflen) result_len = buflen-1; // truncate
duke@435 96 } else if (format[0] == '%' && format[1] == 's' && format[2] == '\0') {
duke@435 97 // trivial copy-through format string
duke@435 98 result = va_arg(ap, const char*);
duke@435 99 result_len = strlen(result);
duke@435 100 if (add_cr && result_len >= buflen) result_len = buflen-1; // truncate
duke@435 101 } else if (vsnprintf(buffer, buflen, format, ap) >= 0) {
duke@435 102 result = buffer;
duke@435 103 result_len = strlen(result);
duke@435 104 } else {
duke@435 105 DEBUG_ONLY(warning("increase O_BUFLEN in ostream.hpp -- output truncated");)
duke@435 106 result = buffer;
duke@435 107 result_len = buflen - 1;
duke@435 108 buffer[result_len] = 0;
duke@435 109 }
duke@435 110 if (add_cr) {
duke@435 111 if (result != buffer) {
duke@435 112 strncpy(buffer, result, buflen);
duke@435 113 result = buffer;
duke@435 114 }
duke@435 115 buffer[result_len++] = '\n';
duke@435 116 buffer[result_len] = 0;
duke@435 117 }
duke@435 118 return result;
duke@435 119 }
duke@435 120
duke@435 121 void outputStream::print(const char* format, ...) {
duke@435 122 char buffer[O_BUFLEN];
duke@435 123 va_list ap;
duke@435 124 va_start(ap, format);
duke@435 125 size_t len;
duke@435 126 const char* str = do_vsnprintf(buffer, O_BUFLEN, format, ap, false, len);
duke@435 127 write(str, len);
duke@435 128 va_end(ap);
duke@435 129 }
duke@435 130
duke@435 131 void outputStream::print_cr(const char* format, ...) {
duke@435 132 char buffer[O_BUFLEN];
duke@435 133 va_list ap;
duke@435 134 va_start(ap, format);
duke@435 135 size_t len;
duke@435 136 const char* str = do_vsnprintf(buffer, O_BUFLEN, format, ap, true, len);
duke@435 137 write(str, len);
duke@435 138 va_end(ap);
duke@435 139 }
duke@435 140
duke@435 141 void outputStream::vprint(const char *format, va_list argptr) {
duke@435 142 char buffer[O_BUFLEN];
duke@435 143 size_t len;
duke@435 144 const char* str = do_vsnprintf(buffer, O_BUFLEN, format, argptr, false, len);
duke@435 145 write(str, len);
duke@435 146 }
duke@435 147
duke@435 148 void outputStream::vprint_cr(const char* format, va_list argptr) {
duke@435 149 char buffer[O_BUFLEN];
duke@435 150 size_t len;
duke@435 151 const char* str = do_vsnprintf(buffer, O_BUFLEN, format, argptr, true, len);
duke@435 152 write(str, len);
duke@435 153 }
duke@435 154
duke@435 155 void outputStream::fill_to(int col) {
jrose@535 156 int need_fill = col - position();
jrose@535 157 sp(need_fill);
jrose@535 158 }
jrose@535 159
jrose@535 160 void outputStream::move_to(int col, int slop, int min_space) {
jrose@535 161 if (position() >= col + slop)
jrose@535 162 cr();
jrose@535 163 int need_fill = col - position();
jrose@535 164 if (need_fill < min_space)
jrose@535 165 need_fill = min_space;
jrose@535 166 sp(need_fill);
duke@435 167 }
duke@435 168
duke@435 169 void outputStream::put(char ch) {
duke@435 170 assert(ch != 0, "please fix call site");
duke@435 171 char buf[] = { ch, '\0' };
duke@435 172 write(buf, 1);
duke@435 173 }
duke@435 174
jrose@535 175 #define SP_USE_TABS false
jrose@535 176
jrose@535 177 void outputStream::sp(int count) {
jrose@535 178 if (count < 0) return;
jrose@535 179 if (SP_USE_TABS && count >= 8) {
jrose@535 180 int target = position() + count;
jrose@535 181 while (count >= 8) {
jrose@535 182 this->write("\t", 1);
jrose@535 183 count -= 8;
jrose@535 184 }
jrose@535 185 count = target - position();
jrose@535 186 }
jrose@535 187 while (count > 0) {
jrose@535 188 int nw = (count > 8) ? 8 : count;
jrose@535 189 this->write(" ", nw);
jrose@535 190 count -= nw;
jrose@535 191 }
duke@435 192 }
duke@435 193
duke@435 194 void outputStream::cr() {
duke@435 195 this->write("\n", 1);
duke@435 196 }
duke@435 197
duke@435 198 void outputStream::stamp() {
duke@435 199 if (! _stamp.is_updated()) {
duke@435 200 _stamp.update(); // start at 0 on first call to stamp()
duke@435 201 }
duke@435 202
duke@435 203 // outputStream::stamp() may get called by ostream_abort(), use snprintf
duke@435 204 // to avoid allocating large stack buffer in print().
duke@435 205 char buf[40];
duke@435 206 jio_snprintf(buf, sizeof(buf), "%.3f", _stamp.seconds());
duke@435 207 print_raw(buf);
duke@435 208 }
duke@435 209
ysr@777 210 void outputStream::stamp(bool guard,
ysr@777 211 const char* prefix,
ysr@777 212 const char* suffix) {
ysr@777 213 if (!guard) {
ysr@777 214 return;
ysr@777 215 }
ysr@777 216 print_raw(prefix);
ysr@777 217 stamp();
ysr@777 218 print_raw(suffix);
ysr@777 219 }
ysr@777 220
duke@435 221 void outputStream::date_stamp(bool guard,
duke@435 222 const char* prefix,
duke@435 223 const char* suffix) {
duke@435 224 if (!guard) {
duke@435 225 return;
duke@435 226 }
duke@435 227 print_raw(prefix);
duke@435 228 static const char error_time[] = "yyyy-mm-ddThh:mm:ss.mmm+zzzz";
duke@435 229 static const int buffer_length = 32;
duke@435 230 char buffer[buffer_length];
duke@435 231 const char* iso8601_result = os::iso8601_time(buffer, buffer_length);
duke@435 232 if (iso8601_result != NULL) {
duke@435 233 print_raw(buffer);
duke@435 234 } else {
duke@435 235 print_raw(error_time);
duke@435 236 }
duke@435 237 print_raw(suffix);
duke@435 238 return;
duke@435 239 }
duke@435 240
duke@435 241 void outputStream::indent() {
duke@435 242 while (_position < _indentation) sp();
duke@435 243 }
duke@435 244
duke@435 245 void outputStream::print_jlong(jlong value) {
duke@435 246 // N.B. Same as INT64_FORMAT
duke@435 247 print(os::jlong_format_specifier(), value);
duke@435 248 }
duke@435 249
duke@435 250 void outputStream::print_julong(julong value) {
duke@435 251 // N.B. Same as UINT64_FORMAT
duke@435 252 print(os::julong_format_specifier(), value);
duke@435 253 }
duke@435 254
duke@435 255 stringStream::stringStream(size_t initial_size) : outputStream() {
duke@435 256 buffer_length = initial_size;
duke@435 257 buffer = NEW_RESOURCE_ARRAY(char, buffer_length);
duke@435 258 buffer_pos = 0;
duke@435 259 buffer_fixed = false;
duke@435 260 }
duke@435 261
duke@435 262 // useful for output to fixed chunks of memory, such as performance counters
duke@435 263 stringStream::stringStream(char* fixed_buffer, size_t fixed_buffer_size) : outputStream() {
duke@435 264 buffer_length = fixed_buffer_size;
duke@435 265 buffer = fixed_buffer;
duke@435 266 buffer_pos = 0;
duke@435 267 buffer_fixed = true;
duke@435 268 }
duke@435 269
duke@435 270 void stringStream::write(const char* s, size_t len) {
duke@435 271 size_t write_len = len; // number of non-null bytes to write
duke@435 272 size_t end = buffer_pos + len + 1; // position after write and final '\0'
duke@435 273 if (end > buffer_length) {
duke@435 274 if (buffer_fixed) {
duke@435 275 // if buffer cannot resize, silently truncate
duke@435 276 end = buffer_length;
duke@435 277 write_len = end - buffer_pos - 1; // leave room for the final '\0'
duke@435 278 } else {
duke@435 279 // For small overruns, double the buffer. For larger ones,
duke@435 280 // increase to the requested size.
duke@435 281 if (end < buffer_length * 2) {
duke@435 282 end = buffer_length * 2;
duke@435 283 }
duke@435 284 char* oldbuf = buffer;
duke@435 285 buffer = NEW_RESOURCE_ARRAY(char, end);
duke@435 286 strncpy(buffer, oldbuf, buffer_pos);
duke@435 287 buffer_length = end;
duke@435 288 }
duke@435 289 }
duke@435 290 // invariant: buffer is always null-terminated
duke@435 291 guarantee(buffer_pos + write_len + 1 <= buffer_length, "stringStream oob");
duke@435 292 buffer[buffer_pos + write_len] = 0;
duke@435 293 strncpy(buffer + buffer_pos, s, write_len);
duke@435 294 buffer_pos += write_len;
duke@435 295
duke@435 296 // Note that the following does not depend on write_len.
duke@435 297 // This means that position and count get updated
duke@435 298 // even when overflow occurs.
duke@435 299 update_position(s, len);
duke@435 300 }
duke@435 301
duke@435 302 char* stringStream::as_string() {
duke@435 303 char* copy = NEW_RESOURCE_ARRAY(char, buffer_pos+1);
duke@435 304 strncpy(copy, buffer, buffer_pos);
duke@435 305 copy[buffer_pos] = 0; // terminating null
duke@435 306 return copy;
duke@435 307 }
duke@435 308
duke@435 309 stringStream::~stringStream() {}
duke@435 310
duke@435 311 xmlStream* xtty;
duke@435 312 outputStream* tty;
duke@435 313 outputStream* gclog_or_tty;
duke@435 314 extern Mutex* tty_lock;
duke@435 315
duke@435 316 fileStream::fileStream(const char* file_name) {
duke@435 317 _file = fopen(file_name, "w");
duke@435 318 _need_close = true;
duke@435 319 }
duke@435 320
duke@435 321 void fileStream::write(const char* s, size_t len) {
xlu@948 322 if (_file != NULL) {
xlu@948 323 // Make an unused local variable to avoid warning from gcc 4.x compiler.
xlu@948 324 size_t count = fwrite(s, 1, len, _file);
xlu@948 325 }
duke@435 326 update_position(s, len);
duke@435 327 }
duke@435 328
duke@435 329 fileStream::~fileStream() {
duke@435 330 if (_file != NULL) {
duke@435 331 if (_need_close) fclose(_file);
duke@435 332 _file = NULL;
duke@435 333 }
duke@435 334 }
duke@435 335
duke@435 336 void fileStream::flush() {
duke@435 337 fflush(_file);
duke@435 338 }
duke@435 339
duke@435 340 fdStream::fdStream(const char* file_name) {
duke@435 341 _fd = open(file_name, O_WRONLY | O_CREAT | O_TRUNC, 0666);
duke@435 342 _need_close = true;
duke@435 343 }
duke@435 344
duke@435 345 fdStream::~fdStream() {
duke@435 346 if (_fd != -1) {
duke@435 347 if (_need_close) close(_fd);
duke@435 348 _fd = -1;
duke@435 349 }
duke@435 350 }
duke@435 351
duke@435 352 void fdStream::write(const char* s, size_t len) {
xlu@948 353 if (_fd != -1) {
xlu@948 354 // Make an unused local variable to avoid warning from gcc 4.x compiler.
xlu@948 355 size_t count = ::write(_fd, s, (int)len);
xlu@948 356 }
duke@435 357 update_position(s, len);
duke@435 358 }
duke@435 359
duke@435 360 defaultStream* defaultStream::instance = NULL;
duke@435 361 int defaultStream::_output_fd = 1;
duke@435 362 int defaultStream::_error_fd = 2;
duke@435 363 FILE* defaultStream::_output_stream = stdout;
duke@435 364 FILE* defaultStream::_error_stream = stderr;
duke@435 365
duke@435 366 #define LOG_MAJOR_VERSION 160
duke@435 367 #define LOG_MINOR_VERSION 1
duke@435 368
duke@435 369 void defaultStream::init() {
duke@435 370 _inited = true;
duke@435 371 if (LogVMOutput || LogCompilation) {
duke@435 372 init_log();
duke@435 373 }
duke@435 374 }
duke@435 375
duke@435 376 bool defaultStream::has_log_file() {
duke@435 377 // lazily create log file (at startup, LogVMOutput is false even
duke@435 378 // if +LogVMOutput is used, because the flags haven't been parsed yet)
duke@435 379 // For safer printing during fatal error handling, do not init logfile
duke@435 380 // if a VM error has been reported.
duke@435 381 if (!_inited && !is_error_reported()) init();
duke@435 382 return _log_file != NULL;
duke@435 383 }
duke@435 384
coleenp@1788 385 static const char* make_log_name(const char* log_name, const char* force_directory) {
duke@435 386 const char* basename = log_name;
duke@435 387 char file_sep = os::file_separator()[0];
duke@435 388 const char* cp;
duke@435 389 for (cp = log_name; *cp != '\0'; cp++) {
duke@435 390 if (*cp == '/' || *cp == file_sep) {
duke@435 391 basename = cp+1;
duke@435 392 }
duke@435 393 }
duke@435 394 const char* nametail = log_name;
duke@435 395
coleenp@1788 396 // Compute buffer length
coleenp@1788 397 size_t buffer_length;
coleenp@1788 398 if (force_directory != NULL) {
coleenp@1788 399 buffer_length = strlen(force_directory) + strlen(os::file_separator()) +
coleenp@1788 400 strlen(basename) + 1;
coleenp@1788 401 } else {
coleenp@1788 402 buffer_length = strlen(log_name) + 1;
coleenp@1788 403 }
coleenp@1788 404
coleenp@1788 405 const char* star = strchr(basename, '*');
coleenp@1788 406 int star_pos = (star == NULL) ? -1 : (star - nametail);
coleenp@1788 407
coleenp@1788 408 char pid[32];
coleenp@1788 409 if (star_pos >= 0) {
coleenp@1788 410 jio_snprintf(pid, sizeof(pid), "%u", os::current_process_id());
coleenp@1788 411 buffer_length += strlen(pid);
coleenp@1788 412 }
coleenp@1788 413
coleenp@1788 414 // Create big enough buffer.
coleenp@1788 415 char *buf = NEW_C_HEAP_ARRAY(char, buffer_length);
coleenp@1788 416
duke@435 417 strcpy(buf, "");
duke@435 418 if (force_directory != NULL) {
duke@435 419 strcat(buf, force_directory);
duke@435 420 strcat(buf, os::file_separator());
duke@435 421 nametail = basename; // completely skip directory prefix
duke@435 422 }
duke@435 423
duke@435 424 if (star_pos >= 0) {
duke@435 425 // convert foo*bar.log to foo123bar.log
duke@435 426 int buf_pos = (int) strlen(buf);
duke@435 427 strncpy(&buf[buf_pos], nametail, star_pos);
coleenp@1788 428 strcpy(&buf[buf_pos + star_pos], pid);
duke@435 429 nametail += star_pos + 1; // skip prefix and star
duke@435 430 }
duke@435 431
duke@435 432 strcat(buf, nametail); // append rest of name, or all of name
duke@435 433 return buf;
duke@435 434 }
duke@435 435
duke@435 436 void defaultStream::init_log() {
duke@435 437 // %%% Need a MutexLocker?
duke@435 438 const char* log_name = LogFile != NULL ? LogFile : "hotspot.log";
coleenp@1788 439 const char* try_name = make_log_name(log_name, NULL);
duke@435 440 fileStream* file = new(ResourceObj::C_HEAP) fileStream(try_name);
duke@435 441 if (!file->is_open()) {
duke@435 442 // Try again to open the file.
duke@435 443 char warnbuf[O_BUFLEN*2];
coleenp@1788 444 jio_snprintf(warnbuf, sizeof(warnbuf),
coleenp@1788 445 "Warning: Cannot open log file: %s\n", try_name);
duke@435 446 // Note: This feature is for maintainer use only. No need for L10N.
duke@435 447 jio_print(warnbuf);
coleenp@1788 448 FREE_C_HEAP_ARRAY(char, try_name);
coleenp@1788 449 try_name = make_log_name("hs_pid*.log", os::get_temp_directory());
coleenp@1788 450 jio_snprintf(warnbuf, sizeof(warnbuf),
coleenp@1788 451 "Warning: Forcing option -XX:LogFile=%s\n", try_name);
duke@435 452 jio_print(warnbuf);
duke@435 453 delete file;
duke@435 454 file = new(ResourceObj::C_HEAP) fileStream(try_name);
coleenp@1788 455 FREE_C_HEAP_ARRAY(char, try_name);
duke@435 456 }
duke@435 457 if (file->is_open()) {
duke@435 458 _log_file = file;
duke@435 459 xmlStream* xs = new(ResourceObj::C_HEAP) xmlStream(file);
duke@435 460 _outer_xmlStream = xs;
duke@435 461 if (this == tty) xtty = xs;
duke@435 462 // Write XML header.
duke@435 463 xs->print_cr("<?xml version='1.0' encoding='UTF-8'?>");
duke@435 464 // (For now, don't bother to issue a DTD for this private format.)
duke@435 465 jlong time_ms = os::javaTimeMillis() - tty->time_stamp().milliseconds();
duke@435 466 // %%% Should be: jlong time_ms = os::start_time_milliseconds(), if
duke@435 467 // we ever get round to introduce that method on the os class
duke@435 468 xs->head("hotspot_log version='%d %d'"
duke@435 469 " process='%d' time_ms='"INT64_FORMAT"'",
duke@435 470 LOG_MAJOR_VERSION, LOG_MINOR_VERSION,
duke@435 471 os::current_process_id(), time_ms);
duke@435 472 // Write VM version header immediately.
duke@435 473 xs->head("vm_version");
duke@435 474 xs->head("name"); xs->text("%s", VM_Version::vm_name()); xs->cr();
duke@435 475 xs->tail("name");
duke@435 476 xs->head("release"); xs->text("%s", VM_Version::vm_release()); xs->cr();
duke@435 477 xs->tail("release");
duke@435 478 xs->head("info"); xs->text("%s", VM_Version::internal_vm_info_string()); xs->cr();
duke@435 479 xs->tail("info");
duke@435 480 xs->tail("vm_version");
duke@435 481 // Record information about the command-line invocation.
duke@435 482 xs->head("vm_arguments"); // Cf. Arguments::print_on()
duke@435 483 if (Arguments::num_jvm_flags() > 0) {
duke@435 484 xs->head("flags");
duke@435 485 Arguments::print_jvm_flags_on(xs->text());
duke@435 486 xs->tail("flags");
duke@435 487 }
duke@435 488 if (Arguments::num_jvm_args() > 0) {
duke@435 489 xs->head("args");
duke@435 490 Arguments::print_jvm_args_on(xs->text());
duke@435 491 xs->tail("args");
duke@435 492 }
duke@435 493 if (Arguments::java_command() != NULL) {
duke@435 494 xs->head("command"); xs->text()->print_cr("%s", Arguments::java_command());
duke@435 495 xs->tail("command");
duke@435 496 }
duke@435 497 if (Arguments::sun_java_launcher() != NULL) {
duke@435 498 xs->head("launcher"); xs->text()->print_cr("%s", Arguments::sun_java_launcher());
duke@435 499 xs->tail("launcher");
duke@435 500 }
duke@435 501 if (Arguments::system_properties() != NULL) {
duke@435 502 xs->head("properties");
duke@435 503 // Print it as a java-style property list.
duke@435 504 // System properties don't generally contain newlines, so don't bother with unparsing.
duke@435 505 for (SystemProperty* p = Arguments::system_properties(); p != NULL; p = p->next()) {
duke@435 506 xs->text()->print_cr("%s=%s", p->key(), p->value());
duke@435 507 }
duke@435 508 xs->tail("properties");
duke@435 509 }
duke@435 510 xs->tail("vm_arguments");
duke@435 511 // tty output per se is grouped under the <tty>...</tty> element.
duke@435 512 xs->head("tty");
duke@435 513 // All further non-markup text gets copied to the tty:
duke@435 514 xs->_text = this; // requires friend declaration!
duke@435 515 } else {
duke@435 516 delete(file);
duke@435 517 // and leave xtty as NULL
duke@435 518 LogVMOutput = false;
duke@435 519 DisplayVMOutput = true;
duke@435 520 LogCompilation = false;
duke@435 521 }
duke@435 522 }
duke@435 523
duke@435 524 // finish_log() is called during normal VM shutdown. finish_log_on_error() is
duke@435 525 // called by ostream_abort() after a fatal error.
duke@435 526 //
duke@435 527 void defaultStream::finish_log() {
duke@435 528 xmlStream* xs = _outer_xmlStream;
duke@435 529 xs->done("tty");
duke@435 530
duke@435 531 // Other log forks are appended here, at the End of Time:
duke@435 532 CompileLog::finish_log(xs->out()); // write compile logging, if any, now
duke@435 533
duke@435 534 xs->done("hotspot_log");
duke@435 535 xs->flush();
duke@435 536
duke@435 537 fileStream* file = _log_file;
duke@435 538 _log_file = NULL;
duke@435 539
duke@435 540 delete _outer_xmlStream;
duke@435 541 _outer_xmlStream = NULL;
duke@435 542
duke@435 543 file->flush();
duke@435 544 delete file;
duke@435 545 }
duke@435 546
duke@435 547 void defaultStream::finish_log_on_error(char *buf, int buflen) {
duke@435 548 xmlStream* xs = _outer_xmlStream;
duke@435 549
duke@435 550 if (xs && xs->out()) {
duke@435 551
duke@435 552 xs->done_raw("tty");
duke@435 553
duke@435 554 // Other log forks are appended here, at the End of Time:
duke@435 555 CompileLog::finish_log_on_error(xs->out(), buf, buflen); // write compile logging, if any, now
duke@435 556
duke@435 557 xs->done_raw("hotspot_log");
duke@435 558 xs->flush();
duke@435 559
duke@435 560 fileStream* file = _log_file;
duke@435 561 _log_file = NULL;
duke@435 562 _outer_xmlStream = NULL;
duke@435 563
duke@435 564 if (file) {
duke@435 565 file->flush();
duke@435 566
duke@435 567 // Can't delete or close the file because delete and fclose aren't
duke@435 568 // async-safe. We are about to die, so leave it to the kernel.
duke@435 569 // delete file;
duke@435 570 }
duke@435 571 }
duke@435 572 }
duke@435 573
duke@435 574 intx defaultStream::hold(intx writer_id) {
duke@435 575 bool has_log = has_log_file(); // check before locking
duke@435 576 if (// impossible, but who knows?
duke@435 577 writer_id == NO_WRITER ||
duke@435 578
duke@435 579 // bootstrap problem
duke@435 580 tty_lock == NULL ||
duke@435 581
duke@435 582 // can't grab a lock or call Thread::current() if TLS isn't initialized
duke@435 583 ThreadLocalStorage::thread() == NULL ||
duke@435 584
duke@435 585 // developer hook
duke@435 586 !SerializeVMOutput ||
duke@435 587
duke@435 588 // VM already unhealthy
duke@435 589 is_error_reported() ||
duke@435 590
duke@435 591 // safepoint == global lock (for VM only)
duke@435 592 (SafepointSynchronize::is_synchronizing() &&
duke@435 593 Thread::current()->is_VM_thread())
duke@435 594 ) {
duke@435 595 // do not attempt to lock unless we know the thread and the VM is healthy
duke@435 596 return NO_WRITER;
duke@435 597 }
duke@435 598 if (_writer == writer_id) {
duke@435 599 // already held, no need to re-grab the lock
duke@435 600 return NO_WRITER;
duke@435 601 }
duke@435 602 tty_lock->lock_without_safepoint_check();
duke@435 603 // got the lock
duke@435 604 if (writer_id != _last_writer) {
duke@435 605 if (has_log) {
duke@435 606 _log_file->bol();
duke@435 607 // output a hint where this output is coming from:
duke@435 608 _log_file->print_cr("<writer thread='"INTX_FORMAT"'/>", writer_id);
duke@435 609 }
duke@435 610 _last_writer = writer_id;
duke@435 611 }
duke@435 612 _writer = writer_id;
duke@435 613 return writer_id;
duke@435 614 }
duke@435 615
duke@435 616 void defaultStream::release(intx holder) {
duke@435 617 if (holder == NO_WRITER) {
duke@435 618 // nothing to release: either a recursive lock, or we scribbled (too bad)
duke@435 619 return;
duke@435 620 }
duke@435 621 if (_writer != holder) {
duke@435 622 return; // already unlocked, perhaps via break_tty_lock_for_safepoint
duke@435 623 }
duke@435 624 _writer = NO_WRITER;
duke@435 625 tty_lock->unlock();
duke@435 626 }
duke@435 627
duke@435 628
duke@435 629 // Yuck: jio_print does not accept char*/len.
duke@435 630 static void call_jio_print(const char* s, size_t len) {
duke@435 631 char buffer[O_BUFLEN+100];
duke@435 632 if (len > sizeof(buffer)-1) {
duke@435 633 warning("increase O_BUFLEN in ostream.cpp -- output truncated");
duke@435 634 len = sizeof(buffer)-1;
duke@435 635 }
duke@435 636 strncpy(buffer, s, len);
duke@435 637 buffer[len] = '\0';
duke@435 638 jio_print(buffer);
duke@435 639 }
duke@435 640
duke@435 641
duke@435 642 void defaultStream::write(const char* s, size_t len) {
duke@435 643 intx thread_id = os::current_thread_id();
duke@435 644 intx holder = hold(thread_id);
duke@435 645
duke@435 646 if (DisplayVMOutput &&
duke@435 647 (_outer_xmlStream == NULL || !_outer_xmlStream->inside_attrs())) {
duke@435 648 // print to output stream. It can be redirected by a vfprintf hook
duke@435 649 if (s[len] == '\0') {
duke@435 650 jio_print(s);
duke@435 651 } else {
duke@435 652 call_jio_print(s, len);
duke@435 653 }
duke@435 654 }
duke@435 655
duke@435 656 // print to log file
duke@435 657 if (has_log_file()) {
duke@435 658 int nl0 = _newlines;
duke@435 659 xmlTextStream::write(s, len);
duke@435 660 // flush the log file too, if there were any newlines
duke@435 661 if (nl0 != _newlines){
duke@435 662 flush();
duke@435 663 }
duke@435 664 } else {
duke@435 665 update_position(s, len);
duke@435 666 }
duke@435 667
duke@435 668 release(holder);
duke@435 669 }
duke@435 670
duke@435 671 intx ttyLocker::hold_tty() {
duke@435 672 if (defaultStream::instance == NULL) return defaultStream::NO_WRITER;
duke@435 673 intx thread_id = os::current_thread_id();
duke@435 674 return defaultStream::instance->hold(thread_id);
duke@435 675 }
duke@435 676
duke@435 677 void ttyLocker::release_tty(intx holder) {
duke@435 678 if (holder == defaultStream::NO_WRITER) return;
duke@435 679 defaultStream::instance->release(holder);
duke@435 680 }
duke@435 681
duke@435 682 void ttyLocker::break_tty_lock_for_safepoint(intx holder) {
duke@435 683 if (defaultStream::instance != NULL &&
duke@435 684 defaultStream::instance->writer() == holder) {
duke@435 685 if (xtty != NULL) {
duke@435 686 xtty->print_cr("<!-- safepoint while printing -->");
duke@435 687 }
duke@435 688 defaultStream::instance->release(holder);
duke@435 689 }
duke@435 690 // (else there was no lock to break)
duke@435 691 }
duke@435 692
duke@435 693 void ostream_init() {
duke@435 694 if (defaultStream::instance == NULL) {
duke@435 695 defaultStream::instance = new(ResourceObj::C_HEAP) defaultStream();
duke@435 696 tty = defaultStream::instance;
duke@435 697
duke@435 698 // We want to ensure that time stamps in GC logs consider time 0
duke@435 699 // the time when the JVM is initialized, not the first time we ask
duke@435 700 // for a time stamp. So, here, we explicitly update the time stamp
duke@435 701 // of tty.
duke@435 702 tty->time_stamp().update_to(1);
duke@435 703 }
duke@435 704 }
duke@435 705
duke@435 706 void ostream_init_log() {
duke@435 707 // For -Xloggc:<file> option - called in runtime/thread.cpp
duke@435 708 // Note : this must be called AFTER ostream_init()
duke@435 709
duke@435 710 gclog_or_tty = tty; // default to tty
duke@435 711 if (Arguments::gc_log_filename() != NULL) {
duke@435 712 fileStream * gclog = new(ResourceObj::C_HEAP)
duke@435 713 fileStream(Arguments::gc_log_filename());
duke@435 714 if (gclog->is_open()) {
duke@435 715 // now we update the time stamp of the GC log to be synced up
duke@435 716 // with tty.
duke@435 717 gclog->time_stamp().update_to(tty->time_stamp().ticks());
duke@435 718 gclog_or_tty = gclog;
duke@435 719 }
duke@435 720 }
duke@435 721
duke@435 722 // If we haven't lazily initialized the logfile yet, do it now,
duke@435 723 // to avoid the possibility of lazy initialization during a VM
duke@435 724 // crash, which can affect the stability of the fatal error handler.
duke@435 725 defaultStream::instance->has_log_file();
duke@435 726 }
duke@435 727
duke@435 728 // ostream_exit() is called during normal VM exit to finish log files, flush
duke@435 729 // output and free resource.
duke@435 730 void ostream_exit() {
duke@435 731 static bool ostream_exit_called = false;
duke@435 732 if (ostream_exit_called) return;
duke@435 733 ostream_exit_called = true;
duke@435 734 if (gclog_or_tty != tty) {
duke@435 735 delete gclog_or_tty;
duke@435 736 }
duke@435 737 {
duke@435 738 // we temporaly disable PrintMallocFree here
duke@435 739 // as otherwise it'll lead to using of almost deleted
duke@435 740 // tty or defaultStream::instance in logging facility
duke@435 741 // of HeapFree(), see 6391258
duke@435 742 DEBUG_ONLY(FlagSetting fs(PrintMallocFree, false);)
duke@435 743 if (tty != defaultStream::instance) {
duke@435 744 delete tty;
duke@435 745 }
duke@435 746 if (defaultStream::instance != NULL) {
duke@435 747 delete defaultStream::instance;
duke@435 748 }
duke@435 749 }
duke@435 750 tty = NULL;
duke@435 751 xtty = NULL;
duke@435 752 gclog_or_tty = NULL;
duke@435 753 defaultStream::instance = NULL;
duke@435 754 }
duke@435 755
duke@435 756 // ostream_abort() is called by os::abort() when VM is about to die.
duke@435 757 void ostream_abort() {
duke@435 758 // Here we can't delete gclog_or_tty and tty, just flush their output
duke@435 759 if (gclog_or_tty) gclog_or_tty->flush();
duke@435 760 if (tty) tty->flush();
duke@435 761
duke@435 762 if (defaultStream::instance != NULL) {
duke@435 763 static char buf[4096];
duke@435 764 defaultStream::instance->finish_log_on_error(buf, sizeof(buf));
duke@435 765 }
duke@435 766 }
duke@435 767
duke@435 768 staticBufferStream::staticBufferStream(char* buffer, size_t buflen,
duke@435 769 outputStream *outer_stream) {
duke@435 770 _buffer = buffer;
duke@435 771 _buflen = buflen;
duke@435 772 _outer_stream = outer_stream;
duke@435 773 }
duke@435 774
duke@435 775 void staticBufferStream::write(const char* c, size_t len) {
duke@435 776 _outer_stream->print_raw(c, (int)len);
duke@435 777 }
duke@435 778
duke@435 779 void staticBufferStream::flush() {
duke@435 780 _outer_stream->flush();
duke@435 781 }
duke@435 782
duke@435 783 void staticBufferStream::print(const char* format, ...) {
duke@435 784 va_list ap;
duke@435 785 va_start(ap, format);
duke@435 786 size_t len;
duke@435 787 const char* str = do_vsnprintf(_buffer, _buflen, format, ap, false, len);
duke@435 788 write(str, len);
duke@435 789 va_end(ap);
duke@435 790 }
duke@435 791
duke@435 792 void staticBufferStream::print_cr(const char* format, ...) {
duke@435 793 va_list ap;
duke@435 794 va_start(ap, format);
duke@435 795 size_t len;
duke@435 796 const char* str = do_vsnprintf(_buffer, _buflen, format, ap, true, len);
duke@435 797 write(str, len);
duke@435 798 va_end(ap);
duke@435 799 }
duke@435 800
duke@435 801 void staticBufferStream::vprint(const char *format, va_list argptr) {
duke@435 802 size_t len;
duke@435 803 const char* str = do_vsnprintf(_buffer, _buflen, format, argptr, false, len);
duke@435 804 write(str, len);
duke@435 805 }
duke@435 806
duke@435 807 void staticBufferStream::vprint_cr(const char* format, va_list argptr) {
duke@435 808 size_t len;
duke@435 809 const char* str = do_vsnprintf(_buffer, _buflen, format, argptr, true, len);
duke@435 810 write(str, len);
duke@435 811 }
duke@435 812
never@657 813 bufferedStream::bufferedStream(size_t initial_size, size_t bufmax) : outputStream() {
duke@435 814 buffer_length = initial_size;
duke@435 815 buffer = NEW_C_HEAP_ARRAY(char, buffer_length);
duke@435 816 buffer_pos = 0;
duke@435 817 buffer_fixed = false;
never@657 818 buffer_max = bufmax;
duke@435 819 }
duke@435 820
never@657 821 bufferedStream::bufferedStream(char* fixed_buffer, size_t fixed_buffer_size, size_t bufmax) : outputStream() {
duke@435 822 buffer_length = fixed_buffer_size;
duke@435 823 buffer = fixed_buffer;
duke@435 824 buffer_pos = 0;
duke@435 825 buffer_fixed = true;
never@657 826 buffer_max = bufmax;
duke@435 827 }
duke@435 828
duke@435 829 void bufferedStream::write(const char* s, size_t len) {
never@657 830
never@657 831 if(buffer_pos + len > buffer_max) {
never@657 832 flush();
never@657 833 }
never@657 834
duke@435 835 size_t end = buffer_pos + len;
duke@435 836 if (end >= buffer_length) {
duke@435 837 if (buffer_fixed) {
duke@435 838 // if buffer cannot resize, silently truncate
duke@435 839 len = buffer_length - buffer_pos - 1;
duke@435 840 } else {
duke@435 841 // For small overruns, double the buffer. For larger ones,
duke@435 842 // increase to the requested size.
duke@435 843 if (end < buffer_length * 2) {
duke@435 844 end = buffer_length * 2;
duke@435 845 }
duke@435 846 buffer = REALLOC_C_HEAP_ARRAY(char, buffer, end);
duke@435 847 buffer_length = end;
duke@435 848 }
duke@435 849 }
duke@435 850 memcpy(buffer + buffer_pos, s, len);
duke@435 851 buffer_pos += len;
duke@435 852 update_position(s, len);
duke@435 853 }
duke@435 854
duke@435 855 char* bufferedStream::as_string() {
duke@435 856 char* copy = NEW_RESOURCE_ARRAY(char, buffer_pos+1);
duke@435 857 strncpy(copy, buffer, buffer_pos);
duke@435 858 copy[buffer_pos] = 0; // terminating null
duke@435 859 return copy;
duke@435 860 }
duke@435 861
duke@435 862 bufferedStream::~bufferedStream() {
duke@435 863 if (!buffer_fixed) {
duke@435 864 FREE_C_HEAP_ARRAY(char, buffer);
duke@435 865 }
duke@435 866 }
duke@435 867
duke@435 868 #ifndef PRODUCT
duke@435 869
duke@435 870 #if defined(SOLARIS) || defined(LINUX)
duke@435 871 #include <sys/types.h>
duke@435 872 #include <sys/socket.h>
duke@435 873 #include <netinet/in.h>
duke@435 874 #include <arpa/inet.h>
duke@435 875 #endif
duke@435 876
duke@435 877 // Network access
never@657 878 networkStream::networkStream() : bufferedStream(1024*10, 1024*10) {
duke@435 879
duke@435 880 _socket = -1;
duke@435 881
duke@435 882 hpi::initialize_socket_library();
duke@435 883
duke@435 884 int result = hpi::socket(AF_INET, SOCK_STREAM, 0);
duke@435 885 if (result <= 0) {
duke@435 886 assert(false, "Socket could not be created!");
duke@435 887 } else {
duke@435 888 _socket = result;
duke@435 889 }
duke@435 890 }
duke@435 891
duke@435 892 int networkStream::read(char *buf, size_t len) {
duke@435 893 return hpi::recv(_socket, buf, (int)len, 0);
duke@435 894 }
duke@435 895
duke@435 896 void networkStream::flush() {
duke@435 897 if (size() != 0) {
never@657 898 int result = hpi::raw_send(_socket, (char *)base(), (int)size(), 0);
never@657 899 assert(result != -1, "connection error");
never@657 900 assert(result == (int)size(), "didn't send enough data");
duke@435 901 }
duke@435 902 reset();
duke@435 903 }
duke@435 904
duke@435 905 networkStream::~networkStream() {
duke@435 906 close();
duke@435 907 }
duke@435 908
duke@435 909 void networkStream::close() {
duke@435 910 if (_socket != -1) {
duke@435 911 flush();
duke@435 912 hpi::socket_close(_socket);
duke@435 913 _socket = -1;
duke@435 914 }
duke@435 915 }
duke@435 916
duke@435 917 bool networkStream::connect(const char *ip, short port) {
duke@435 918
duke@435 919 struct sockaddr_in server;
duke@435 920 server.sin_family = AF_INET;
duke@435 921 server.sin_port = htons(port);
duke@435 922
duke@435 923 server.sin_addr.s_addr = inet_addr(ip);
jcoomes@515 924 if (server.sin_addr.s_addr == (uint32_t)-1) {
duke@435 925 #ifdef _WINDOWS
duke@435 926 struct hostent* host = hpi::get_host_by_name((char*)ip);
duke@435 927 #else
duke@435 928 struct hostent* host = gethostbyname(ip);
duke@435 929 #endif
duke@435 930 if (host != NULL) {
duke@435 931 memcpy(&server.sin_addr, host->h_addr_list[0], host->h_length);
duke@435 932 } else {
duke@435 933 return false;
duke@435 934 }
duke@435 935 }
duke@435 936
duke@435 937
duke@435 938 int result = hpi::connect(_socket, (struct sockaddr*)&server, sizeof(struct sockaddr_in));
duke@435 939 return (result >= 0);
duke@435 940 }
duke@435 941
duke@435 942 #endif

mercurial