src/share/vm/utilities/ostream.cpp

Thu, 31 Mar 2011 16:54:27 -0700

author
kvn
date
Thu, 31 Mar 2011 16:54:27 -0700
changeset 2702
8010c8c623ac
parent 2682
29524004ce17
child 2964
2a241e764894
permissions
-rw-r--r--

7032849: 7022998 changes broke hs_err compile task print
Summary: Initialize the time stamp on ostream used for hs_err dumping.
Reviewed-by: never

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

mercurial