Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 1 | /* |
| 2 | * Copyright (C) 2015 The Android Open Source Project |
| 3 | * |
| 4 | * Licensed under the Apache License, Version 2.0 (the "License"); |
| 5 | * you may not use this file except in compliance with the License. |
| 6 | * You may obtain a copy of the License at |
| 7 | * |
| 8 | * http://www.apache.org/licenses/LICENSE-2.0 |
| 9 | * |
| 10 | * Unless required by applicable law or agreed to in writing, software |
| 11 | * distributed under the License is distributed on an "AS IS" BASIS, |
| 12 | * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. |
| 13 | * See the License for the specific language governing permissions and |
| 14 | * limitations under the License. |
| 15 | */ |
| 16 | |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 17 | #if defined(_WIN32) |
Spencer Low | 4759052 | 2015-05-19 22:12:06 -0700 | [diff] [blame] | 18 | #include <windows.h> |
| 19 | #endif |
| 20 | |
Elliott Hughes | b635162 | 2015-12-04 22:00:26 -0800 | [diff] [blame] | 21 | #include "android-base/logging.h" |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 22 | |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 23 | #include <fcntl.h> |
Josh Gao | ef102be | 2018-03-16 14:25:42 -0700 | [diff] [blame] | 24 | #include <inttypes.h> |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 25 | #include <libgen.h> |
Elliott Hughes | 6522eb5 | 2016-06-21 14:25:44 -0700 | [diff] [blame] | 26 | #include <time.h> |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 27 | |
| 28 | // For getprogname(3) or program_invocation_short_name. |
| 29 | #if defined(__ANDROID__) || defined(__APPLE__) |
| 30 | #include <stdlib.h> |
| 31 | #elif defined(__GLIBC__) |
| 32 | #include <errno.h> |
| 33 | #endif |
| 34 | |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 35 | #include <atomic> |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 36 | #include <iostream> |
| 37 | #include <limits> |
Josh Gao | b08de45 | 2016-09-13 14:57:12 -0700 | [diff] [blame] | 38 | #include <mutex> |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 39 | #include <optional> |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 40 | #include <sstream> |
| 41 | #include <string> |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 42 | #include <utility> |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 43 | #include <vector> |
| 44 | |
Andreas Gampe | ed91707 | 2018-02-15 11:40:30 -0800 | [diff] [blame] | 45 | #include <android/log.h> |
Tom Cherry | 17e8580 | 2020-01-08 13:41:56 -0800 | [diff] [blame] | 46 | #ifdef __ANDROID__ |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 47 | #include <android/set_abort_message.h> |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 48 | #else |
| 49 | #include <sys/types.h> |
| 50 | #include <unistd.h> |
| 51 | #endif |
| 52 | |
Elliott Hughes | 397961e | 2018-10-19 13:59:44 -0700 | [diff] [blame] | 53 | #include <android-base/file.h> |
Mark Salyzyn | 5cbb251 | 2016-09-28 15:54:45 -0700 | [diff] [blame] | 54 | #include <android-base/macros.h> |
Mark Salyzyn | 504d8ed | 2018-04-06 09:40:26 -0700 | [diff] [blame] | 55 | #include <android-base/parseint.h> |
Mark Salyzyn | 5cbb251 | 2016-09-28 15:54:45 -0700 | [diff] [blame] | 56 | #include <android-base/strings.h> |
Josh Gao | ef102be | 2018-03-16 14:25:42 -0700 | [diff] [blame] | 57 | #include <android-base/threads.h> |
Elliott Hughes | 774d7f6 | 2015-11-11 18:02:29 +0000 | [diff] [blame] | 58 | |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 59 | #include "logging_splitters.h" |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 60 | |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 61 | namespace android { |
| 62 | namespace base { |
| 63 | |
| 64 | // BSD-based systems like Android/macOS have getprogname(). Others need us to provide one. |
Colin Cross | 18c2bd4 | 2021-07-14 15:07:58 -0700 | [diff] [blame] | 65 | #if !defined(__APPLE__) && !defined(__BIONIC__) |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 66 | static const char* getprogname() { |
Colin Cross | 18c2bd4 | 2021-07-14 15:07:58 -0700 | [diff] [blame] | 67 | #ifdef _WIN32 |
Dan Albert | dc15ffd | 2015-04-29 11:32:23 -0700 | [diff] [blame] | 68 | static bool first = true; |
| 69 | static char progname[MAX_PATH] = {}; |
| 70 | |
| 71 | if (first) { |
Elliott Hughes | 397961e | 2018-10-19 13:59:44 -0700 | [diff] [blame] | 72 | snprintf(progname, sizeof(progname), "%s", |
| 73 | android::base::Basename(android::base::GetExecutablePath()).c_str()); |
Dan Albert | dc15ffd | 2015-04-29 11:32:23 -0700 | [diff] [blame] | 74 | first = false; |
| 75 | } |
| 76 | |
| 77 | return progname; |
Colin Cross | 18c2bd4 | 2021-07-14 15:07:58 -0700 | [diff] [blame] | 78 | #else |
| 79 | return program_invocation_short_name; |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 80 | #endif |
Dan Albert | dc15ffd | 2015-04-29 11:32:23 -0700 | [diff] [blame] | 81 | } |
Dan Albert | dc15ffd | 2015-04-29 11:32:23 -0700 | [diff] [blame] | 82 | #endif |
Mark Salyzyn | 504d8ed | 2018-04-06 09:40:26 -0700 | [diff] [blame] | 83 | |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 84 | static const char* GetFileBasename(const char* file) { |
| 85 | // We can't use basename(3) even on Unix because the Mac doesn't |
| 86 | // have a non-modifying basename. |
| 87 | const char* last_slash = strrchr(file, '/'); |
| 88 | if (last_slash != nullptr) { |
| 89 | return last_slash + 1; |
| 90 | } |
| 91 | #if defined(_WIN32) |
| 92 | const char* last_backslash = strrchr(file, '\\'); |
| 93 | if (last_backslash != nullptr) { |
| 94 | return last_backslash + 1; |
| 95 | } |
| 96 | #endif |
| 97 | return file; |
| 98 | } |
| 99 | |
Mark Salyzyn | 504d8ed | 2018-04-06 09:40:26 -0700 | [diff] [blame] | 100 | #if defined(__linux__) |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 101 | static int OpenKmsg() { |
Mark Salyzyn | 504d8ed | 2018-04-06 09:40:26 -0700 | [diff] [blame] | 102 | #if defined(__ANDROID__) |
| 103 | // pick up 'file w /dev/kmsg' environment from daemon's init rc file |
| 104 | const auto val = getenv("ANDROID_FILE__dev_kmsg"); |
| 105 | if (val != nullptr) { |
| 106 | int fd; |
| 107 | if (android::base::ParseInt(val, &fd, 0)) { |
| 108 | auto flags = fcntl(fd, F_GETFL); |
| 109 | if ((flags != -1) && ((flags & O_ACCMODE) == O_WRONLY)) return fd; |
| 110 | } |
| 111 | } |
| 112 | #endif |
| 113 | return TEMP_FAILURE_RETRY(open("/dev/kmsg", O_WRONLY | O_CLOEXEC)); |
| 114 | } |
| 115 | #endif |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 116 | |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 117 | static LogId log_id_tToLogId(int32_t buffer_id) { |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 118 | switch (buffer_id) { |
| 119 | case LOG_ID_MAIN: |
| 120 | return MAIN; |
| 121 | case LOG_ID_SYSTEM: |
| 122 | return SYSTEM; |
| 123 | case LOG_ID_RADIO: |
| 124 | return RADIO; |
| 125 | case LOG_ID_CRASH: |
| 126 | return CRASH; |
| 127 | case LOG_ID_DEFAULT: |
| 128 | default: |
| 129 | return DEFAULT; |
| 130 | } |
| 131 | } |
| 132 | |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 133 | static int32_t LogIdTolog_id_t(LogId log_id) { |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 134 | switch (log_id) { |
| 135 | case MAIN: |
| 136 | return LOG_ID_MAIN; |
| 137 | case SYSTEM: |
| 138 | return LOG_ID_SYSTEM; |
| 139 | case RADIO: |
| 140 | return LOG_ID_RADIO; |
| 141 | case CRASH: |
| 142 | return LOG_ID_CRASH; |
| 143 | case DEFAULT: |
| 144 | default: |
| 145 | return LOG_ID_DEFAULT; |
| 146 | } |
| 147 | } |
| 148 | |
| 149 | static LogSeverity PriorityToLogSeverity(int priority) { |
| 150 | switch (priority) { |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 151 | case ANDROID_LOG_DEFAULT: |
| 152 | return INFO; |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 153 | case ANDROID_LOG_VERBOSE: |
| 154 | return VERBOSE; |
| 155 | case ANDROID_LOG_DEBUG: |
| 156 | return DEBUG; |
| 157 | case ANDROID_LOG_INFO: |
| 158 | return INFO; |
| 159 | case ANDROID_LOG_WARN: |
| 160 | return WARNING; |
| 161 | case ANDROID_LOG_ERROR: |
| 162 | return ERROR; |
| 163 | case ANDROID_LOG_FATAL: |
| 164 | return FATAL; |
| 165 | default: |
| 166 | return FATAL; |
| 167 | } |
| 168 | } |
| 169 | |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 170 | static int32_t LogSeverityToPriority(LogSeverity severity) { |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 171 | switch (severity) { |
| 172 | case VERBOSE: |
| 173 | return ANDROID_LOG_VERBOSE; |
| 174 | case DEBUG: |
| 175 | return ANDROID_LOG_DEBUG; |
| 176 | case INFO: |
| 177 | return ANDROID_LOG_INFO; |
| 178 | case WARNING: |
| 179 | return ANDROID_LOG_WARN; |
| 180 | case ERROR: |
| 181 | return ANDROID_LOG_ERROR; |
| 182 | case FATAL_WITHOUT_ABORT: |
| 183 | case FATAL: |
| 184 | default: |
| 185 | return ANDROID_LOG_FATAL; |
| 186 | } |
| 187 | } |
| 188 | |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 189 | static LogFunction& Logger() { |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 190 | #ifdef __ANDROID__ |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 191 | static auto& logger = *new LogFunction(LogdLogger()); |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 192 | #else |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 193 | static auto& logger = *new LogFunction(StderrLogger); |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 194 | #endif |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 195 | return logger; |
| 196 | } |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 197 | |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 198 | static AbortFunction& Aborter() { |
| 199 | static auto& aborter = *new AbortFunction(DefaultAborter); |
| 200 | return aborter; |
| 201 | } |
| 202 | |
Tom Cherry | dbc07ce | 2020-01-22 07:48:42 -0800 | [diff] [blame] | 203 | // Only used for Q fallback. |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 204 | static std::recursive_mutex& TagLock() { |
| 205 | static auto& tag_lock = *new std::recursive_mutex(); |
| 206 | return tag_lock; |
| 207 | } |
Tom Cherry | dbc07ce | 2020-01-22 07:48:42 -0800 | [diff] [blame] | 208 | // Only used for Q fallback. |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 209 | static std::string* gDefaultTag; |
Tom Cherry | dbc07ce | 2020-01-22 07:48:42 -0800 | [diff] [blame] | 210 | |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 211 | void SetDefaultTag(const std::string& tag) { |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 212 | if (__builtin_available(android 30, *)) { |
| 213 | __android_log_set_default_tag(tag.c_str()); |
Tom Cherry | dbc07ce | 2020-01-22 07:48:42 -0800 | [diff] [blame] | 214 | } else { |
| 215 | std::lock_guard<std::recursive_mutex> lock(TagLock()); |
| 216 | if (gDefaultTag != nullptr) { |
| 217 | delete gDefaultTag; |
| 218 | gDefaultTag = nullptr; |
| 219 | } |
| 220 | if (!tag.empty()) { |
| 221 | gDefaultTag = new std::string(tag); |
| 222 | } |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 223 | } |
Yabin Cui | 7ff958a | 2017-01-23 10:29:23 -0800 | [diff] [blame] | 224 | } |
Andreas Gampe | 9008e8d | 2016-09-08 11:03:58 -0700 | [diff] [blame] | 225 | |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 226 | static bool gInitialized = false; |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 227 | |
| 228 | // Only used for Q fallback. |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 229 | static LogSeverity gMinimumLogSeverity = INFO; |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 230 | |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 231 | #if defined(__linux__) |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 232 | static void KernelLogLine(const char* msg, int length, android::base::LogSeverity severity, |
| 233 | const char* tag) { |
Andreas Gampe | d2a4f21 | 2016-09-07 10:10:50 -0700 | [diff] [blame] | 234 | // clang-format off |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 235 | static constexpr int kLogSeverityToKernelLogLevel[] = { |
Andreas Gampe | d2a4f21 | 2016-09-07 10:10:50 -0700 | [diff] [blame] | 236 | [android::base::VERBOSE] = 7, // KERN_DEBUG (there is no verbose kernel log |
| 237 | // level) |
| 238 | [android::base::DEBUG] = 7, // KERN_DEBUG |
| 239 | [android::base::INFO] = 6, // KERN_INFO |
| 240 | [android::base::WARNING] = 4, // KERN_WARNING |
| 241 | [android::base::ERROR] = 3, // KERN_ERROR |
| 242 | [android::base::FATAL_WITHOUT_ABORT] = 2, // KERN_CRIT |
| 243 | [android::base::FATAL] = 2, // KERN_CRIT |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 244 | }; |
Andreas Gampe | d2a4f21 | 2016-09-07 10:10:50 -0700 | [diff] [blame] | 245 | // clang-format on |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 246 | static_assert(arraysize(kLogSeverityToKernelLogLevel) == android::base::FATAL + 1, |
| 247 | "Mismatch in size of kLogSeverityToKernelLogLevel and values in LogSeverity"); |
| 248 | |
Mark Salyzyn | 504d8ed | 2018-04-06 09:40:26 -0700 | [diff] [blame] | 249 | static int klog_fd = OpenKmsg(); |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 250 | if (klog_fd == -1) return; |
| 251 | |
| 252 | int level = kLogSeverityToKernelLogLevel[severity]; |
| 253 | |
Yi-Yo Chiang | 02cdbf2 | 2021-03-17 16:34:35 +0800 | [diff] [blame] | 254 | // The kernel's printk buffer is only |1024 - PREFIX_MAX| bytes, where |
| 255 | // PREFIX_MAX could be 48 or 32. |
| 256 | // Reference: kernel/printk/printk.c |
Yi-Yo Chiang | 02cdbf2 | 2021-03-17 16:34:35 +0800 | [diff] [blame] | 257 | static constexpr int LOG_LINE_MAX = 1024 - 48; |
| 258 | char buf[LOG_LINE_MAX] __attribute__((__uninitialized__)); |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 259 | size_t size = snprintf(buf, sizeof(buf), "<%d>%s: %.*s\n", level, tag, length, msg); |
Yi-Yo Chiang | 1b96cbd | 2021-03-18 01:23:58 +0800 | [diff] [blame] | 260 | TEMP_FAILURE_RETRY(write(klog_fd, buf, std::min(size, sizeof(buf)))); |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 261 | |
Yi-Yo Chiang | 1b96cbd | 2021-03-18 01:23:58 +0800 | [diff] [blame] | 262 | if (size > sizeof(buf)) { |
| 263 | size_t truncated = size - sizeof(buf); |
| 264 | size = snprintf( |
| 265 | buf, sizeof(buf), |
| 266 | "<%d>%s: **previous message missing %zu bytes** %zu-byte message too long for printk\n", |
| 267 | level, tag, truncated, size); |
| 268 | TEMP_FAILURE_RETRY(write(klog_fd, buf, std::min(size, sizeof(buf)))); |
| 269 | } |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 270 | } |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 271 | |
| 272 | void KernelLogger(android::base::LogId, android::base::LogSeverity severity, const char* tag, |
| 273 | const char*, unsigned int, const char* full_message) { |
| 274 | SplitByLines(full_message, KernelLogLine, severity, tag); |
| 275 | } |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 276 | #endif |
| 277 | |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 278 | void StderrLogger(LogId, LogSeverity severity, const char* tag, const char* file, unsigned int line, |
| 279 | const char* message) { |
Elliott Hughes | 6522eb5 | 2016-06-21 14:25:44 -0700 | [diff] [blame] | 280 | struct tm now; |
| 281 | time_t t = time(nullptr); |
| 282 | |
| 283 | #if defined(_WIN32) |
| 284 | localtime_s(&now, &t); |
| 285 | #else |
| 286 | localtime_r(&t, &now); |
| 287 | #endif |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 288 | auto output_string = |
| 289 | StderrOutputGenerator(now, getpid(), GetThreadId(), severity, tag, file, line, message); |
Elliott Hughes | 6522eb5 | 2016-06-21 14:25:44 -0700 | [diff] [blame] | 290 | |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 291 | fputs(output_string.c_str(), stderr); |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 292 | } |
| 293 | |
Elliott Hughes | 1c1409f | 2018-05-23 09:16:46 -0700 | [diff] [blame] | 294 | void StdioLogger(LogId, LogSeverity severity, const char* /*tag*/, const char* /*file*/, |
| 295 | unsigned int /*line*/, const char* message) { |
| 296 | if (severity >= WARNING) { |
| 297 | fflush(stdout); |
Elliott Hughes | 462a45e | 2018-06-06 12:54:41 -0700 | [diff] [blame] | 298 | fprintf(stderr, "%s: %s\n", GetFileBasename(getprogname()), message); |
Elliott Hughes | 1c1409f | 2018-05-23 09:16:46 -0700 | [diff] [blame] | 299 | } else { |
| 300 | fprintf(stdout, "%s\n", message); |
| 301 | } |
| 302 | } |
| 303 | |
Andreas Gampe | 9008e8d | 2016-09-08 11:03:58 -0700 | [diff] [blame] | 304 | void DefaultAborter(const char* abort_message) { |
| 305 | #ifdef __ANDROID__ |
| 306 | android_set_abort_message(abort_message); |
| 307 | #else |
| 308 | UNUSED(abort_message); |
| 309 | #endif |
| 310 | abort(); |
| 311 | } |
| 312 | |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 313 | static void LogdLogChunk(LogId id, LogSeverity severity, const char* tag, const char* message) { |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 314 | int32_t lg_id = LogIdTolog_id_t(id); |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 315 | int32_t priority = LogSeverityToPriority(severity); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 316 | |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 317 | if (__builtin_available(android 30, *)) { |
Tom Cherry | 228eff1 | 2020-03-11 11:07:13 -0700 | [diff] [blame] | 318 | __android_log_message log_message = {sizeof(__android_log_message), lg_id, priority, tag, |
| 319 | static_cast<const char*>(nullptr), 0, message}; |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 320 | __android_log_logd_logger(&log_message); |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 321 | } else { |
| 322 | __android_log_buf_print(lg_id, priority, tag, "%s", message); |
| 323 | } |
| 324 | } |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 325 | |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 326 | LogdLogger::LogdLogger(LogId default_log_id) : default_log_id_(default_log_id) {} |
| 327 | |
| 328 | void LogdLogger::operator()(LogId id, LogSeverity severity, const char* tag, const char* file, |
| 329 | unsigned int line, const char* message) { |
| 330 | if (id == DEFAULT) { |
| 331 | id = default_log_id_; |
| 332 | } |
| 333 | |
| 334 | SplitByLogdChunks(id, severity, tag, file, line, message, LogdLogChunk); |
| 335 | } |
| 336 | |
Andreas Gampe | 9008e8d | 2016-09-08 11:03:58 -0700 | [diff] [blame] | 337 | void InitLogging(char* argv[], LogFunction&& logger, AbortFunction&& aborter) { |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 338 | SetLogger(std::forward<LogFunction>(logger)); |
Andreas Gampe | 9008e8d | 2016-09-08 11:03:58 -0700 | [diff] [blame] | 339 | SetAborter(std::forward<AbortFunction>(aborter)); |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 340 | |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 341 | if (gInitialized) { |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 342 | return; |
| 343 | } |
| 344 | |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 345 | gInitialized = true; |
| 346 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 347 | // Stash the command line for later use. We can use /proc/self/cmdline on |
Spencer Low | bec7862 | 2015-11-07 18:51:54 -0800 | [diff] [blame] | 348 | // Linux to recover this, but we don't have that luxury on the Mac/Windows, |
| 349 | // and there are a couple of argv[0] variants that are commonly used. |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 350 | if (argv != nullptr) { |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 351 | SetDefaultTag(basename(argv[0])); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 352 | } |
Dan Albert | 1be4dec | 2015-04-03 11:28:46 -0700 | [diff] [blame] | 353 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 354 | const char* tags = getenv("ANDROID_LOG_TAGS"); |
| 355 | if (tags == nullptr) { |
| 356 | return; |
| 357 | } |
| 358 | |
Dan Albert | 0d716d0 | 2015-03-19 13:24:26 -0700 | [diff] [blame] | 359 | std::vector<std::string> specs = Split(tags, " "); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 360 | for (size_t i = 0; i < specs.size(); ++i) { |
| 361 | // "tag-pattern:[vdiwefs]" |
| 362 | std::string spec(specs[i]); |
| 363 | if (spec.size() == 3 && StartsWith(spec, "*:")) { |
| 364 | switch (spec[2]) { |
| 365 | case 'v': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 366 | SetMinimumLogSeverity(VERBOSE); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 367 | continue; |
| 368 | case 'd': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 369 | SetMinimumLogSeverity(DEBUG); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 370 | continue; |
| 371 | case 'i': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 372 | SetMinimumLogSeverity(INFO); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 373 | continue; |
| 374 | case 'w': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 375 | SetMinimumLogSeverity(WARNING); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 376 | continue; |
| 377 | case 'e': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 378 | SetMinimumLogSeverity(ERROR); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 379 | continue; |
| 380 | case 'f': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 381 | SetMinimumLogSeverity(FATAL_WITHOUT_ABORT); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 382 | continue; |
Luke Huang | 317728b | 2020-07-30 03:04:39 +0800 | [diff] [blame] | 383 | // liblog will even suppress FATAL if you say 's' for silent, but fatal should |
| 384 | // never be suppressed. |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 385 | case 's': |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 386 | SetMinimumLogSeverity(FATAL_WITHOUT_ABORT); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 387 | continue; |
| 388 | } |
| 389 | } |
| 390 | LOG(FATAL) << "unsupported '" << spec << "' in ANDROID_LOG_TAGS (" << tags |
| 391 | << ")"; |
| 392 | } |
| 393 | } |
| 394 | |
Krzysztof Kosiński | ccbd5db | 2020-08-04 17:41:44 -0700 | [diff] [blame] | 395 | LogFunction SetLogger(LogFunction&& logger) { |
| 396 | LogFunction old_logger = std::move(Logger()); |
Tom Cherry | 8a06da8 | 2020-04-22 11:37:26 -0700 | [diff] [blame] | 397 | Logger() = std::move(logger); |
| 398 | |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 399 | if (__builtin_available(android 30, *)) { |
| 400 | __android_log_set_logger([](const struct __android_log_message* log_message) { |
Tom Cherry | 228eff1 | 2020-03-11 11:07:13 -0700 | [diff] [blame] | 401 | auto log_id = log_id_tToLogId(log_message->buffer_id); |
| 402 | auto severity = PriorityToLogSeverity(log_message->priority); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 403 | |
Tom Cherry | 8a06da8 | 2020-04-22 11:37:26 -0700 | [diff] [blame] | 404 | Logger()(log_id, severity, log_message->tag, log_message->file, log_message->line, |
Tom Cherry | 228eff1 | 2020-03-11 11:07:13 -0700 | [diff] [blame] | 405 | log_message->message); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 406 | }); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 407 | } |
Krzysztof Kosiński | ccbd5db | 2020-08-04 17:41:44 -0700 | [diff] [blame] | 408 | return old_logger; |
Dan Albert | 1f65c49 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 409 | } |
| 410 | |
Krzysztof Kosiński | ccbd5db | 2020-08-04 17:41:44 -0700 | [diff] [blame] | 411 | AbortFunction SetAborter(AbortFunction&& aborter) { |
| 412 | AbortFunction old_aborter = std::move(Aborter()); |
Tom Cherry | 8a06da8 | 2020-04-22 11:37:26 -0700 | [diff] [blame] | 413 | Aborter() = std::move(aborter); |
| 414 | |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 415 | if (__builtin_available(android 30, *)) { |
| 416 | __android_log_set_aborter([](const char* abort_message) { Aborter()(abort_message); }); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 417 | } |
Krzysztof Kosiński | ccbd5db | 2020-08-04 17:41:44 -0700 | [diff] [blame] | 418 | return old_aborter; |
Andreas Gampe | 9008e8d | 2016-09-08 11:03:58 -0700 | [diff] [blame] | 419 | } |
| 420 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 421 | // This indirection greatly reduces the stack impact of having lots of |
| 422 | // checks/logging in a function. |
| 423 | class LogMessageData { |
| 424 | public: |
Tom Cherry | 46a2e0e | 2020-01-10 17:18:55 -0800 | [diff] [blame] | 425 | LogMessageData(const char* file, unsigned int line, LogSeverity severity, const char* tag, |
| 426 | int error) |
Spencer Low | 55853a9 | 2015-08-11 16:00:13 -0700 | [diff] [blame] | 427 | : file_(GetFileBasename(file)), |
Dan Albert | ab5c882 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 428 | line_number_(line), |
Dan Albert | ab5c882 | 2015-03-27 11:20:14 -0700 | [diff] [blame] | 429 | severity_(severity), |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 430 | tag_(tag), |
| 431 | error_(error) {} |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 432 | |
| 433 | const char* GetFile() const { |
| 434 | return file_; |
| 435 | } |
| 436 | |
| 437 | unsigned int GetLineNumber() const { |
| 438 | return line_number_; |
| 439 | } |
| 440 | |
| 441 | LogSeverity GetSeverity() const { |
| 442 | return severity_; |
| 443 | } |
| 444 | |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 445 | const char* GetTag() const { return tag_; } |
| 446 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 447 | int GetError() const { |
| 448 | return error_; |
| 449 | } |
| 450 | |
| 451 | std::ostream& GetBuffer() { |
| 452 | return buffer_; |
| 453 | } |
| 454 | |
| 455 | std::string ToString() const { |
| 456 | return buffer_.str(); |
| 457 | } |
| 458 | |
| 459 | private: |
| 460 | std::ostringstream buffer_; |
| 461 | const char* const file_; |
| 462 | const unsigned int line_number_; |
| 463 | const LogSeverity severity_; |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 464 | const char* const tag_; |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 465 | const int error_; |
| 466 | |
| 467 | DISALLOW_COPY_AND_ASSIGN(LogMessageData); |
| 468 | }; |
| 469 | |
Tom Cherry | 46a2e0e | 2020-01-10 17:18:55 -0800 | [diff] [blame] | 470 | LogMessage::LogMessage(const char* file, unsigned int line, LogId, LogSeverity severity, |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 471 | const char* tag, int error) |
Tom Cherry | 46a2e0e | 2020-01-10 17:18:55 -0800 | [diff] [blame] | 472 | : LogMessage(file, line, severity, tag, error) {} |
| 473 | |
| 474 | LogMessage::LogMessage(const char* file, unsigned int line, LogSeverity severity, const char* tag, |
| 475 | int error) |
| 476 | : data_(new LogMessageData(file, line, severity, tag, error)) {} |
Tomasz Wasilczyk | a419de2 | 2017-12-18 06:30:17 -0800 | [diff] [blame] | 477 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 478 | LogMessage::~LogMessage() { |
Andreas Gampe | c65ea94 | 2016-09-23 13:31:52 -0700 | [diff] [blame] | 479 | // Check severity again. This is duplicate work wrt/ LOG macros, but not LOG_STREAM. |
Andreas Gampe | cb35a4a | 2016-09-23 16:37:12 -0700 | [diff] [blame] | 480 | if (!WOULD_LOG(data_->GetSeverity())) { |
Andreas Gampe | c65ea94 | 2016-09-23 13:31:52 -0700 | [diff] [blame] | 481 | return; |
| 482 | } |
| 483 | |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 484 | // Finish constructing the message. |
| 485 | if (data_->GetError() != -1) { |
| 486 | data_->GetBuffer() << ": " << strerror(data_->GetError()); |
| 487 | } |
| 488 | std::string msg(data_->ToString()); |
| 489 | |
Andreas Gampe | 2f9e49f | 2018-12-05 11:26:14 -0800 | [diff] [blame] | 490 | if (data_->GetSeverity() == FATAL) { |
| 491 | #ifdef __ANDROID__ |
| 492 | // Set the bionic abort message early to avoid liblog doing it |
| 493 | // with the individual lines, so that we get the whole message. |
| 494 | android_set_abort_message(msg.c_str()); |
| 495 | #endif |
| 496 | } |
| 497 | |
Tom Cherry | a687242 | 2020-04-17 13:05:11 -0700 | [diff] [blame] | 498 | LogLine(data_->GetFile(), data_->GetLineNumber(), data_->GetSeverity(), data_->GetTag(), |
| 499 | msg.c_str()); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 500 | |
| 501 | // Abort if necessary. |
| 502 | if (data_->GetSeverity() == FATAL) { |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 503 | if (__builtin_available(android 30, *)) { |
| 504 | __android_log_call_aborter(msg.c_str()); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 505 | } else { |
| 506 | Aborter()(msg.c_str()); |
| 507 | } |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 508 | } |
| 509 | } |
| 510 | |
| 511 | std::ostream& LogMessage::stream() { |
| 512 | return data_->GetBuffer(); |
| 513 | } |
| 514 | |
Tom Cherry | 46a2e0e | 2020-01-10 17:18:55 -0800 | [diff] [blame] | 515 | void LogMessage::LogLine(const char* file, unsigned int line, LogSeverity severity, const char* tag, |
| 516 | const char* message) { |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 517 | int32_t priority = LogSeverityToPriority(severity); |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 518 | if (__builtin_available(android 30, *)) { |
Tom Cherry | 228eff1 | 2020-03-11 11:07:13 -0700 | [diff] [blame] | 519 | __android_log_message log_message = { |
| 520 | sizeof(__android_log_message), LOG_ID_DEFAULT, priority, tag, file, line, message}; |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 521 | __android_log_write_log_message(&log_message); |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 522 | } else { |
Tom Cherry | dbc07ce | 2020-01-22 07:48:42 -0800 | [diff] [blame] | 523 | if (tag == nullptr) { |
| 524 | std::lock_guard<std::recursive_mutex> lock(TagLock()); |
| 525 | if (gDefaultTag == nullptr) { |
| 526 | gDefaultTag = new std::string(getprogname()); |
| 527 | } |
| 528 | |
| 529 | Logger()(DEFAULT, severity, gDefaultTag->c_str(), file, line, message); |
Tom Cherry | 1bfa8ab | 2020-01-08 14:47:42 -0800 | [diff] [blame] | 530 | } else { |
| 531 | Logger()(DEFAULT, severity, tag, file, line, message); |
| 532 | } |
Andreas Gampe | fec5b09 | 2018-03-05 10:00:19 -0800 | [diff] [blame] | 533 | } |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 534 | } |
| 535 | |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 536 | LogSeverity GetMinimumLogSeverity() { |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 537 | if (__builtin_available(android 30, *)) { |
| 538 | return PriorityToLogSeverity(__android_log_get_minimum_priority()); |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 539 | } else { |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 540 | return gMinimumLogSeverity; |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 541 | } |
| 542 | } |
| 543 | |
| 544 | bool ShouldLog(LogSeverity severity, const char* tag) { |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 545 | // Even though we're not using the R liblog functions in this function, if we're running on Q, |
| 546 | // we need to fall back to using gMinimumLogSeverity, since __android_log_is_loggable() will not |
| 547 | // take into consideration the value from SetMinimumLogSeverity(). |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 548 | if (__builtin_available(android 30, *)) { |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 549 | int32_t priority = LogSeverityToPriority(severity); |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 550 | return __android_log_is_loggable(priority, tag, ANDROID_LOG_INFO); |
| 551 | } else { |
| 552 | return severity >= gMinimumLogSeverity; |
| 553 | } |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 554 | } |
| 555 | |
| 556 | LogSeverity SetMinimumLogSeverity(LogSeverity new_severity) { |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 557 | if (__builtin_available(android 30, *)) { |
Tom Cherry | 784ba9a | 2020-03-12 11:07:07 -0700 | [diff] [blame] | 558 | int32_t priority = LogSeverityToPriority(new_severity); |
Jiyong Park | ecb6afe | 2020-08-10 21:27:51 +0900 | [diff] [blame] | 559 | return PriorityToLogSeverity(__android_log_set_minimum_priority(priority)); |
Tom Cherry | 4916e09 | 2020-01-16 15:58:02 -0800 | [diff] [blame] | 560 | } else { |
| 561 | LogSeverity old_severity = gMinimumLogSeverity; |
| 562 | gMinimumLogSeverity = new_severity; |
| 563 | return old_severity; |
| 564 | } |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 565 | } |
| 566 | |
| 567 | ScopedLogSeverity::ScopedLogSeverity(LogSeverity new_severity) { |
| 568 | old_ = SetMinimumLogSeverity(new_severity); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 569 | } |
| 570 | |
| 571 | ScopedLogSeverity::~ScopedLogSeverity() { |
Elliott Hughes | 8cf75f0 | 2016-08-04 16:09:39 -0700 | [diff] [blame] | 572 | SetMinimumLogSeverity(old_); |
Dan Albert | e3ea058 | 2015-03-13 23:06:01 -0700 | [diff] [blame] | 573 | } |
| 574 | |
| 575 | } // namespace base |
| 576 | } // namespace android |