Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 1 | /* |
| 2 | * Copyright (C) 2014 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 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 17 | #include "LogStatistics.h" |
| 18 | |
Mark Salyzyn | c4e4823 | 2017-05-04 13:54:46 -0700 | [diff] [blame] | 19 | #include <ctype.h> |
Mark Salyzyn | 9a03863 | 2014-04-07 07:05:40 -0700 | [diff] [blame] | 20 | #include <fcntl.h> |
Mark Salyzyn | 02dd2f4 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 21 | #include <inttypes.h> |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 22 | #include <pwd.h> |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 23 | #include <stdio.h> |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 24 | #include <string.h> |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 25 | #include <sys/types.h> |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 26 | #include <unistd.h> |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 27 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 28 | #include <list> |
| 29 | |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 30 | #include <android-base/logging.h> |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 31 | #include <private/android_logger.h> |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 32 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 33 | #include "LogBufferElement.h" |
| 34 | |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 35 | static const uint64_t hourSec = 60 * 60; |
| 36 | static const uint64_t monthSec = 31 * 24 * hourSec; |
| 37 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 38 | std::atomic<size_t> LogStatistics::SizesTotal; |
Mark Salyzyn | 3296291 | 2016-09-12 10:29:17 -0700 | [diff] [blame] | 39 | |
Tom Cherry | b0263af | 2020-06-03 15:38:32 -0700 | [diff] [blame] | 40 | static std::string TagNameKey(const LogStatisticsElement& element) { |
| 41 | if (IsBinary(element.log_id)) { |
| 42 | uint32_t tag = element.tag; |
| 43 | if (tag) { |
| 44 | const char* cp = android::tagToName(tag); |
| 45 | if (cp) { |
| 46 | return std::string(cp); |
| 47 | } |
| 48 | } |
| 49 | return android::base::StringPrintf("[%" PRIu32 "]", tag); |
| 50 | } |
| 51 | const char* msg = element.msg; |
| 52 | if (!msg) { |
| 53 | return "chatty"; |
| 54 | } |
| 55 | ++msg; |
| 56 | uint16_t len = element.msg_len; |
| 57 | len = (len <= 1) ? 0 : strnlen(msg, len - 1); |
| 58 | if (!len) { |
| 59 | return "<NULL>"; |
| 60 | } |
| 61 | return std::string(msg, len); |
| 62 | } |
| 63 | |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 64 | LogStatistics::LogStatistics(bool enable_statistics, bool track_total_size) |
| 65 | : enable(enable_statistics), track_total_size_(track_total_size) { |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 66 | log_time now(CLOCK_REALTIME); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 67 | log_id_for_each(id) { |
| 68 | mSizes[id] = 0; |
| 69 | mElements[id] = 0; |
Mark Salyzyn | 58b8be8 | 2015-09-30 07:40:09 -0700 | [diff] [blame] | 70 | mDroppedElements[id] = 0; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 71 | mSizesTotal[id] = 0; |
| 72 | mElementsTotal[id] = 0; |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 73 | mOldest[id] = now; |
| 74 | mNewest[id] = now; |
| 75 | mNewestDropped[id] = now; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 76 | } |
| 77 | } |
| 78 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 79 | namespace android { |
| 80 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 81 | size_t sizesTotal() { |
| 82 | return LogStatistics::sizesTotal(); |
| 83 | } |
Mark Salyzyn | 3296291 | 2016-09-12 10:29:17 -0700 | [diff] [blame] | 84 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 85 | // caller must own and free character string |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 86 | char* pidToName(pid_t pid) { |
Yi Kong | c8d09dd | 2018-07-13 17:39:22 -0700 | [diff] [blame] | 87 | char* retval = nullptr; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 88 | if (pid == 0) { // special case from auditd/klogd for kernel |
Mark Salyzyn | ae4d928 | 2014-10-15 08:49:39 -0700 | [diff] [blame] | 89 | retval = strdup("logd"); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 90 | } else { |
Mark Salyzyn | 9a03863 | 2014-04-07 07:05:40 -0700 | [diff] [blame] | 91 | char buffer[512]; |
| 92 | snprintf(buffer, sizeof(buffer), "/proc/%u/cmdline", pid); |
Tom Cherry | 9b4246d | 2020-06-17 11:40:55 -0700 | [diff] [blame] | 93 | int fd = open(buffer, O_RDONLY | O_CLOEXEC); |
Mark Salyzyn | 9a03863 | 2014-04-07 07:05:40 -0700 | [diff] [blame] | 94 | if (fd >= 0) { |
| 95 | ssize_t ret = read(fd, buffer, sizeof(buffer)); |
| 96 | if (ret > 0) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 97 | buffer[sizeof(buffer) - 1] = '\0'; |
Mark Salyzyn | 9a03863 | 2014-04-07 07:05:40 -0700 | [diff] [blame] | 98 | // frameworks intermediate state |
Mark Salyzyn | 0eeb06b | 2016-12-02 10:08:48 -0800 | [diff] [blame] | 99 | if (fastcmp<strcmp>(buffer, "<pre-initialized>")) { |
Mark Salyzyn | 9a03863 | 2014-04-07 07:05:40 -0700 | [diff] [blame] | 100 | retval = strdup(buffer); |
| 101 | } |
| 102 | } |
| 103 | close(fd); |
| 104 | } |
| 105 | } |
| 106 | return retval; |
| 107 | } |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 108 | } |
| 109 | |
Tom Cherry | a26f7df | 2020-05-19 17:48:42 -0700 | [diff] [blame] | 110 | void LogStatistics::AddTotal(log_id_t log_id, uint16_t size) { |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 111 | auto lock = std::lock_guard{lock_}; |
Mark Salyzyn | 02dd2f4 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 112 | |
Mark Salyzyn | 02dd2f4 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 113 | mSizesTotal[log_id] += size; |
| 114 | SizesTotal += size; |
| 115 | ++mElementsTotal[log_id]; |
| 116 | } |
| 117 | |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 118 | void LogStatistics::Add(LogStatisticsElement element) { |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 119 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 120 | |
| 121 | if (!track_total_size_) { |
| 122 | element.total_len = element.msg_len; |
| 123 | } |
| 124 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 125 | log_id_t log_id = element.log_id; |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 126 | uint16_t size = element.total_len; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 127 | mSizes[log_id] += size; |
| 128 | ++mElements[log_id]; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 129 | |
Mark Salyzyn | 02dd2f4 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 130 | // When caller adding a chatty entry, they will have already |
| 131 | // called add() and subtract() for each entry as they are |
| 132 | // evaluated and trimmed, thus recording size and number of |
| 133 | // elements, but we must recognize the manufactured dropped |
| 134 | // entry as not contributing to the lifetime totals. |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 135 | if (element.dropped_count) { |
Mark Salyzyn | a2c0222 | 2016-12-13 10:31:29 -0800 | [diff] [blame] | 136 | ++mDroppedElements[log_id]; |
| 137 | } else { |
Mark Salyzyn | a2c0222 | 2016-12-13 10:31:29 -0800 | [diff] [blame] | 138 | mSizesTotal[log_id] += size; |
Mark Salyzyn | 3296291 | 2016-09-12 10:29:17 -0700 | [diff] [blame] | 139 | SizesTotal += size; |
Mark Salyzyn | a2c0222 | 2016-12-13 10:31:29 -0800 | [diff] [blame] | 140 | ++mElementsTotal[log_id]; |
| 141 | } |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 142 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 143 | log_time stamp(element.realtime); |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 144 | if (mNewest[log_id] < stamp) { |
| 145 | // A major time update invalidates the statistics :-( |
| 146 | log_time diff = stamp - mNewest[log_id]; |
| 147 | mNewest[log_id] = stamp; |
| 148 | |
| 149 | if (diff.tv_sec > hourSec) { |
| 150 | // approximate Do-Your-Best fixup |
| 151 | diff += mOldest[log_id]; |
| 152 | if ((diff > stamp) && ((diff - stamp).tv_sec < hourSec)) { |
| 153 | diff = stamp; |
| 154 | } |
| 155 | if (diff <= stamp) { |
| 156 | mOldest[log_id] = diff; |
| 157 | if (mNewestDropped[log_id] < diff) { |
| 158 | mNewestDropped[log_id] = diff; |
| 159 | } |
| 160 | } |
| 161 | } |
| 162 | } |
| 163 | |
Mark Salyzyn | ae4d928 | 2014-10-15 08:49:39 -0700 | [diff] [blame] | 164 | if (log_id == LOG_ID_KERNEL) { |
| 165 | return; |
| 166 | } |
| 167 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 168 | uidTable[log_id].Add(element.uid, element); |
| 169 | if (element.uid == AID_SYSTEM) { |
| 170 | pidSystemTable[log_id].Add(element.pid, element); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 171 | } |
Mark Salyzyn | ae4d928 | 2014-10-15 08:49:39 -0700 | [diff] [blame] | 172 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 173 | if (!enable) { |
| 174 | return; |
| 175 | } |
| 176 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 177 | pidTable.Add(element.pid, element); |
| 178 | tidTable.Add(element.tid, element); |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 179 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 180 | uint32_t tag = element.tag; |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 181 | if (tag) { |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 182 | if (log_id == LOG_ID_SECURITY) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 183 | securityTagTable.Add(tag, element); |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 184 | } else { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 185 | tagTable.Add(tag, element); |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 186 | } |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 187 | } |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 188 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 189 | if (!element.dropped_count) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 190 | tagNameTable.Add(TagNameKey(element), element); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 191 | } |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 192 | } |
| 193 | |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 194 | void LogStatistics::Subtract(LogStatisticsElement element) { |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 195 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 196 | |
| 197 | if (!track_total_size_) { |
| 198 | element.total_len = element.msg_len; |
| 199 | } |
| 200 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 201 | log_id_t log_id = element.log_id; |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 202 | uint16_t size = element.total_len; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 203 | mSizes[log_id] -= size; |
| 204 | --mElements[log_id]; |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 205 | if (element.dropped_count) { |
Mark Salyzyn | 58b8be8 | 2015-09-30 07:40:09 -0700 | [diff] [blame] | 206 | --mDroppedElements[log_id]; |
| 207 | } |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 208 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 209 | if (mOldest[log_id] < element.realtime) { |
| 210 | mOldest[log_id] = element.realtime; |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 211 | } |
| 212 | |
Mark Salyzyn | ae4d928 | 2014-10-15 08:49:39 -0700 | [diff] [blame] | 213 | if (log_id == LOG_ID_KERNEL) { |
| 214 | return; |
| 215 | } |
| 216 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 217 | uidTable[log_id].Subtract(element.uid, element); |
| 218 | if (element.uid == AID_SYSTEM) { |
| 219 | pidSystemTable[log_id].Subtract(element.pid, element); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 220 | } |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 221 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 222 | if (!enable) { |
| 223 | return; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 224 | } |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 225 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 226 | pidTable.Subtract(element.pid, element); |
| 227 | tidTable.Subtract(element.tid, element); |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 228 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 229 | uint32_t tag = element.tag; |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 230 | if (tag) { |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 231 | if (log_id == LOG_ID_SECURITY) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 232 | securityTagTable.Subtract(tag, element); |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 233 | } else { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 234 | tagTable.Subtract(tag, element); |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 235 | } |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 236 | } |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 237 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 238 | if (!element.dropped_count) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 239 | tagNameTable.Subtract(TagNameKey(element), element); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 240 | } |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 241 | } |
| 242 | |
Mark Salyzyn | ab0dcf6 | 2015-03-16 12:04:09 -0700 | [diff] [blame] | 243 | // Atomically set an entry to drop |
| 244 | // entry->setDropped(1) must follow this call, caller should do this explicitly. |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 245 | void LogStatistics::Drop(LogStatisticsElement element) { |
| 246 | CHECK_EQ(element.dropped_count, 0U); |
| 247 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 248 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 249 | log_id_t log_id = element.log_id; |
| 250 | uint16_t size = element.msg_len; |
Mark Salyzyn | ab0dcf6 | 2015-03-16 12:04:09 -0700 | [diff] [blame] | 251 | mSizes[log_id] -= size; |
Mark Salyzyn | 58b8be8 | 2015-09-30 07:40:09 -0700 | [diff] [blame] | 252 | ++mDroppedElements[log_id]; |
Mark Salyzyn | ab0dcf6 | 2015-03-16 12:04:09 -0700 | [diff] [blame] | 253 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 254 | if (mNewestDropped[log_id] < element.realtime) { |
| 255 | mNewestDropped[log_id] = element.realtime; |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 256 | } |
| 257 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 258 | uidTable[log_id].Drop(element.uid, element); |
| 259 | if (element.uid == AID_SYSTEM) { |
| 260 | pidSystemTable[log_id].Drop(element.pid, element); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 261 | } |
Mark Salyzyn | ab0dcf6 | 2015-03-16 12:04:09 -0700 | [diff] [blame] | 262 | |
| 263 | if (!enable) { |
| 264 | return; |
| 265 | } |
| 266 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 267 | pidTable.Drop(element.pid, element); |
| 268 | tidTable.Drop(element.tid, element); |
Mark Salyzyn | 6a06694 | 2016-07-14 15:34:30 -0700 | [diff] [blame] | 269 | |
Tom Cherry | 3dd3ec3 | 2020-06-02 15:39:21 -0700 | [diff] [blame] | 270 | uint32_t tag = element.tag; |
Mark Salyzyn | 6a06694 | 2016-07-14 15:34:30 -0700 | [diff] [blame] | 271 | if (tag) { |
| 272 | if (log_id == LOG_ID_SECURITY) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 273 | securityTagTable.Drop(tag, element); |
Mark Salyzyn | 6a06694 | 2016-07-14 15:34:30 -0700 | [diff] [blame] | 274 | } else { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 275 | tagTable.Drop(tag, element); |
Mark Salyzyn | 6a06694 | 2016-07-14 15:34:30 -0700 | [diff] [blame] | 276 | } |
| 277 | } |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 278 | |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 279 | tagNameTable.Subtract(TagNameKey(element), element); |
Mark Salyzyn | ab0dcf6 | 2015-03-16 12:04:09 -0700 | [diff] [blame] | 280 | } |
| 281 | |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 282 | void LogStatistics::Erase(LogStatisticsElement element) { |
| 283 | CHECK_GT(element.dropped_count, 0U); |
| 284 | CHECK_EQ(element.msg_len, 0U); |
| 285 | |
| 286 | auto lock = std::lock_guard{lock_}; |
| 287 | |
| 288 | if (!track_total_size_) { |
| 289 | element.total_len = 0; |
| 290 | } |
| 291 | |
| 292 | log_id_t log_id = element.log_id; |
| 293 | --mElements[log_id]; |
| 294 | --mDroppedElements[log_id]; |
| 295 | mSizes[log_id] -= element.total_len; |
| 296 | |
| 297 | uidTable[log_id].Erase(element.uid, element); |
| 298 | if (element.uid == AID_SYSTEM) { |
| 299 | pidSystemTable[log_id].Erase(element.pid, element); |
| 300 | } |
| 301 | |
| 302 | if (!enable) { |
| 303 | return; |
| 304 | } |
| 305 | |
| 306 | pidTable.Erase(element.pid, element); |
| 307 | tidTable.Erase(element.tid, element); |
| 308 | |
| 309 | uint32_t tag = element.tag; |
| 310 | if (tag) { |
| 311 | if (log_id == LOG_ID_SECURITY) { |
| 312 | securityTagTable.Erase(tag, element); |
| 313 | } else { |
| 314 | tagTable.Erase(tag, element); |
| 315 | } |
| 316 | } |
| 317 | } |
| 318 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 319 | const char* LogStatistics::UidToName(uid_t uid) const { |
| 320 | auto lock = std::lock_guard{lock_}; |
| 321 | return UidToNameLocked(uid); |
| 322 | } |
| 323 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 324 | // caller must own and free character string |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 325 | const char* LogStatistics::UidToNameLocked(uid_t uid) const { |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 326 | // Local hard coded favourites |
| 327 | if (uid == AID_LOGD) { |
| 328 | return strdup("auditd"); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 329 | } |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 330 | |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 331 | // Android system |
| 332 | if (uid < AID_APP) { |
| 333 | // in bionic, thread safe as long as we copy the results |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 334 | struct passwd* pwd = getpwuid(uid); |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 335 | if (pwd) { |
| 336 | return strdup(pwd->pw_name); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 337 | } |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 338 | } |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 339 | |
Mark Salyzyn | 08739ba | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 340 | // Parse /data/system/packages.list |
Jeff Sharkey | dff4470 | 2016-12-13 11:55:19 -0700 | [diff] [blame] | 341 | uid_t userId = uid % AID_USER_OFFSET; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 342 | const char* name = android::uidToName(userId); |
Mark Salyzyn | 023f51f | 2015-04-29 12:48:45 -0700 | [diff] [blame] | 343 | if (!name && (userId > (AID_SHARED_GID_START - AID_APP))) { |
| 344 | name = android::uidToName(userId - (AID_SHARED_GID_START - AID_APP)); |
| 345 | } |
Mark Salyzyn | 08739ba | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 346 | if (name) { |
| 347 | return name; |
| 348 | } |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 349 | |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 350 | // Android application |
| 351 | if (uid >= AID_APP) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 352 | struct passwd* pwd = getpwuid(uid); |
Mark Salyzyn | b8a95bd | 2016-04-07 11:06:31 -0700 | [diff] [blame] | 353 | if (pwd) { |
| 354 | return strdup(pwd->pw_name); |
| 355 | } |
| 356 | } |
| 357 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 358 | // report uid -> pid(s) -> pidToName if unique |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 359 | for (pidTable_t::const_iterator it = pidTable.begin(); it != pidTable.end(); |
| 360 | ++it) { |
| 361 | const PidEntry& entry = it->second; |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 362 | |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 363 | if (entry.uid() == uid) { |
| 364 | const char* nameTmp = entry.name(); |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 365 | |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 366 | if (nameTmp) { |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 367 | if (!name) { |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 368 | name = strdup(nameTmp); |
Mark Salyzyn | 0eeb06b | 2016-12-02 10:08:48 -0800 | [diff] [blame] | 369 | } else if (fastcmp<strcmp>(name, nameTmp)) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 370 | free(const_cast<char*>(name)); |
Yi Kong | c8d09dd | 2018-07-13 17:39:22 -0700 | [diff] [blame] | 371 | name = nullptr; |
Mark Salyzyn | 023f51f | 2015-04-29 12:48:45 -0700 | [diff] [blame] | 372 | break; |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 373 | } |
| 374 | } |
| 375 | } |
| 376 | } |
| 377 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 378 | // No one |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 379 | return name; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 380 | } |
| 381 | |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 382 | template <typename TKey, typename TEntry> |
| 383 | void LogStatistics::WorstTwoWithThreshold(const LogHashtable<TKey, TEntry>& table, size_t threshold, |
| 384 | int* worst, size_t* worst_sizes, |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 385 | size_t* second_worst_sizes) const { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 386 | std::array<const TKey*, 2> max_keys; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 387 | std::array<const TEntry*, 2> max_entries; |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 388 | table.MaxEntries(AID_ROOT, 0, max_keys, max_entries); |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 389 | if (max_entries[0] == nullptr || max_entries[1] == nullptr) { |
| 390 | return; |
| 391 | } |
| 392 | *worst_sizes = max_entries[0]->getSizes(); |
| 393 | // b/24782000: Allow time horizon to extend roughly tenfold, assume average entry length is |
| 394 | // 100 characters. |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 395 | if (*worst_sizes > threshold && *worst_sizes > (10 * max_entries[0]->dropped_count())) { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 396 | *worst = *max_keys[0]; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 397 | *second_worst_sizes = max_entries[1]->getSizes(); |
| 398 | if (*second_worst_sizes < threshold) { |
| 399 | *second_worst_sizes = threshold; |
| 400 | } |
| 401 | } |
| 402 | } |
| 403 | |
| 404 | void LogStatistics::WorstTwoUids(log_id id, size_t threshold, int* worst, size_t* worst_sizes, |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 405 | size_t* second_worst_sizes) const { |
| 406 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 407 | WorstTwoWithThreshold(uidTable[id], threshold, worst, worst_sizes, second_worst_sizes); |
| 408 | } |
| 409 | |
| 410 | void LogStatistics::WorstTwoTags(size_t threshold, int* worst, size_t* worst_sizes, |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 411 | size_t* second_worst_sizes) const { |
| 412 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 413 | WorstTwoWithThreshold(tagTable, threshold, worst, worst_sizes, second_worst_sizes); |
| 414 | } |
| 415 | |
| 416 | void LogStatistics::WorstTwoSystemPids(log_id id, size_t worst_uid_sizes, int* worst, |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 417 | size_t* second_worst_sizes) const { |
| 418 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 419 | std::array<const pid_t*, 2> max_keys; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 420 | std::array<const PidEntry*, 2> max_entries; |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 421 | pidSystemTable[id].MaxEntries(AID_SYSTEM, 0, max_keys, max_entries); |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 422 | if (max_entries[0] == nullptr || max_entries[1] == nullptr) { |
| 423 | return; |
| 424 | } |
| 425 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 426 | *worst = *max_keys[0]; |
Tom Cherry | b6b78e9 | 2020-05-07 09:13:12 -0700 | [diff] [blame] | 427 | *second_worst_sizes = worst_uid_sizes - max_entries[0]->getSizes() + max_entries[1]->getSizes(); |
| 428 | } |
| 429 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 430 | // Prune at most 10% of the log entries or maxPrune, whichever is less. |
| 431 | bool LogStatistics::ShouldPrune(log_id id, unsigned long max_size, |
| 432 | unsigned long* prune_rows) const { |
| 433 | static constexpr size_t kMinPrune = 4; |
| 434 | static constexpr size_t kMaxPrune = 256; |
| 435 | |
| 436 | auto lock = std::lock_guard{lock_}; |
| 437 | size_t sizes = mSizes[id]; |
| 438 | if (sizes <= max_size) { |
| 439 | return false; |
| 440 | } |
| 441 | size_t size_over = sizes - ((max_size * 9) / 10); |
| 442 | size_t elements = mElements[id] - mDroppedElements[id]; |
| 443 | size_t min_elements = elements / 100; |
| 444 | if (min_elements < kMinPrune) { |
| 445 | min_elements = kMinPrune; |
| 446 | } |
| 447 | *prune_rows = elements * size_over / sizes; |
| 448 | if (*prune_rows < min_elements) { |
| 449 | *prune_rows = min_elements; |
| 450 | } |
| 451 | if (*prune_rows > kMaxPrune) { |
| 452 | *prune_rows = kMaxPrune; |
| 453 | } |
| 454 | |
| 455 | return true; |
| 456 | } |
| 457 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 458 | std::string UidEntry::formatHeader(const std::string& name, log_id_t id) const { |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 459 | bool isprune = worstUidEnabledForLogid(id); |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 460 | return formatLine(android::base::StringPrintf(name.c_str(), |
| 461 | android_log_id_to_name(id)), |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 462 | std::string("Size"), |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 463 | std::string(isprune ? "+/- Pruned" : "")) + |
| 464 | formatLine(std::string("UID PACKAGE"), std::string("BYTES"), |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 465 | std::string(isprune ? "NUM" : "")); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 466 | } |
| 467 | |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 468 | // Helper to truncate name, if too long, and add name dressings |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 469 | void LogStatistics::FormatTmp(const char* nameTmp, uid_t uid, std::string& name, std::string& size, |
| 470 | size_t nameLen) const { |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 471 | const char* allocNameTmp = nullptr; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 472 | if (!nameTmp) nameTmp = allocNameTmp = UidToNameLocked(uid); |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 473 | if (nameTmp) { |
| 474 | size_t lenSpace = std::max(nameLen - name.length(), (size_t)1); |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 475 | size_t len = EntryBase::TOTAL_LEN - EntryBase::PRUNED_LEN - size.length() - name.length() - |
| 476 | lenSpace - 2; |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 477 | size_t lenNameTmp = strlen(nameTmp); |
| 478 | while ((len < lenNameTmp) && (lenSpace > 1)) { |
| 479 | ++len; |
| 480 | --lenSpace; |
| 481 | } |
| 482 | name += android::base::StringPrintf("%*s", (int)lenSpace, ""); |
| 483 | if (len < lenNameTmp) { |
| 484 | name += "..."; |
| 485 | nameTmp += lenNameTmp - std::max(len - 3, (size_t)1); |
| 486 | } |
| 487 | name += nameTmp; |
| 488 | free(const_cast<char*>(allocNameTmp)); |
| 489 | } |
| 490 | } |
| 491 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 492 | std::string UidEntry::format(const LogStatistics& stat, log_id_t id, uid_t uid) const |
| 493 | REQUIRES(stat.lock_) { |
| 494 | std::string name = android::base::StringPrintf("%u", uid); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 495 | std::string size = android::base::StringPrintf("%zu", getSizes()); |
| 496 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 497 | stat.FormatTmp(nullptr, uid, name, size, 6); |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 498 | |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 499 | std::string pruned = ""; |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 500 | if (worstUidEnabledForLogid(id)) { |
| 501 | size_t totalDropped = 0; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 502 | for (LogStatistics::uidTable_t::const_iterator it = |
| 503 | stat.uidTable[id].begin(); |
| 504 | it != stat.uidTable[id].end(); ++it) { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 505 | totalDropped += it->second.dropped_count(); |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 506 | } |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 507 | size_t sizes = stat.mSizes[id]; |
| 508 | size_t totalSize = stat.mSizesTotal[id]; |
| 509 | size_t totalElements = stat.mElementsTotal[id]; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 510 | float totalVirtualSize = |
| 511 | (float)sizes + (float)totalDropped * totalSize / totalElements; |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 512 | size_t entrySize = getSizes(); |
| 513 | float virtualEntrySize = entrySize; |
| 514 | int realPermille = virtualEntrySize * 1000.0 / sizes; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 515 | size_t dropped = dropped_count(); |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 516 | if (dropped) { |
| 517 | pruned = android::base::StringPrintf("%zu", dropped); |
| 518 | virtualEntrySize += (float)dropped * totalSize / totalElements; |
| 519 | } |
| 520 | int virtualPermille = virtualEntrySize * 1000.0 / totalVirtualSize; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 521 | int permille = |
| 522 | (realPermille - virtualPermille) * 1000L / (virtualPermille ?: 1); |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 523 | if ((permille < -1) || (1 < permille)) { |
| 524 | std::string change; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 525 | const char* units = "%"; |
| 526 | const char* prefix = (permille > 0) ? "+" : ""; |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 527 | |
| 528 | if (permille > 999) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 529 | permille = (permille + 1000) / 100; // Now tenths fold |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 530 | units = "X"; |
| 531 | prefix = ""; |
| 532 | } |
| 533 | if ((-99 < permille) && (permille < 99)) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 534 | change = android::base::StringPrintf( |
| 535 | "%s%d.%u%s", prefix, permille / 10, |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 536 | ((permille < 0) ? (-permille % 10) : (permille % 10)), |
| 537 | units); |
| 538 | } else { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 539 | change = android::base::StringPrintf( |
| 540 | "%s%d%s", prefix, (permille + 5) / 10, units); |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 541 | } |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 542 | ssize_t spaces = EntryBase::PRUNED_LEN - 2 - pruned.length() - change.length(); |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 543 | if ((spaces <= 0) && pruned.length()) { |
| 544 | spaces = 1; |
| 545 | } |
Mark Salyzyn | d966e22 | 2016-12-19 22:23:03 +0000 | [diff] [blame] | 546 | if (spaces > 0) { |
Mark Salyzyn | c723df8 | 2015-08-24 11:08:00 -0700 | [diff] [blame] | 547 | change += android::base::StringPrintf("%*s", (int)spaces, ""); |
| 548 | } |
| 549 | pruned = change + pruned; |
| 550 | } |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 551 | } |
| 552 | |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 553 | std::string output = formatLine(name, size, pruned); |
| 554 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 555 | if (uid != AID_SYSTEM) { |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 556 | return output; |
| 557 | } |
| 558 | |
| 559 | static const size_t maximum_sorted_entries = 32; |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 560 | std::array<const pid_t*, maximum_sorted_entries> sorted_pids; |
| 561 | std::array<const PidEntry*, maximum_sorted_entries> sorted_entries; |
| 562 | stat.pidSystemTable[id].MaxEntries(uid, 0, sorted_pids, sorted_entries); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 563 | |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 564 | std::string byPid; |
| 565 | size_t index; |
| 566 | bool hasDropped = false; |
| 567 | for (index = 0; index < maximum_sorted_entries; ++index) { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 568 | const PidEntry* entry = sorted_entries[index]; |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 569 | if (!entry) { |
| 570 | break; |
| 571 | } |
| 572 | if (entry->getSizes() <= (getSizes() / 100)) { |
| 573 | break; |
| 574 | } |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 575 | if (entry->dropped_count()) { |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 576 | hasDropped = true; |
| 577 | } |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 578 | byPid += entry->format(stat, id, *sorted_pids[index]); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 579 | } |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 580 | if (index > 1) { // print this only if interesting |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 581 | std::string ditto("\" "); |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 582 | output += formatLine(std::string(" PID/UID COMMAND LINE"), ditto, |
| 583 | hasDropped ? ditto : std::string("")); |
Mark Salyzyn | bec3c3d | 2015-08-28 08:02:59 -0700 | [diff] [blame] | 584 | output += byPid; |
| 585 | } |
| 586 | |
| 587 | return output; |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 588 | } |
| 589 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 590 | std::string PidEntry::formatHeader(const std::string& name, |
| 591 | log_id_t /* id */) const { |
| 592 | return formatLine(name, std::string("Size"), std::string("Pruned")) + |
| 593 | formatLine(std::string(" PID/UID COMMAND LINE"), |
| 594 | std::string("BYTES"), std::string("NUM")); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 595 | } |
| 596 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 597 | std::string PidEntry::format(const LogStatistics& stat, log_id_t, pid_t pid) const |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 598 | REQUIRES(stat.lock_) { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 599 | std::string name = android::base::StringPrintf("%5u/%u", pid, uid_); |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 600 | std::string size = android::base::StringPrintf("%zu", getSizes()); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 601 | |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 602 | stat.FormatTmp(name_, uid_, name, size, 12); |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 603 | |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 604 | std::string pruned = ""; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 605 | size_t dropped = dropped_count(); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 606 | if (dropped) { |
| 607 | pruned = android::base::StringPrintf("%zu", dropped); |
| 608 | } |
| 609 | |
| 610 | return formatLine(name, size, pruned); |
| 611 | } |
| 612 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 613 | std::string TidEntry::formatHeader(const std::string& name, |
| 614 | log_id_t /* id */) const { |
| 615 | return formatLine(name, std::string("Size"), std::string("Pruned")) + |
| 616 | formatLine(std::string(" TID/UID COMM"), std::string("BYTES"), |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 617 | std::string("NUM")); |
| 618 | } |
| 619 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 620 | std::string TidEntry::format(const LogStatistics& stat, log_id_t, pid_t tid) const |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 621 | REQUIRES(stat.lock_) { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 622 | std::string name = android::base::StringPrintf("%5u/%u", tid, uid_); |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 623 | std::string size = android::base::StringPrintf("%zu", getSizes()); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 624 | |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 625 | stat.FormatTmp(name_, uid_, name, size, 12); |
Mark Salyzyn | f31ae3d | 2017-04-13 15:35:22 -0700 | [diff] [blame] | 626 | |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 627 | std::string pruned = ""; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 628 | size_t dropped = dropped_count(); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 629 | if (dropped) { |
| 630 | pruned = android::base::StringPrintf("%zu", dropped); |
| 631 | } |
| 632 | |
| 633 | return formatLine(name, size, pruned); |
| 634 | } |
| 635 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 636 | std::string TagEntry::formatHeader(const std::string& name, log_id_t id) const { |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 637 | bool isprune = worstUidEnabledForLogid(id); |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 638 | return formatLine(name, std::string("Size"), |
| 639 | std::string(isprune ? "Prune" : "")) + |
| 640 | formatLine(std::string(" TAG/UID TAGNAME"), |
| 641 | std::string("BYTES"), std::string(isprune ? "NUM" : "")); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 642 | } |
| 643 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 644 | std::string TagEntry::format(const LogStatistics&, log_id_t, uint32_t) const { |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 645 | std::string name; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 646 | if (uid_ == (uid_t)-1) { |
| 647 | name = android::base::StringPrintf("%7u", key()); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 648 | } else { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 649 | name = android::base::StringPrintf("%7u/%u", key(), uid_); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 650 | } |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 651 | const char* nameTmp = this->name(); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 652 | if (nameTmp) { |
| 653 | name += android::base::StringPrintf( |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 654 | "%*s%s", (int)std::max(14 - name.length(), (size_t)1), "", nameTmp); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 655 | } |
| 656 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 657 | std::string size = android::base::StringPrintf("%zu", getSizes()); |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 658 | |
| 659 | std::string pruned = ""; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 660 | size_t dropped = dropped_count(); |
Mark Salyzyn | 6a06694 | 2016-07-14 15:34:30 -0700 | [diff] [blame] | 661 | if (dropped) { |
| 662 | pruned = android::base::StringPrintf("%zu", dropped); |
| 663 | } |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 664 | |
| 665 | return formatLine(name, size, pruned); |
| 666 | } |
| 667 | |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 668 | std::string TagNameEntry::formatHeader(const std::string& name, |
| 669 | log_id_t /* id */) const { |
| 670 | return formatLine(name, std::string("Size"), std::string("")) + |
| 671 | formatLine(std::string(" TID/PID/UID LOG_TAG NAME"), |
| 672 | std::string("BYTES"), std::string("")); |
| 673 | } |
| 674 | |
Tom Cherry | b0263af | 2020-06-03 15:38:32 -0700 | [diff] [blame] | 675 | std::string TagNameEntry::format(const LogStatistics&, log_id_t, |
| 676 | const std::string& key_name) const { |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 677 | std::string name; |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 678 | std::string pidstr; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 679 | if (pid_ != (pid_t)-1) { |
| 680 | pidstr = android::base::StringPrintf("%u", pid_); |
| 681 | if (tid_ != (pid_t)-1 && tid_ != pid_) pidstr = "/" + pidstr; |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 682 | } |
| 683 | int len = 9 - pidstr.length(); |
| 684 | if (len < 0) len = 0; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 685 | if (tid_ == (pid_t)-1 || tid_ == pid_) { |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 686 | name = android::base::StringPrintf("%*s", len, ""); |
| 687 | } else { |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 688 | name = android::base::StringPrintf("%*u", len, tid_); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 689 | } |
| 690 | name += pidstr; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 691 | if (uid_ != (uid_t)-1) { |
| 692 | name += android::base::StringPrintf("/%u", uid_); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 693 | } |
| 694 | |
| 695 | std::string size = android::base::StringPrintf("%zu", getSizes()); |
| 696 | |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 697 | const char* nameTmp = key_name.data(); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 698 | if (nameTmp) { |
| 699 | size_t lenSpace = std::max(16 - name.length(), (size_t)1); |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 700 | size_t len = EntryBase::TOTAL_LEN - EntryBase::PRUNED_LEN - size.length() - name.length() - |
| 701 | lenSpace - 2; |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 702 | size_t lenNameTmp = strlen(nameTmp); |
| 703 | while ((len < lenNameTmp) && (lenSpace > 1)) { |
| 704 | ++len; |
| 705 | --lenSpace; |
| 706 | } |
| 707 | name += android::base::StringPrintf("%*s", (int)lenSpace, ""); |
| 708 | if (len < lenNameTmp) { |
| 709 | name += "..."; |
| 710 | nameTmp += lenNameTmp - std::max(len - 3, (size_t)1); |
| 711 | } |
| 712 | name += nameTmp; |
| 713 | } |
| 714 | |
| 715 | std::string pruned = ""; |
| 716 | |
| 717 | return formatLine(name, size, pruned); |
| 718 | } |
| 719 | |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 720 | static std::string formatMsec(uint64_t val) { |
| 721 | static const unsigned subsecDigits = 3; |
| 722 | static const uint64_t sec = MS_PER_SEC; |
| 723 | |
| 724 | static const uint64_t minute = 60 * sec; |
| 725 | static const uint64_t hour = 60 * minute; |
| 726 | static const uint64_t day = 24 * hour; |
| 727 | |
| 728 | std::string output; |
| 729 | if (val < sec) return output; |
| 730 | |
| 731 | if (val >= day) { |
| 732 | output = android::base::StringPrintf("%" PRIu64 "d ", val / day); |
| 733 | val = (val % day) + day; |
| 734 | } |
| 735 | if (val >= minute) { |
| 736 | if (val >= hour) { |
| 737 | output += android::base::StringPrintf("%" PRIu64 ":", |
| 738 | (val / hour) % (day / hour)); |
| 739 | } |
| 740 | output += android::base::StringPrintf( |
| 741 | (val >= hour) ? "%02" PRIu64 ":" : "%" PRIu64 ":", |
| 742 | (val / minute) % (hour / minute)); |
| 743 | } |
| 744 | output += |
| 745 | android::base::StringPrintf((val >= minute) ? "%02" PRIu64 : "%" PRIu64, |
| 746 | (val / sec) % (minute / sec)); |
| 747 | val %= sec; |
| 748 | unsigned digits = subsecDigits; |
| 749 | while (digits && ((val % 10) == 0)) { |
| 750 | val /= 10; |
| 751 | --digits; |
| 752 | } |
| 753 | if (digits) { |
| 754 | output += android::base::StringPrintf(".%0*" PRIu64, digits, val); |
| 755 | } |
| 756 | return output; |
| 757 | } |
| 758 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 759 | template <typename TKey, typename TEntry> |
| 760 | std::string LogStatistics::FormatTable(const LogHashtable<TKey, TEntry>& table, uid_t uid, |
| 761 | pid_t pid, const std::string& name, log_id_t id) const |
| 762 | REQUIRES(lock_) { |
| 763 | static const size_t maximum_sorted_entries = 32; |
| 764 | std::string output; |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 765 | std::array<const TKey*, maximum_sorted_entries> sorted_keys; |
| 766 | std::array<const TEntry*, maximum_sorted_entries> sorted_entries; |
| 767 | table.MaxEntries(uid, pid, sorted_keys, sorted_entries); |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 768 | bool header_printed = false; |
| 769 | for (size_t index = 0; index < maximum_sorted_entries; ++index) { |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 770 | const TEntry* entry = sorted_entries[index]; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 771 | if (!entry) { |
| 772 | break; |
| 773 | } |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 774 | if (entry->getSizes() <= (sorted_entries[0]->getSizes() / 100)) { |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 775 | break; |
| 776 | } |
| 777 | if (!header_printed) { |
| 778 | output += "\n\n"; |
| 779 | output += entry->formatHeader(name, id); |
| 780 | header_printed = true; |
| 781 | } |
Tom Cherry | 4596b78 | 2020-06-03 13:49:24 -0700 | [diff] [blame] | 782 | output += entry->format(*this, id, *sorted_keys[index]); |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 783 | } |
| 784 | return output; |
| 785 | } |
| 786 | |
| 787 | std::string LogStatistics::Format(uid_t uid, pid_t pid, unsigned int logMask) const { |
| 788 | auto lock = std::lock_guard{lock_}; |
| 789 | |
Chih-Hung Hsieh | 08d470b | 2018-08-13 14:22:56 -0700 | [diff] [blame] | 790 | static const uint16_t spaces_total = 19; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 791 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 792 | // Report on total logging, current and for all time |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 793 | |
Mark Salyzyn | decbcd9 | 2015-08-19 15:33:01 -0700 | [diff] [blame] | 794 | std::string output = "size/num"; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 795 | size_t oldLength; |
Chih-Hung Hsieh | 08d470b | 2018-08-13 14:22:56 -0700 | [diff] [blame] | 796 | int16_t spaces = 1; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 797 | |
| 798 | log_id_for_each(id) { |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 799 | if (!(logMask & (1 << id))) continue; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 800 | oldLength = output.length(); |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 801 | if (spaces < 0) spaces = 0; |
Mark Salyzyn | decbcd9 | 2015-08-19 15:33:01 -0700 | [diff] [blame] | 802 | output += android::base::StringPrintf("%*s%s", spaces, "", |
| 803 | android_log_id_to_name(id)); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 804 | spaces += spaces_total + oldLength - output.length(); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 805 | } |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 806 | if (spaces < 0) spaces = 0; |
| 807 | output += android::base::StringPrintf("%*sTotal", spaces, ""); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 808 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 809 | static const char TotalStr[] = "\nTotal"; |
| 810 | spaces = 10 - strlen(TotalStr); |
| 811 | output += TotalStr; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 812 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 813 | size_t totalSize = 0; |
| 814 | size_t totalEls = 0; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 815 | log_id_for_each(id) { |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 816 | if (!(logMask & (1 << id))) continue; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 817 | oldLength = output.length(); |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 818 | if (spaces < 0) spaces = 0; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 819 | size_t szs = mSizesTotal[id]; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 820 | totalSize += szs; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 821 | size_t els = mElementsTotal[id]; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 822 | totalEls += els; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 823 | output += |
| 824 | android::base::StringPrintf("%*s%zu/%zu", spaces, "", szs, els); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 825 | spaces += spaces_total + oldLength - output.length(); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 826 | } |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 827 | if (spaces < 0) spaces = 0; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 828 | output += android::base::StringPrintf("%*s%zu/%zu", spaces, "", totalSize, |
| 829 | totalEls); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 830 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 831 | static const char NowStr[] = "\nNow"; |
| 832 | spaces = 10 - strlen(NowStr); |
| 833 | output += NowStr; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 834 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 835 | totalSize = 0; |
| 836 | totalEls = 0; |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 837 | log_id_for_each(id) { |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 838 | if (!(logMask & (1 << id))) continue; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 839 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 840 | size_t els = mElements[id]; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 841 | if (els) { |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 842 | oldLength = output.length(); |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 843 | if (spaces < 0) spaces = 0; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 844 | size_t szs = mSizes[id]; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 845 | totalSize += szs; |
| 846 | totalEls += els; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 847 | output += |
| 848 | android::base::StringPrintf("%*s%zu/%zu", spaces, "", szs, els); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 849 | spaces -= output.length() - oldLength; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 850 | } |
| 851 | spaces += spaces_total; |
| 852 | } |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 853 | if (spaces < 0) spaces = 0; |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 854 | output += android::base::StringPrintf("%*s%zu/%zu", spaces, "", totalSize, |
| 855 | totalEls); |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 856 | |
Mark Salyzyn | 03bb759 | 2017-04-14 09:46:57 -0700 | [diff] [blame] | 857 | static const char SpanStr[] = "\nLogspan"; |
| 858 | spaces = 10 - strlen(SpanStr); |
| 859 | output += SpanStr; |
| 860 | |
| 861 | // Total reports the greater of the individual maximum time span, or the |
| 862 | // validated minimum start and maximum end time span if it makes sense. |
| 863 | uint64_t minTime = UINT64_MAX; |
| 864 | uint64_t maxTime = 0; |
| 865 | uint64_t maxSpan = 0; |
| 866 | totalSize = 0; |
| 867 | |
| 868 | log_id_for_each(id) { |
| 869 | if (!(logMask & (1 << id))) continue; |
| 870 | |
| 871 | // validity checking |
| 872 | uint64_t oldest = mOldest[id].msec(); |
| 873 | uint64_t newest = mNewest[id].msec(); |
| 874 | if (newest <= oldest) { |
| 875 | spaces += spaces_total; |
| 876 | continue; |
| 877 | } |
| 878 | |
| 879 | uint64_t span = newest - oldest; |
| 880 | if (span > (monthSec * MS_PER_SEC)) { |
| 881 | spaces += spaces_total; |
| 882 | continue; |
| 883 | } |
| 884 | |
| 885 | // total span |
| 886 | if (minTime > oldest) minTime = oldest; |
| 887 | if (maxTime < newest) maxTime = newest; |
| 888 | if (span > maxSpan) maxSpan = span; |
| 889 | totalSize += span; |
| 890 | |
| 891 | uint64_t dropped = mNewestDropped[id].msec(); |
| 892 | if (dropped < oldest) dropped = oldest; |
| 893 | if (dropped > newest) dropped = newest; |
| 894 | |
| 895 | oldLength = output.length(); |
| 896 | output += android::base::StringPrintf("%*s%s", spaces, "", |
| 897 | formatMsec(span).c_str()); |
| 898 | unsigned permille = ((newest - dropped) * 1000 + (span / 2)) / span; |
| 899 | if ((permille > 1) && (permille < 999)) { |
| 900 | output += android::base::StringPrintf("(%u", permille / 10); |
| 901 | permille %= 10; |
| 902 | if (permille) { |
| 903 | output += android::base::StringPrintf(".%u", permille); |
| 904 | } |
| 905 | output += android::base::StringPrintf("%%)"); |
| 906 | } |
| 907 | spaces -= output.length() - oldLength; |
| 908 | spaces += spaces_total; |
| 909 | } |
| 910 | if ((maxTime > minTime) && ((maxTime -= minTime) < totalSize) && |
| 911 | (maxTime > maxSpan)) { |
| 912 | maxSpan = maxTime; |
| 913 | } |
| 914 | if (spaces < 0) spaces = 0; |
| 915 | output += android::base::StringPrintf("%*s%s", spaces, "", |
| 916 | formatMsec(maxSpan).c_str()); |
| 917 | |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 918 | static const char OverheadStr[] = "\nOverhead"; |
| 919 | spaces = 10 - strlen(OverheadStr); |
| 920 | output += OverheadStr; |
| 921 | |
| 922 | totalSize = 0; |
| 923 | log_id_for_each(id) { |
| 924 | if (!(logMask & (1 << id))) continue; |
| 925 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 926 | size_t els = mElements[id]; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 927 | if (els) { |
| 928 | oldLength = output.length(); |
| 929 | if (spaces < 0) spaces = 0; |
Tom Cherry | f74503d | 2020-06-19 12:21:21 -0700 | [diff] [blame] | 930 | size_t szs = 0; |
| 931 | if (overhead_[id]) { |
| 932 | szs = *overhead_[id]; |
| 933 | } else if (track_total_size_) { |
| 934 | szs = mSizes[id]; |
| 935 | } else { |
| 936 | // Legacy fallback for Chatty without track_total_size_ |
| 937 | // Estimate the size of this element in the parent std::list<> by adding two void*'s |
| 938 | // corresponding to the next/prev pointers and aligning to 64 bit. |
| 939 | static const size_t overhead = |
| 940 | (sizeof(LogBufferElement) + 2 * sizeof(void*) + sizeof(uint64_t) - 1) & |
| 941 | -sizeof(uint64_t); |
| 942 | szs = mSizes[id] + els * overhead; |
| 943 | } |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 944 | totalSize += szs; |
| 945 | output += android::base::StringPrintf("%*s%zu", spaces, "", szs); |
| 946 | spaces -= output.length() - oldLength; |
| 947 | } |
| 948 | spaces += spaces_total; |
| 949 | } |
Mark Salyzyn | 6d981af | 2016-10-06 09:55:21 -0700 | [diff] [blame] | 950 | totalSize += sizeOf(); |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 951 | if (spaces < 0) spaces = 0; |
| 952 | output += android::base::StringPrintf("%*s%zu", spaces, "", totalSize); |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 953 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 954 | // Report on Chattiest |
Mark Salyzyn | 8e72c53 | 2014-03-26 10:46:39 -0700 | [diff] [blame] | 955 | |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 956 | std::string name; |
| 957 | |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 958 | // Chattiest by application (UID) |
| 959 | log_id_for_each(id) { |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 960 | if (!(logMask & (1 << id))) continue; |
Mark Salyzyn | 8e72c53 | 2014-03-26 10:46:39 -0700 | [diff] [blame] | 961 | |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 962 | name = (uid == AID_ROOT) ? "Chattiest UIDs in %s log buffer:" |
| 963 | : "Logging for your UID in %s log buffer:"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 964 | output += FormatTable(uidTable[id], uid, pid, name, id); |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 965 | } |
Mark Salyzyn | 8e72c53 | 2014-03-26 10:46:39 -0700 | [diff] [blame] | 966 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 967 | if (enable) { |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 968 | name = ((uid == AID_ROOT) && !pid) ? "Chattiest PIDs:" |
| 969 | : "Logging for this PID:"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 970 | output += FormatTable(pidTable, uid, pid, name); |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 971 | name = "Chattiest TIDs"; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 972 | if (pid) name += android::base::StringPrintf(" for PID %d", pid); |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 973 | name += ":"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 974 | output += FormatTable(tidTable, uid, pid, name); |
Mark Salyzyn | 17ed679 | 2015-04-20 13:35:15 -0700 | [diff] [blame] | 975 | } |
| 976 | |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 977 | if (enable && (logMask & (1 << LOG_ID_EVENTS))) { |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 978 | name = "Chattiest events log buffer TAGs"; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 979 | if (pid) name += android::base::StringPrintf(" for PID %d", pid); |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 980 | name += ":"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 981 | output += FormatTable(tagTable, uid, pid, name, LOG_ID_EVENTS); |
Mark Salyzyn | 344bff4 | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 982 | } |
| 983 | |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 984 | if (enable && (logMask & (1 << LOG_ID_SECURITY))) { |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 985 | name = "Chattiest security log buffer TAGs"; |
Mark Salyzyn | 9af33ee | 2016-10-05 12:34:37 -0700 | [diff] [blame] | 986 | if (pid) name += android::base::StringPrintf(" for PID %d", pid); |
Mark Salyzyn | ee3b838 | 2015-12-17 09:58:43 -0800 | [diff] [blame] | 987 | name += ":"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 988 | output += FormatTable(securityTagTable, uid, pid, name, LOG_ID_SECURITY); |
Mark Salyzyn | 083b037 | 2015-12-04 10:59:45 -0800 | [diff] [blame] | 989 | } |
| 990 | |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 991 | if (enable) { |
| 992 | name = "Chattiest TAGs"; |
| 993 | if (pid) name += android::base::StringPrintf(" for PID %d", pid); |
| 994 | name += ":"; |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 995 | output += FormatTable(tagNameTable, uid, pid, name); |
Mark Salyzyn | f99a7d6 | 2017-04-19 14:39:21 -0700 | [diff] [blame] | 996 | } |
| 997 | |
Mark Salyzyn | 73160ac | 2015-08-20 10:01:44 -0700 | [diff] [blame] | 998 | return output; |
Mark Salyzyn | 34facab | 2014-02-06 14:48:50 -0800 | [diff] [blame] | 999 | } |
Mark Salyzyn | 4ba0387 | 2014-04-07 07:15:33 -0700 | [diff] [blame] | 1000 | |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 1001 | namespace android { |
| 1002 | |
| 1003 | uid_t pidToUid(pid_t pid) { |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 1004 | char buffer[512]; |
| 1005 | snprintf(buffer, sizeof(buffer), "/proc/%u/status", pid); |
Tom Cherry | 9b4246d | 2020-06-17 11:40:55 -0700 | [diff] [blame] | 1006 | FILE* fp = fopen(buffer, "re"); |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 1007 | if (fp) { |
| 1008 | while (fgets(buffer, sizeof(buffer), fp)) { |
Mark Salyzyn | c4e4823 | 2017-05-04 13:54:46 -0700 | [diff] [blame] | 1009 | int uid = AID_LOGD; |
| 1010 | char space = 0; |
| 1011 | if ((sscanf(buffer, "Uid: %d%c", &uid, &space) == 2) && |
| 1012 | isspace(space)) { |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 1013 | fclose(fp); |
| 1014 | return uid; |
Mark Salyzyn | 4ba0387 | 2014-04-07 07:15:33 -0700 | [diff] [blame] | 1015 | } |
| 1016 | } |
Mark Salyzyn | 97c1c2b | 2015-03-10 13:51:35 -0700 | [diff] [blame] | 1017 | fclose(fp); |
Mark Salyzyn | 4ba0387 | 2014-04-07 07:15:33 -0700 | [diff] [blame] | 1018 | } |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 1019 | return AID_LOGD; // associate this with the logger |
Mark Salyzyn | 4ba0387 | 2014-04-07 07:15:33 -0700 | [diff] [blame] | 1020 | } |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 1021 | } |
| 1022 | |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 1023 | uid_t LogStatistics::PidToUid(pid_t pid) { |
| 1024 | auto lock = std::lock_guard{lock_}; |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 1025 | return pidTable.Add(pid)->second.uid(); |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 1026 | } |
| 1027 | |
| 1028 | // caller must free character string |
Tom Cherry | 64e9016 | 2020-05-07 14:44:43 -0700 | [diff] [blame] | 1029 | const char* LogStatistics::PidToName(pid_t pid) const { |
| 1030 | auto lock = std::lock_guard{lock_}; |
Mark Salyzyn | 758058f | 2015-08-21 16:44:30 -0700 | [diff] [blame] | 1031 | // An inconvenient truth ... getName() can alter the object |
Mark Salyzyn | 501c373 | 2017-03-10 14:31:54 -0800 | [diff] [blame] | 1032 | pidTable_t& writablePidTable = const_cast<pidTable_t&>(pidTable); |
Tom Cherry | 9787f9a | 2020-05-19 19:01:16 -0700 | [diff] [blame] | 1033 | const char* name = writablePidTable.Add(pid)->second.name(); |
Mark Salyzyn | 81b3eab | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 1034 | if (!name) { |
Yi Kong | c8d09dd | 2018-07-13 17:39:22 -0700 | [diff] [blame] | 1035 | return nullptr; |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 1036 | } |
Mark Salyzyn | 81b3eab | 2015-04-13 14:24:45 -0700 | [diff] [blame] | 1037 | return strdup(name); |
Mark Salyzyn | 720f6d1 | 2015-03-16 08:26:05 -0700 | [diff] [blame] | 1038 | } |