Fri, 10 Jun 2011 15:08:36 -0700
6941923: RFE: Handling large log files produced by long running Java Applications
Summary: supply optinal flags to realize gc log rotation
Reviewed-by: ysr, jwilhelm
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); |
minqi@2964 | 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 | |
minqi@2964 | 380 | rotatingFileStream::~rotatingFileStream() { |
minqi@2964 | 381 | if (_file != NULL) { |
minqi@2964 | 382 | if (_need_close) fclose(_file); |
minqi@2964 | 383 | _file = NULL; |
minqi@2964 | 384 | FREE_C_HEAP_ARRAY(char, _file_name); |
minqi@2964 | 385 | _file_name = NULL; |
minqi@2964 | 386 | } |
minqi@2964 | 387 | } |
minqi@2964 | 388 | |
minqi@2964 | 389 | rotatingFileStream::rotatingFileStream(const char* file_name) { |
minqi@2964 | 390 | _cur_file_num = 0; |
minqi@2964 | 391 | _bytes_writen = 0L; |
minqi@2964 | 392 | _file_name = NEW_C_HEAP_ARRAY(char, strlen(file_name)+10); |
minqi@2964 | 393 | jio_snprintf(_file_name, strlen(file_name)+10, "%s.%d", file_name, _cur_file_num); |
minqi@2964 | 394 | _file = fopen(_file_name, "w"); |
minqi@2964 | 395 | _need_close = true; |
minqi@2964 | 396 | } |
minqi@2964 | 397 | |
minqi@2964 | 398 | rotatingFileStream::rotatingFileStream(const char* file_name, const char* opentype) { |
minqi@2964 | 399 | _cur_file_num = 0; |
minqi@2964 | 400 | _bytes_writen = 0L; |
minqi@2964 | 401 | _file_name = NEW_C_HEAP_ARRAY(char, strlen(file_name)+10); |
minqi@2964 | 402 | jio_snprintf(_file_name, strlen(file_name)+10, "%s.%d", file_name, _cur_file_num); |
minqi@2964 | 403 | _file = fopen(_file_name, opentype); |
minqi@2964 | 404 | _need_close = true; |
minqi@2964 | 405 | } |
minqi@2964 | 406 | |
minqi@2964 | 407 | void rotatingFileStream::write(const char* s, size_t len) { |
minqi@2964 | 408 | if (_file != NULL) { |
minqi@2964 | 409 | // Make an unused local variable to avoid warning from gcc 4.x compiler. |
minqi@2964 | 410 | size_t count = fwrite(s, 1, len, _file); |
minqi@2964 | 411 | Atomic::add((jlong)count, &_bytes_writen); |
minqi@2964 | 412 | } |
minqi@2964 | 413 | update_position(s, len); |
minqi@2964 | 414 | } |
minqi@2964 | 415 | |
minqi@2964 | 416 | // rotate_log must be called from VMThread at safepoint. In case need change parameters |
minqi@2964 | 417 | // for gc log rotation from thread other than VMThread, a sub type of VM_Operation |
minqi@2964 | 418 | // should be created and be submitted to VMThread's operation queue. DO NOT call this |
minqi@2964 | 419 | // function directly. Currently, it is safe to rotate log at safepoint through VMThread. |
minqi@2964 | 420 | // That is, no mutator threads and concurrent GC threads run parallel with VMThread to |
minqi@2964 | 421 | // write to gc log file at safepoint. If in future, changes made for mutator threads or |
minqi@2964 | 422 | // concurrent GC threads to run parallel with VMThread at safepoint, write and rotate_log |
minqi@2964 | 423 | // must be synchronized. |
minqi@2964 | 424 | void rotatingFileStream::rotate_log() { |
minqi@2964 | 425 | if (_bytes_writen < (jlong)GCLogFileSize) return; |
minqi@2964 | 426 | #ifdef ASSERT |
minqi@2964 | 427 | Thread *thread = Thread::current(); |
minqi@2964 | 428 | assert(thread == NULL || |
minqi@2964 | 429 | (thread->is_VM_thread() && SafepointSynchronize::is_at_safepoint()), |
minqi@2964 | 430 | "Must be VMThread at safepoint"); |
minqi@2964 | 431 | #endif |
minqi@2964 | 432 | if (NumberOfGCLogFiles == 1) { |
minqi@2964 | 433 | // rotate in same file |
minqi@2964 | 434 | rewind(); |
minqi@2964 | 435 | _bytes_writen = 0L; |
minqi@2964 | 436 | return; |
minqi@2964 | 437 | } |
minqi@2964 | 438 | |
minqi@2964 | 439 | // rotate file in names file.0, file.1, file.2, ..., file.<MaxGCLogFileNumbers-1> |
minqi@2964 | 440 | // close current file, rotate to next file |
minqi@2964 | 441 | if (_file != NULL) { |
minqi@2964 | 442 | _cur_file_num ++; |
minqi@2964 | 443 | if (_cur_file_num >= NumberOfGCLogFiles) _cur_file_num = 0; |
minqi@2964 | 444 | jio_snprintf(_file_name, strlen(Arguments::gc_log_filename()) + 10, "%s.%d", |
minqi@2964 | 445 | Arguments::gc_log_filename(), _cur_file_num); |
minqi@2964 | 446 | fclose(_file); |
minqi@2964 | 447 | _file = NULL; |
minqi@2964 | 448 | } |
minqi@2964 | 449 | _file = fopen(_file_name, "w"); |
minqi@2964 | 450 | if (_file != NULL) { |
minqi@2964 | 451 | _bytes_writen = 0L; |
minqi@2964 | 452 | _need_close = true; |
minqi@2964 | 453 | } else { |
minqi@2964 | 454 | tty->print_cr("failed to open rotation log file %s due to %s\n", |
minqi@2964 | 455 | _file_name, strerror(errno)); |
minqi@2964 | 456 | _need_close = false; |
minqi@2964 | 457 | } |
minqi@2964 | 458 | } |
minqi@2964 | 459 | |
duke@435 | 460 | defaultStream* defaultStream::instance = NULL; |
duke@435 | 461 | int defaultStream::_output_fd = 1; |
duke@435 | 462 | int defaultStream::_error_fd = 2; |
duke@435 | 463 | FILE* defaultStream::_output_stream = stdout; |
duke@435 | 464 | FILE* defaultStream::_error_stream = stderr; |
duke@435 | 465 | |
duke@435 | 466 | #define LOG_MAJOR_VERSION 160 |
duke@435 | 467 | #define LOG_MINOR_VERSION 1 |
duke@435 | 468 | |
duke@435 | 469 | void defaultStream::init() { |
duke@435 | 470 | _inited = true; |
duke@435 | 471 | if (LogVMOutput || LogCompilation) { |
duke@435 | 472 | init_log(); |
duke@435 | 473 | } |
duke@435 | 474 | } |
duke@435 | 475 | |
duke@435 | 476 | bool defaultStream::has_log_file() { |
duke@435 | 477 | // lazily create log file (at startup, LogVMOutput is false even |
duke@435 | 478 | // if +LogVMOutput is used, because the flags haven't been parsed yet) |
duke@435 | 479 | // For safer printing during fatal error handling, do not init logfile |
duke@435 | 480 | // if a VM error has been reported. |
duke@435 | 481 | if (!_inited && !is_error_reported()) init(); |
duke@435 | 482 | return _log_file != NULL; |
duke@435 | 483 | } |
duke@435 | 484 | |
coleenp@1788 | 485 | static const char* make_log_name(const char* log_name, const char* force_directory) { |
duke@435 | 486 | const char* basename = log_name; |
duke@435 | 487 | char file_sep = os::file_separator()[0]; |
duke@435 | 488 | const char* cp; |
duke@435 | 489 | for (cp = log_name; *cp != '\0'; cp++) { |
duke@435 | 490 | if (*cp == '/' || *cp == file_sep) { |
duke@435 | 491 | basename = cp+1; |
duke@435 | 492 | } |
duke@435 | 493 | } |
duke@435 | 494 | const char* nametail = log_name; |
duke@435 | 495 | |
coleenp@1788 | 496 | // Compute buffer length |
coleenp@1788 | 497 | size_t buffer_length; |
coleenp@1788 | 498 | if (force_directory != NULL) { |
coleenp@1788 | 499 | buffer_length = strlen(force_directory) + strlen(os::file_separator()) + |
coleenp@1788 | 500 | strlen(basename) + 1; |
coleenp@1788 | 501 | } else { |
coleenp@1788 | 502 | buffer_length = strlen(log_name) + 1; |
coleenp@1788 | 503 | } |
coleenp@1788 | 504 | |
coleenp@1788 | 505 | const char* star = strchr(basename, '*'); |
coleenp@1788 | 506 | int star_pos = (star == NULL) ? -1 : (star - nametail); |
never@2682 | 507 | int skip = 1; |
never@2682 | 508 | if (star == NULL) { |
never@2682 | 509 | // Try %p |
never@2682 | 510 | star = strstr(basename, "%p"); |
never@2682 | 511 | if (star != NULL) { |
never@2682 | 512 | skip = 2; |
never@2682 | 513 | } |
never@2682 | 514 | } |
never@2682 | 515 | star_pos = (star == NULL) ? -1 : (star - nametail); |
coleenp@1788 | 516 | |
coleenp@1788 | 517 | char pid[32]; |
coleenp@1788 | 518 | if (star_pos >= 0) { |
coleenp@1788 | 519 | jio_snprintf(pid, sizeof(pid), "%u", os::current_process_id()); |
coleenp@1788 | 520 | buffer_length += strlen(pid); |
coleenp@1788 | 521 | } |
coleenp@1788 | 522 | |
coleenp@1788 | 523 | // Create big enough buffer. |
coleenp@1788 | 524 | char *buf = NEW_C_HEAP_ARRAY(char, buffer_length); |
coleenp@1788 | 525 | |
duke@435 | 526 | strcpy(buf, ""); |
duke@435 | 527 | if (force_directory != NULL) { |
duke@435 | 528 | strcat(buf, force_directory); |
duke@435 | 529 | strcat(buf, os::file_separator()); |
duke@435 | 530 | nametail = basename; // completely skip directory prefix |
duke@435 | 531 | } |
duke@435 | 532 | |
duke@435 | 533 | if (star_pos >= 0) { |
never@2682 | 534 | // convert foo*bar.log or foo%pbar.log to foo123bar.log |
duke@435 | 535 | int buf_pos = (int) strlen(buf); |
duke@435 | 536 | strncpy(&buf[buf_pos], nametail, star_pos); |
coleenp@1788 | 537 | strcpy(&buf[buf_pos + star_pos], pid); |
never@2682 | 538 | nametail += star_pos + skip; // skip prefix and pid format |
duke@435 | 539 | } |
duke@435 | 540 | |
duke@435 | 541 | strcat(buf, nametail); // append rest of name, or all of name |
duke@435 | 542 | return buf; |
duke@435 | 543 | } |
duke@435 | 544 | |
duke@435 | 545 | void defaultStream::init_log() { |
duke@435 | 546 | // %%% Need a MutexLocker? |
duke@435 | 547 | const char* log_name = LogFile != NULL ? LogFile : "hotspot.log"; |
coleenp@1788 | 548 | const char* try_name = make_log_name(log_name, NULL); |
duke@435 | 549 | fileStream* file = new(ResourceObj::C_HEAP) fileStream(try_name); |
duke@435 | 550 | if (!file->is_open()) { |
duke@435 | 551 | // Try again to open the file. |
duke@435 | 552 | char warnbuf[O_BUFLEN*2]; |
coleenp@1788 | 553 | jio_snprintf(warnbuf, sizeof(warnbuf), |
coleenp@1788 | 554 | "Warning: Cannot open log file: %s\n", try_name); |
duke@435 | 555 | // Note: This feature is for maintainer use only. No need for L10N. |
duke@435 | 556 | jio_print(warnbuf); |
coleenp@1788 | 557 | FREE_C_HEAP_ARRAY(char, try_name); |
never@2682 | 558 | try_name = make_log_name("hs_pid%p.log", os::get_temp_directory()); |
coleenp@1788 | 559 | jio_snprintf(warnbuf, sizeof(warnbuf), |
coleenp@1788 | 560 | "Warning: Forcing option -XX:LogFile=%s\n", try_name); |
duke@435 | 561 | jio_print(warnbuf); |
duke@435 | 562 | delete file; |
duke@435 | 563 | file = new(ResourceObj::C_HEAP) fileStream(try_name); |
coleenp@1788 | 564 | FREE_C_HEAP_ARRAY(char, try_name); |
duke@435 | 565 | } |
duke@435 | 566 | if (file->is_open()) { |
duke@435 | 567 | _log_file = file; |
duke@435 | 568 | xmlStream* xs = new(ResourceObj::C_HEAP) xmlStream(file); |
duke@435 | 569 | _outer_xmlStream = xs; |
duke@435 | 570 | if (this == tty) xtty = xs; |
duke@435 | 571 | // Write XML header. |
duke@435 | 572 | xs->print_cr("<?xml version='1.0' encoding='UTF-8'?>"); |
duke@435 | 573 | // (For now, don't bother to issue a DTD for this private format.) |
duke@435 | 574 | jlong time_ms = os::javaTimeMillis() - tty->time_stamp().milliseconds(); |
duke@435 | 575 | // %%% Should be: jlong time_ms = os::start_time_milliseconds(), if |
duke@435 | 576 | // we ever get round to introduce that method on the os class |
duke@435 | 577 | xs->head("hotspot_log version='%d %d'" |
duke@435 | 578 | " process='%d' time_ms='"INT64_FORMAT"'", |
duke@435 | 579 | LOG_MAJOR_VERSION, LOG_MINOR_VERSION, |
duke@435 | 580 | os::current_process_id(), time_ms); |
duke@435 | 581 | // Write VM version header immediately. |
duke@435 | 582 | xs->head("vm_version"); |
duke@435 | 583 | xs->head("name"); xs->text("%s", VM_Version::vm_name()); xs->cr(); |
duke@435 | 584 | xs->tail("name"); |
duke@435 | 585 | xs->head("release"); xs->text("%s", VM_Version::vm_release()); xs->cr(); |
duke@435 | 586 | xs->tail("release"); |
duke@435 | 587 | xs->head("info"); xs->text("%s", VM_Version::internal_vm_info_string()); xs->cr(); |
duke@435 | 588 | xs->tail("info"); |
duke@435 | 589 | xs->tail("vm_version"); |
duke@435 | 590 | // Record information about the command-line invocation. |
duke@435 | 591 | xs->head("vm_arguments"); // Cf. Arguments::print_on() |
duke@435 | 592 | if (Arguments::num_jvm_flags() > 0) { |
duke@435 | 593 | xs->head("flags"); |
duke@435 | 594 | Arguments::print_jvm_flags_on(xs->text()); |
duke@435 | 595 | xs->tail("flags"); |
duke@435 | 596 | } |
duke@435 | 597 | if (Arguments::num_jvm_args() > 0) { |
duke@435 | 598 | xs->head("args"); |
duke@435 | 599 | Arguments::print_jvm_args_on(xs->text()); |
duke@435 | 600 | xs->tail("args"); |
duke@435 | 601 | } |
duke@435 | 602 | if (Arguments::java_command() != NULL) { |
duke@435 | 603 | xs->head("command"); xs->text()->print_cr("%s", Arguments::java_command()); |
duke@435 | 604 | xs->tail("command"); |
duke@435 | 605 | } |
duke@435 | 606 | if (Arguments::sun_java_launcher() != NULL) { |
duke@435 | 607 | xs->head("launcher"); xs->text()->print_cr("%s", Arguments::sun_java_launcher()); |
duke@435 | 608 | xs->tail("launcher"); |
duke@435 | 609 | } |
duke@435 | 610 | if (Arguments::system_properties() != NULL) { |
duke@435 | 611 | xs->head("properties"); |
duke@435 | 612 | // Print it as a java-style property list. |
duke@435 | 613 | // System properties don't generally contain newlines, so don't bother with unparsing. |
duke@435 | 614 | for (SystemProperty* p = Arguments::system_properties(); p != NULL; p = p->next()) { |
duke@435 | 615 | xs->text()->print_cr("%s=%s", p->key(), p->value()); |
duke@435 | 616 | } |
duke@435 | 617 | xs->tail("properties"); |
duke@435 | 618 | } |
duke@435 | 619 | xs->tail("vm_arguments"); |
duke@435 | 620 | // tty output per se is grouped under the <tty>...</tty> element. |
duke@435 | 621 | xs->head("tty"); |
duke@435 | 622 | // All further non-markup text gets copied to the tty: |
duke@435 | 623 | xs->_text = this; // requires friend declaration! |
duke@435 | 624 | } else { |
duke@435 | 625 | delete(file); |
duke@435 | 626 | // and leave xtty as NULL |
duke@435 | 627 | LogVMOutput = false; |
duke@435 | 628 | DisplayVMOutput = true; |
duke@435 | 629 | LogCompilation = false; |
duke@435 | 630 | } |
duke@435 | 631 | } |
duke@435 | 632 | |
duke@435 | 633 | // finish_log() is called during normal VM shutdown. finish_log_on_error() is |
duke@435 | 634 | // called by ostream_abort() after a fatal error. |
duke@435 | 635 | // |
duke@435 | 636 | void defaultStream::finish_log() { |
duke@435 | 637 | xmlStream* xs = _outer_xmlStream; |
duke@435 | 638 | xs->done("tty"); |
duke@435 | 639 | |
duke@435 | 640 | // Other log forks are appended here, at the End of Time: |
duke@435 | 641 | CompileLog::finish_log(xs->out()); // write compile logging, if any, now |
duke@435 | 642 | |
duke@435 | 643 | xs->done("hotspot_log"); |
duke@435 | 644 | xs->flush(); |
duke@435 | 645 | |
duke@435 | 646 | fileStream* file = _log_file; |
duke@435 | 647 | _log_file = NULL; |
duke@435 | 648 | |
duke@435 | 649 | delete _outer_xmlStream; |
duke@435 | 650 | _outer_xmlStream = NULL; |
duke@435 | 651 | |
duke@435 | 652 | file->flush(); |
duke@435 | 653 | delete file; |
duke@435 | 654 | } |
duke@435 | 655 | |
duke@435 | 656 | void defaultStream::finish_log_on_error(char *buf, int buflen) { |
duke@435 | 657 | xmlStream* xs = _outer_xmlStream; |
duke@435 | 658 | |
duke@435 | 659 | if (xs && xs->out()) { |
duke@435 | 660 | |
duke@435 | 661 | xs->done_raw("tty"); |
duke@435 | 662 | |
duke@435 | 663 | // Other log forks are appended here, at the End of Time: |
duke@435 | 664 | CompileLog::finish_log_on_error(xs->out(), buf, buflen); // write compile logging, if any, now |
duke@435 | 665 | |
duke@435 | 666 | xs->done_raw("hotspot_log"); |
duke@435 | 667 | xs->flush(); |
duke@435 | 668 | |
duke@435 | 669 | fileStream* file = _log_file; |
duke@435 | 670 | _log_file = NULL; |
duke@435 | 671 | _outer_xmlStream = NULL; |
duke@435 | 672 | |
duke@435 | 673 | if (file) { |
duke@435 | 674 | file->flush(); |
duke@435 | 675 | |
duke@435 | 676 | // Can't delete or close the file because delete and fclose aren't |
duke@435 | 677 | // async-safe. We are about to die, so leave it to the kernel. |
duke@435 | 678 | // delete file; |
duke@435 | 679 | } |
duke@435 | 680 | } |
duke@435 | 681 | } |
duke@435 | 682 | |
duke@435 | 683 | intx defaultStream::hold(intx writer_id) { |
duke@435 | 684 | bool has_log = has_log_file(); // check before locking |
duke@435 | 685 | if (// impossible, but who knows? |
duke@435 | 686 | writer_id == NO_WRITER || |
duke@435 | 687 | |
duke@435 | 688 | // bootstrap problem |
duke@435 | 689 | tty_lock == NULL || |
duke@435 | 690 | |
duke@435 | 691 | // can't grab a lock or call Thread::current() if TLS isn't initialized |
duke@435 | 692 | ThreadLocalStorage::thread() == NULL || |
duke@435 | 693 | |
duke@435 | 694 | // developer hook |
duke@435 | 695 | !SerializeVMOutput || |
duke@435 | 696 | |
duke@435 | 697 | // VM already unhealthy |
duke@435 | 698 | is_error_reported() || |
duke@435 | 699 | |
duke@435 | 700 | // safepoint == global lock (for VM only) |
duke@435 | 701 | (SafepointSynchronize::is_synchronizing() && |
duke@435 | 702 | Thread::current()->is_VM_thread()) |
duke@435 | 703 | ) { |
duke@435 | 704 | // do not attempt to lock unless we know the thread and the VM is healthy |
duke@435 | 705 | return NO_WRITER; |
duke@435 | 706 | } |
duke@435 | 707 | if (_writer == writer_id) { |
duke@435 | 708 | // already held, no need to re-grab the lock |
duke@435 | 709 | return NO_WRITER; |
duke@435 | 710 | } |
duke@435 | 711 | tty_lock->lock_without_safepoint_check(); |
duke@435 | 712 | // got the lock |
duke@435 | 713 | if (writer_id != _last_writer) { |
duke@435 | 714 | if (has_log) { |
duke@435 | 715 | _log_file->bol(); |
duke@435 | 716 | // output a hint where this output is coming from: |
duke@435 | 717 | _log_file->print_cr("<writer thread='"INTX_FORMAT"'/>", writer_id); |
duke@435 | 718 | } |
duke@435 | 719 | _last_writer = writer_id; |
duke@435 | 720 | } |
duke@435 | 721 | _writer = writer_id; |
duke@435 | 722 | return writer_id; |
duke@435 | 723 | } |
duke@435 | 724 | |
duke@435 | 725 | void defaultStream::release(intx holder) { |
duke@435 | 726 | if (holder == NO_WRITER) { |
duke@435 | 727 | // nothing to release: either a recursive lock, or we scribbled (too bad) |
duke@435 | 728 | return; |
duke@435 | 729 | } |
duke@435 | 730 | if (_writer != holder) { |
duke@435 | 731 | return; // already unlocked, perhaps via break_tty_lock_for_safepoint |
duke@435 | 732 | } |
duke@435 | 733 | _writer = NO_WRITER; |
duke@435 | 734 | tty_lock->unlock(); |
duke@435 | 735 | } |
duke@435 | 736 | |
duke@435 | 737 | |
duke@435 | 738 | // Yuck: jio_print does not accept char*/len. |
duke@435 | 739 | static void call_jio_print(const char* s, size_t len) { |
duke@435 | 740 | char buffer[O_BUFLEN+100]; |
duke@435 | 741 | if (len > sizeof(buffer)-1) { |
duke@435 | 742 | warning("increase O_BUFLEN in ostream.cpp -- output truncated"); |
duke@435 | 743 | len = sizeof(buffer)-1; |
duke@435 | 744 | } |
duke@435 | 745 | strncpy(buffer, s, len); |
duke@435 | 746 | buffer[len] = '\0'; |
duke@435 | 747 | jio_print(buffer); |
duke@435 | 748 | } |
duke@435 | 749 | |
duke@435 | 750 | |
duke@435 | 751 | void defaultStream::write(const char* s, size_t len) { |
duke@435 | 752 | intx thread_id = os::current_thread_id(); |
duke@435 | 753 | intx holder = hold(thread_id); |
duke@435 | 754 | |
duke@435 | 755 | if (DisplayVMOutput && |
duke@435 | 756 | (_outer_xmlStream == NULL || !_outer_xmlStream->inside_attrs())) { |
duke@435 | 757 | // print to output stream. It can be redirected by a vfprintf hook |
duke@435 | 758 | if (s[len] == '\0') { |
duke@435 | 759 | jio_print(s); |
duke@435 | 760 | } else { |
duke@435 | 761 | call_jio_print(s, len); |
duke@435 | 762 | } |
duke@435 | 763 | } |
duke@435 | 764 | |
duke@435 | 765 | // print to log file |
duke@435 | 766 | if (has_log_file()) { |
duke@435 | 767 | int nl0 = _newlines; |
duke@435 | 768 | xmlTextStream::write(s, len); |
duke@435 | 769 | // flush the log file too, if there were any newlines |
duke@435 | 770 | if (nl0 != _newlines){ |
duke@435 | 771 | flush(); |
duke@435 | 772 | } |
duke@435 | 773 | } else { |
duke@435 | 774 | update_position(s, len); |
duke@435 | 775 | } |
duke@435 | 776 | |
duke@435 | 777 | release(holder); |
duke@435 | 778 | } |
duke@435 | 779 | |
duke@435 | 780 | intx ttyLocker::hold_tty() { |
duke@435 | 781 | if (defaultStream::instance == NULL) return defaultStream::NO_WRITER; |
duke@435 | 782 | intx thread_id = os::current_thread_id(); |
duke@435 | 783 | return defaultStream::instance->hold(thread_id); |
duke@435 | 784 | } |
duke@435 | 785 | |
duke@435 | 786 | void ttyLocker::release_tty(intx holder) { |
duke@435 | 787 | if (holder == defaultStream::NO_WRITER) return; |
duke@435 | 788 | defaultStream::instance->release(holder); |
duke@435 | 789 | } |
duke@435 | 790 | |
never@2570 | 791 | bool ttyLocker::release_tty_if_locked() { |
never@2570 | 792 | intx thread_id = os::current_thread_id(); |
never@2570 | 793 | if (defaultStream::instance->writer() == thread_id) { |
never@2570 | 794 | // release the lock and return true so callers know if was |
never@2570 | 795 | // previously held. |
never@2570 | 796 | release_tty(thread_id); |
never@2570 | 797 | return true; |
never@2570 | 798 | } |
never@2570 | 799 | return false; |
never@2570 | 800 | } |
never@2570 | 801 | |
duke@435 | 802 | void ttyLocker::break_tty_lock_for_safepoint(intx holder) { |
duke@435 | 803 | if (defaultStream::instance != NULL && |
duke@435 | 804 | defaultStream::instance->writer() == holder) { |
duke@435 | 805 | if (xtty != NULL) { |
duke@435 | 806 | xtty->print_cr("<!-- safepoint while printing -->"); |
duke@435 | 807 | } |
duke@435 | 808 | defaultStream::instance->release(holder); |
duke@435 | 809 | } |
duke@435 | 810 | // (else there was no lock to break) |
duke@435 | 811 | } |
duke@435 | 812 | |
duke@435 | 813 | void ostream_init() { |
duke@435 | 814 | if (defaultStream::instance == NULL) { |
duke@435 | 815 | defaultStream::instance = new(ResourceObj::C_HEAP) defaultStream(); |
duke@435 | 816 | tty = defaultStream::instance; |
duke@435 | 817 | |
duke@435 | 818 | // We want to ensure that time stamps in GC logs consider time 0 |
duke@435 | 819 | // the time when the JVM is initialized, not the first time we ask |
duke@435 | 820 | // for a time stamp. So, here, we explicitly update the time stamp |
duke@435 | 821 | // of tty. |
duke@435 | 822 | tty->time_stamp().update_to(1); |
duke@435 | 823 | } |
duke@435 | 824 | } |
duke@435 | 825 | |
duke@435 | 826 | void ostream_init_log() { |
duke@435 | 827 | // For -Xloggc:<file> option - called in runtime/thread.cpp |
duke@435 | 828 | // Note : this must be called AFTER ostream_init() |
duke@435 | 829 | |
duke@435 | 830 | gclog_or_tty = tty; // default to tty |
duke@435 | 831 | if (Arguments::gc_log_filename() != NULL) { |
minqi@2964 | 832 | fileStream * gclog = UseGCLogFileRotation ? |
minqi@2964 | 833 | new(ResourceObj::C_HEAP) |
minqi@2964 | 834 | rotatingFileStream(Arguments::gc_log_filename()) : |
minqi@2964 | 835 | new(ResourceObj::C_HEAP) |
minqi@2964 | 836 | fileStream(Arguments::gc_log_filename()); |
duke@435 | 837 | if (gclog->is_open()) { |
duke@435 | 838 | // now we update the time stamp of the GC log to be synced up |
duke@435 | 839 | // with tty. |
duke@435 | 840 | gclog->time_stamp().update_to(tty->time_stamp().ticks()); |
duke@435 | 841 | } |
minqi@2964 | 842 | gclog_or_tty = gclog; |
duke@435 | 843 | } |
duke@435 | 844 | |
duke@435 | 845 | // If we haven't lazily initialized the logfile yet, do it now, |
duke@435 | 846 | // to avoid the possibility of lazy initialization during a VM |
duke@435 | 847 | // crash, which can affect the stability of the fatal error handler. |
duke@435 | 848 | defaultStream::instance->has_log_file(); |
duke@435 | 849 | } |
duke@435 | 850 | |
duke@435 | 851 | // ostream_exit() is called during normal VM exit to finish log files, flush |
duke@435 | 852 | // output and free resource. |
duke@435 | 853 | void ostream_exit() { |
duke@435 | 854 | static bool ostream_exit_called = false; |
duke@435 | 855 | if (ostream_exit_called) return; |
duke@435 | 856 | ostream_exit_called = true; |
duke@435 | 857 | if (gclog_or_tty != tty) { |
duke@435 | 858 | delete gclog_or_tty; |
duke@435 | 859 | } |
duke@435 | 860 | { |
duke@435 | 861 | // we temporaly disable PrintMallocFree here |
duke@435 | 862 | // as otherwise it'll lead to using of almost deleted |
duke@435 | 863 | // tty or defaultStream::instance in logging facility |
duke@435 | 864 | // of HeapFree(), see 6391258 |
duke@435 | 865 | DEBUG_ONLY(FlagSetting fs(PrintMallocFree, false);) |
duke@435 | 866 | if (tty != defaultStream::instance) { |
duke@435 | 867 | delete tty; |
duke@435 | 868 | } |
duke@435 | 869 | if (defaultStream::instance != NULL) { |
duke@435 | 870 | delete defaultStream::instance; |
duke@435 | 871 | } |
duke@435 | 872 | } |
duke@435 | 873 | tty = NULL; |
duke@435 | 874 | xtty = NULL; |
duke@435 | 875 | gclog_or_tty = NULL; |
duke@435 | 876 | defaultStream::instance = NULL; |
duke@435 | 877 | } |
duke@435 | 878 | |
duke@435 | 879 | // ostream_abort() is called by os::abort() when VM is about to die. |
duke@435 | 880 | void ostream_abort() { |
duke@435 | 881 | // Here we can't delete gclog_or_tty and tty, just flush their output |
duke@435 | 882 | if (gclog_or_tty) gclog_or_tty->flush(); |
duke@435 | 883 | if (tty) tty->flush(); |
duke@435 | 884 | |
duke@435 | 885 | if (defaultStream::instance != NULL) { |
duke@435 | 886 | static char buf[4096]; |
duke@435 | 887 | defaultStream::instance->finish_log_on_error(buf, sizeof(buf)); |
duke@435 | 888 | } |
duke@435 | 889 | } |
duke@435 | 890 | |
duke@435 | 891 | staticBufferStream::staticBufferStream(char* buffer, size_t buflen, |
duke@435 | 892 | outputStream *outer_stream) { |
duke@435 | 893 | _buffer = buffer; |
duke@435 | 894 | _buflen = buflen; |
duke@435 | 895 | _outer_stream = outer_stream; |
kvn@2702 | 896 | // compile task prints time stamp relative to VM start |
kvn@2702 | 897 | _stamp.update_to(1); |
duke@435 | 898 | } |
duke@435 | 899 | |
duke@435 | 900 | void staticBufferStream::write(const char* c, size_t len) { |
duke@435 | 901 | _outer_stream->print_raw(c, (int)len); |
duke@435 | 902 | } |
duke@435 | 903 | |
duke@435 | 904 | void staticBufferStream::flush() { |
duke@435 | 905 | _outer_stream->flush(); |
duke@435 | 906 | } |
duke@435 | 907 | |
duke@435 | 908 | void staticBufferStream::print(const char* format, ...) { |
duke@435 | 909 | va_list ap; |
duke@435 | 910 | va_start(ap, format); |
duke@435 | 911 | size_t len; |
duke@435 | 912 | const char* str = do_vsnprintf(_buffer, _buflen, format, ap, false, len); |
duke@435 | 913 | write(str, len); |
duke@435 | 914 | va_end(ap); |
duke@435 | 915 | } |
duke@435 | 916 | |
duke@435 | 917 | void staticBufferStream::print_cr(const char* format, ...) { |
duke@435 | 918 | va_list ap; |
duke@435 | 919 | va_start(ap, format); |
duke@435 | 920 | size_t len; |
duke@435 | 921 | const char* str = do_vsnprintf(_buffer, _buflen, format, ap, true, len); |
duke@435 | 922 | write(str, len); |
duke@435 | 923 | va_end(ap); |
duke@435 | 924 | } |
duke@435 | 925 | |
duke@435 | 926 | void staticBufferStream::vprint(const char *format, va_list argptr) { |
duke@435 | 927 | size_t len; |
duke@435 | 928 | const char* str = do_vsnprintf(_buffer, _buflen, format, argptr, false, len); |
duke@435 | 929 | write(str, len); |
duke@435 | 930 | } |
duke@435 | 931 | |
duke@435 | 932 | void staticBufferStream::vprint_cr(const char* format, va_list argptr) { |
duke@435 | 933 | size_t len; |
duke@435 | 934 | const char* str = do_vsnprintf(_buffer, _buflen, format, argptr, true, len); |
duke@435 | 935 | write(str, len); |
duke@435 | 936 | } |
duke@435 | 937 | |
never@657 | 938 | bufferedStream::bufferedStream(size_t initial_size, size_t bufmax) : outputStream() { |
duke@435 | 939 | buffer_length = initial_size; |
duke@435 | 940 | buffer = NEW_C_HEAP_ARRAY(char, buffer_length); |
duke@435 | 941 | buffer_pos = 0; |
duke@435 | 942 | buffer_fixed = false; |
never@657 | 943 | buffer_max = bufmax; |
duke@435 | 944 | } |
duke@435 | 945 | |
never@657 | 946 | bufferedStream::bufferedStream(char* fixed_buffer, size_t fixed_buffer_size, size_t bufmax) : outputStream() { |
duke@435 | 947 | buffer_length = fixed_buffer_size; |
duke@435 | 948 | buffer = fixed_buffer; |
duke@435 | 949 | buffer_pos = 0; |
duke@435 | 950 | buffer_fixed = true; |
never@657 | 951 | buffer_max = bufmax; |
duke@435 | 952 | } |
duke@435 | 953 | |
duke@435 | 954 | void bufferedStream::write(const char* s, size_t len) { |
never@657 | 955 | |
never@657 | 956 | if(buffer_pos + len > buffer_max) { |
never@657 | 957 | flush(); |
never@657 | 958 | } |
never@657 | 959 | |
duke@435 | 960 | size_t end = buffer_pos + len; |
duke@435 | 961 | if (end >= buffer_length) { |
duke@435 | 962 | if (buffer_fixed) { |
duke@435 | 963 | // if buffer cannot resize, silently truncate |
duke@435 | 964 | len = buffer_length - buffer_pos - 1; |
duke@435 | 965 | } else { |
duke@435 | 966 | // For small overruns, double the buffer. For larger ones, |
duke@435 | 967 | // increase to the requested size. |
duke@435 | 968 | if (end < buffer_length * 2) { |
duke@435 | 969 | end = buffer_length * 2; |
duke@435 | 970 | } |
duke@435 | 971 | buffer = REALLOC_C_HEAP_ARRAY(char, buffer, end); |
duke@435 | 972 | buffer_length = end; |
duke@435 | 973 | } |
duke@435 | 974 | } |
duke@435 | 975 | memcpy(buffer + buffer_pos, s, len); |
duke@435 | 976 | buffer_pos += len; |
duke@435 | 977 | update_position(s, len); |
duke@435 | 978 | } |
duke@435 | 979 | |
duke@435 | 980 | char* bufferedStream::as_string() { |
duke@435 | 981 | char* copy = NEW_RESOURCE_ARRAY(char, buffer_pos+1); |
duke@435 | 982 | strncpy(copy, buffer, buffer_pos); |
duke@435 | 983 | copy[buffer_pos] = 0; // terminating null |
duke@435 | 984 | return copy; |
duke@435 | 985 | } |
duke@435 | 986 | |
duke@435 | 987 | bufferedStream::~bufferedStream() { |
duke@435 | 988 | if (!buffer_fixed) { |
duke@435 | 989 | FREE_C_HEAP_ARRAY(char, buffer); |
duke@435 | 990 | } |
duke@435 | 991 | } |
duke@435 | 992 | |
duke@435 | 993 | #ifndef PRODUCT |
duke@435 | 994 | |
duke@435 | 995 | #if defined(SOLARIS) || defined(LINUX) |
duke@435 | 996 | #include <sys/types.h> |
duke@435 | 997 | #include <sys/socket.h> |
duke@435 | 998 | #include <netinet/in.h> |
duke@435 | 999 | #include <arpa/inet.h> |
duke@435 | 1000 | #endif |
duke@435 | 1001 | |
duke@435 | 1002 | // Network access |
never@657 | 1003 | networkStream::networkStream() : bufferedStream(1024*10, 1024*10) { |
duke@435 | 1004 | |
duke@435 | 1005 | _socket = -1; |
duke@435 | 1006 | |
ikrylov@2322 | 1007 | int result = os::socket(AF_INET, SOCK_STREAM, 0); |
duke@435 | 1008 | if (result <= 0) { |
duke@435 | 1009 | assert(false, "Socket could not be created!"); |
duke@435 | 1010 | } else { |
duke@435 | 1011 | _socket = result; |
duke@435 | 1012 | } |
duke@435 | 1013 | } |
duke@435 | 1014 | |
duke@435 | 1015 | int networkStream::read(char *buf, size_t len) { |
ikrylov@2322 | 1016 | return os::recv(_socket, buf, (int)len, 0); |
duke@435 | 1017 | } |
duke@435 | 1018 | |
duke@435 | 1019 | void networkStream::flush() { |
duke@435 | 1020 | if (size() != 0) { |
ikrylov@2322 | 1021 | int result = os::raw_send(_socket, (char *)base(), (int)size(), 0); |
never@657 | 1022 | assert(result != -1, "connection error"); |
never@657 | 1023 | assert(result == (int)size(), "didn't send enough data"); |
duke@435 | 1024 | } |
duke@435 | 1025 | reset(); |
duke@435 | 1026 | } |
duke@435 | 1027 | |
duke@435 | 1028 | networkStream::~networkStream() { |
duke@435 | 1029 | close(); |
duke@435 | 1030 | } |
duke@435 | 1031 | |
duke@435 | 1032 | void networkStream::close() { |
duke@435 | 1033 | if (_socket != -1) { |
duke@435 | 1034 | flush(); |
ikrylov@2322 | 1035 | os::socket_close(_socket); |
duke@435 | 1036 | _socket = -1; |
duke@435 | 1037 | } |
duke@435 | 1038 | } |
duke@435 | 1039 | |
duke@435 | 1040 | bool networkStream::connect(const char *ip, short port) { |
duke@435 | 1041 | |
duke@435 | 1042 | struct sockaddr_in server; |
duke@435 | 1043 | server.sin_family = AF_INET; |
duke@435 | 1044 | server.sin_port = htons(port); |
duke@435 | 1045 | |
duke@435 | 1046 | server.sin_addr.s_addr = inet_addr(ip); |
jcoomes@515 | 1047 | if (server.sin_addr.s_addr == (uint32_t)-1) { |
ikrylov@2322 | 1048 | struct hostent* host = os::get_host_by_name((char*)ip); |
duke@435 | 1049 | if (host != NULL) { |
duke@435 | 1050 | memcpy(&server.sin_addr, host->h_addr_list[0], host->h_length); |
duke@435 | 1051 | } else { |
duke@435 | 1052 | return false; |
duke@435 | 1053 | } |
duke@435 | 1054 | } |
duke@435 | 1055 | |
duke@435 | 1056 | |
ikrylov@2322 | 1057 | int result = os::connect(_socket, (struct sockaddr*)&server, sizeof(struct sockaddr_in)); |
duke@435 | 1058 | return (result >= 0); |
duke@435 | 1059 | } |
duke@435 | 1060 | |
duke@435 | 1061 | #endif |