Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 1 | // Copyright 2009 the V8 project authors. All rights reserved. |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 2 | // Use of this source code is governed by a BSD-style license that can be |
| 3 | // found in the LICENSE file. |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 4 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 5 | #include "src/v8.h" |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 6 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 7 | #include "src/log-utils.h" |
| 8 | #include "src/string-stream.h" |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 9 | |
| 10 | namespace v8 { |
| 11 | namespace internal { |
| 12 | |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 13 | |
Ben Murdoch | 69a99ed | 2011-11-30 16:03:39 +0000 | [diff] [blame] | 14 | const char* const Log::kLogToTemporaryFile = "&"; |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 15 | const char* const Log::kLogToConsole = "-"; |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 16 | |
| 17 | |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 18 | Log::Log(Logger* logger) |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 19 | : is_stopped_(false), |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 20 | output_handle_(NULL), |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 21 | message_buffer_(NULL), |
| 22 | logger_(logger) { |
| 23 | } |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 24 | |
| 25 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 26 | void Log::Initialize(const char* log_file_name) { |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 27 | message_buffer_ = NewArray<char>(kMessageBufferSize); |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 28 | |
| 29 | // --log-all enables all the log flags. |
| 30 | if (FLAG_log_all) { |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 31 | FLAG_log_api = true; |
| 32 | FLAG_log_code = true; |
| 33 | FLAG_log_gc = true; |
| 34 | FLAG_log_suspect = true; |
| 35 | FLAG_log_handles = true; |
| 36 | FLAG_log_regexp = true; |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 37 | FLAG_log_internal_timer_events = true; |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 38 | } |
| 39 | |
| 40 | // --prof implies --log-code. |
| 41 | if (FLAG_prof) FLAG_log_code = true; |
| 42 | |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 43 | // If we're logging anything, we need to open the log file. |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 44 | if (Log::InitLogAtStart()) { |
| 45 | if (strcmp(log_file_name, kLogToConsole) == 0) { |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 46 | OpenStdout(); |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 47 | } else if (strcmp(log_file_name, kLogToTemporaryFile) == 0) { |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 48 | OpenTemporaryFile(); |
| 49 | } else { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 50 | OpenFile(log_file_name); |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 51 | } |
| 52 | } |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 53 | } |
| 54 | |
| 55 | |
| 56 | void Log::OpenStdout() { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 57 | DCHECK(!IsEnabled()); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 58 | output_handle_ = stdout; |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 59 | } |
| 60 | |
| 61 | |
| 62 | void Log::OpenTemporaryFile() { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 63 | DCHECK(!IsEnabled()); |
| 64 | output_handle_ = base::OS::OpenTemporaryFile(); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 65 | } |
| 66 | |
| 67 | |
| 68 | void Log::OpenFile(const char* name) { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 69 | DCHECK(!IsEnabled()); |
| 70 | output_handle_ = base::OS::FOpen(name, base::OS::LogFileOpenMode); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 71 | } |
| 72 | |
| 73 | |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 74 | FILE* Log::Close() { |
| 75 | FILE* result = NULL; |
| 76 | if (output_handle_ != NULL) { |
| 77 | if (strcmp(FLAG_logfile, kLogToTemporaryFile) != 0) { |
| 78 | fclose(output_handle_); |
| 79 | } else { |
| 80 | result = output_handle_; |
| 81 | } |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 82 | } |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 83 | output_handle_ = NULL; |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 84 | |
| 85 | DeleteArray(message_buffer_); |
| 86 | message_buffer_ = NULL; |
| 87 | |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 88 | is_stopped_ = false; |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 89 | return result; |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 90 | } |
| 91 | |
| 92 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 93 | Log::MessageBuilder::MessageBuilder(Log* log) |
| 94 | : log_(log), |
| 95 | lock_guard_(&log_->mutex_), |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 96 | pos_(0) { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 97 | DCHECK(log_->message_buffer_ != NULL); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 98 | } |
| 99 | |
| 100 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 101 | void Log::MessageBuilder::Append(const char* format, ...) { |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 102 | Vector<char> buf(log_->message_buffer_ + pos_, |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 103 | Log::kMessageBufferSize - pos_); |
| 104 | va_list args; |
| 105 | va_start(args, format); |
| 106 | AppendVA(format, args); |
| 107 | va_end(args); |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 108 | DCHECK(pos_ <= Log::kMessageBufferSize); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 109 | } |
| 110 | |
| 111 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 112 | void Log::MessageBuilder::AppendVA(const char* format, va_list args) { |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 113 | Vector<char> buf(log_->message_buffer_ + pos_, |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 114 | Log::kMessageBufferSize - pos_); |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 115 | int result = v8::internal::VSNPrintF(buf, format, args); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 116 | |
| 117 | // Result is -1 if output was truncated. |
| 118 | if (result >= 0) { |
| 119 | pos_ += result; |
| 120 | } else { |
| 121 | pos_ = Log::kMessageBufferSize; |
| 122 | } |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 123 | DCHECK(pos_ <= Log::kMessageBufferSize); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 124 | } |
| 125 | |
| 126 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 127 | void Log::MessageBuilder::Append(const char c) { |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 128 | if (pos_ < Log::kMessageBufferSize) { |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 129 | log_->message_buffer_[pos_++] = c; |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 130 | } |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 131 | DCHECK(pos_ <= Log::kMessageBufferSize); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 132 | } |
| 133 | |
| 134 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 135 | void Log::MessageBuilder::AppendDoubleQuotedString(const char* string) { |
| 136 | Append('"'); |
| 137 | for (const char* p = string; *p != '\0'; p++) { |
| 138 | if (*p == '"') { |
| 139 | Append('\\'); |
| 140 | } |
| 141 | Append(*p); |
| 142 | } |
| 143 | Append('"'); |
| 144 | } |
| 145 | |
| 146 | |
| 147 | void Log::MessageBuilder::Append(String* str) { |
| 148 | DisallowHeapAllocation no_gc; // Ensure string stay valid. |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 149 | int length = str->length(); |
| 150 | for (int i = 0; i < length; i++) { |
| 151 | Append(static_cast<char>(str->Get(i))); |
| 152 | } |
| 153 | } |
| 154 | |
| 155 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 156 | void Log::MessageBuilder::AppendAddress(Address addr) { |
Ben Murdoch | b0fe162 | 2011-05-05 13:52:32 +0100 | [diff] [blame] | 157 | Append("0x%" V8PRIxPTR, addr); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 158 | } |
| 159 | |
| 160 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 161 | void Log::MessageBuilder::AppendSymbolName(Symbol* symbol) { |
| 162 | DCHECK(symbol); |
| 163 | Append("symbol("); |
| 164 | if (!symbol->name()->IsUndefined()) { |
| 165 | Append("\""); |
| 166 | AppendDetailed(String::cast(symbol->name()), false); |
| 167 | Append("\" "); |
| 168 | } |
| 169 | Append("hash %x)", symbol->Hash()); |
| 170 | } |
| 171 | |
| 172 | |
| 173 | void Log::MessageBuilder::AppendDetailed(String* str, bool show_impl_info) { |
Ben Murdoch | 257744e | 2011-11-30 15:57:28 +0000 | [diff] [blame] | 174 | if (str == NULL) return; |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 175 | DisallowHeapAllocation no_gc; // Ensure string stay valid. |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 176 | int len = str->length(); |
| 177 | if (len > 0x1000) |
| 178 | len = 0x1000; |
| 179 | if (show_impl_info) { |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 180 | Append(str->IsOneByteRepresentation() ? 'a' : '2'); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 181 | if (StringShape(str).IsExternal()) |
| 182 | Append('e'); |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 183 | if (StringShape(str).IsInternalized()) |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 184 | Append('#'); |
| 185 | Append(":%i:", str->length()); |
| 186 | } |
| 187 | for (int i = 0; i < len; i++) { |
| 188 | uc32 c = str->Get(i); |
| 189 | if (c > 0xff) { |
| 190 | Append("\\u%04x", c); |
| 191 | } else if (c < 32 || c > 126) { |
| 192 | Append("\\x%02x", c); |
| 193 | } else if (c == ',') { |
| 194 | Append("\\,"); |
| 195 | } else if (c == '\\') { |
| 196 | Append("\\\\"); |
Ben Murdoch | e0cee9b | 2011-05-25 10:26:03 +0100 | [diff] [blame] | 197 | } else if (c == '\"') { |
| 198 | Append("\"\""); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 199 | } else { |
| 200 | Append("%lc", c); |
| 201 | } |
| 202 | } |
| 203 | } |
| 204 | |
| 205 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 206 | void Log::MessageBuilder::AppendStringPart(const char* str, int len) { |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 207 | if (pos_ + len > Log::kMessageBufferSize) { |
| 208 | len = Log::kMessageBufferSize - pos_; |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 209 | DCHECK(len >= 0); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 210 | if (len == 0) return; |
| 211 | } |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 212 | Vector<char> buf(log_->message_buffer_ + pos_, |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 213 | Log::kMessageBufferSize - pos_); |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 214 | StrNCpy(buf, str, len); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 215 | pos_ += len; |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 216 | DCHECK(pos_ <= Log::kMessageBufferSize); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 217 | } |
| 218 | |
| 219 | |
Ben Murdoch | b8a8cc1 | 2014-11-26 15:28:44 +0000 | [diff] [blame^] | 220 | void Log::MessageBuilder::WriteToLogFile() { |
| 221 | DCHECK(pos_ <= Log::kMessageBufferSize); |
| 222 | // Assert that we do not already have a new line at the end. |
| 223 | DCHECK(pos_ == 0 || log_->message_buffer_[pos_ - 1] != '\n'); |
| 224 | if (pos_ == Log::kMessageBufferSize) pos_--; |
| 225 | log_->message_buffer_[pos_++] = '\n'; |
Ben Murdoch | 3fb3ca8 | 2011-12-02 17:19:32 +0000 | [diff] [blame] | 226 | const int written = log_->WriteToFile(log_->message_buffer_, pos_); |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 227 | if (written != pos_) { |
| 228 | log_->stop(); |
| 229 | log_->logger_->LogFailure(); |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 230 | } |
| 231 | } |
| 232 | |
Steve Block | 44f0eee | 2011-05-26 01:26:41 +0100 | [diff] [blame] | 233 | |
Steve Block | a7e24c1 | 2009-10-30 11:49:00 +0000 | [diff] [blame] | 234 | } } // namespace v8::internal |