Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 1 | /* |
| 2 | * Copyright (C) 2017 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 | |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 17 | #define DEBUG false // STOPSHIP if true |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 18 | #include "Log.h" |
tsaichristine | d21aacf | 2019-10-07 14:47:38 -0700 | [diff] [blame] | 19 | |
| 20 | #include "StatsLogProcessor.h" |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 21 | |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 22 | #include <android-base/file.h> |
| 23 | #include <dirent.h> |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 24 | #include <frameworks/base/cmds/statsd/src/active_config_list.pb.h> |
tsaichristine | d21aacf | 2019-10-07 14:47:38 -0700 | [diff] [blame] | 25 | #include <log/log_event_list.h> |
| 26 | #include <utils/Errors.h> |
| 27 | #include <utils/SystemClock.h> |
| 28 | |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 29 | #include "android-base/stringprintf.h" |
Muhammad Qureshi | c8e2266 | 2019-11-20 17:18:03 -0800 | [diff] [blame^] | 30 | #include "atoms_info.h" |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 31 | #include "external/StatsPullerManager.h" |
Yao Chen | b356151 | 2017-11-21 18:07:17 -0800 | [diff] [blame] | 32 | #include "guardrail/StatsdStats.h" |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 33 | #include "metrics/CountMetricProducer.h" |
tsaichristine | d21aacf | 2019-10-07 14:47:38 -0700 | [diff] [blame] | 34 | #include "state/StateManager.h" |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 35 | #include "stats_log_util.h" |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 36 | #include "stats_util.h" |
tsaichristine | d21aacf | 2019-10-07 14:47:38 -0700 | [diff] [blame] | 37 | #include "statslog.h" |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 38 | #include "storage/StorageManager.h" |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 39 | |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 40 | using namespace android; |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 41 | using android::base::StringPrintf; |
yro | b0378b0 | 2017-11-09 20:36:25 -0800 | [diff] [blame] | 42 | using android::util::FIELD_COUNT_REPEATED; |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 43 | using android::util::FIELD_TYPE_BOOL; |
| 44 | using android::util::FIELD_TYPE_FLOAT; |
| 45 | using android::util::FIELD_TYPE_INT32; |
| 46 | using android::util::FIELD_TYPE_INT64; |
| 47 | using android::util::FIELD_TYPE_MESSAGE; |
| 48 | using android::util::FIELD_TYPE_STRING; |
| 49 | using android::util::ProtoOutputStream; |
Yao Chen | 44cf27c | 2017-09-14 22:32:50 -0700 | [diff] [blame] | 50 | using std::make_unique; |
| 51 | using std::unique_ptr; |
| 52 | using std::vector; |
Bookatz | 906a35c | 2017-09-20 15:26:44 -0700 | [diff] [blame] | 53 | |
| 54 | namespace android { |
| 55 | namespace os { |
| 56 | namespace statsd { |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 57 | |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 58 | // for ConfigMetricsReportList |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 59 | const int FIELD_ID_CONFIG_KEY = 1; |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 60 | const int FIELD_ID_REPORTS = 2; |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 61 | // for ConfigKey |
| 62 | const int FIELD_ID_UID = 1; |
Yangster-mac | 94e197c | 2018-01-02 16:03:03 -0800 | [diff] [blame] | 63 | const int FIELD_ID_ID = 2; |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 64 | // for ConfigMetricsReport |
Yao Chen | 4c959cb | 2018-02-13 13:27:48 -0800 | [diff] [blame] | 65 | // const int FIELD_ID_METRICS = 1; // written in MetricsManager.cpp |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 66 | const int FIELD_ID_UID_MAP = 2; |
Yangster-mac | 330af58 | 2018-02-08 15:24:38 -0800 | [diff] [blame] | 67 | const int FIELD_ID_LAST_REPORT_ELAPSED_NANOS = 3; |
| 68 | const int FIELD_ID_CURRENT_REPORT_ELAPSED_NANOS = 4; |
Yangster-mac | 3fa5d7f | 2018-03-10 21:50:27 -0800 | [diff] [blame] | 69 | const int FIELD_ID_LAST_REPORT_WALL_CLOCK_NANOS = 5; |
| 70 | const int FIELD_ID_CURRENT_REPORT_WALL_CLOCK_NANOS = 6; |
Chenjie Yu | e36018b | 2018-04-16 15:18:30 -0700 | [diff] [blame] | 71 | const int FIELD_ID_DUMP_REPORT_REASON = 8; |
Yangster-mac | 9def8e3 | 2018-04-17 13:55:51 -0700 | [diff] [blame] | 72 | const int FIELD_ID_STRINGS = 9; |
Yangster-mac | 3fa5d7f | 2018-03-10 21:50:27 -0800 | [diff] [blame] | 73 | |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 74 | // for ActiveConfigList |
| 75 | const int FIELD_ID_ACTIVE_CONFIG_LIST_CONFIG = 1; |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 76 | |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 77 | #define NS_PER_HOUR 3600 * NS_PER_SEC |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 78 | |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 79 | #define STATS_ACTIVE_METRIC_DIR "/data/misc/stats-active-metric" |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 80 | |
Tej Singh | 42f9e06 | 2018-11-09 10:01:00 -0800 | [diff] [blame] | 81 | // Cool down period for writing data to disk to avoid overwriting files. |
| 82 | #define WRITE_DATA_COOL_DOWN_SEC 5 |
| 83 | |
yro | 31eb67b | 2017-10-24 13:33:21 -0700 | [diff] [blame] | 84 | StatsLogProcessor::StatsLogProcessor(const sp<UidMap>& uidMap, |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 85 | const sp<StatsPullerManager>& pullerManager, |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 86 | const sp<AlarmMonitor>& anomalyAlarmMonitor, |
| 87 | const sp<AlarmMonitor>& periodicAlarmMonitor, |
Yangster-mac | 15f6bbc | 2018-04-08 11:52:26 -0700 | [diff] [blame] | 88 | const int64_t timeBaseNs, |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 89 | const std::function<bool(const ConfigKey&)>& sendBroadcast, |
| 90 | const std::function<bool( |
| 91 | const int&, const vector<int64_t>&)>& activateBroadcast) |
Chenjie Yu | 85ed838 | 2017-12-14 16:48:54 -0800 | [diff] [blame] | 92 | : mUidMap(uidMap), |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 93 | mPullerManager(pullerManager), |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 94 | mAnomalyAlarmMonitor(anomalyAlarmMonitor), |
| 95 | mPeriodicAlarmMonitor(periodicAlarmMonitor), |
Chenjie Yu | 85ed838 | 2017-12-14 16:48:54 -0800 | [diff] [blame] | 96 | mSendBroadcast(sendBroadcast), |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 97 | mSendActivationBroadcast(activateBroadcast), |
Yangster-mac | 15f6bbc | 2018-04-08 11:52:26 -0700 | [diff] [blame] | 98 | mTimeBaseNs(timeBaseNs), |
Yao Chen | 163d260 | 2018-04-10 10:39:53 -0700 | [diff] [blame] | 99 | mLargestTimestampSeen(0), |
| 100 | mLastTimestampSeen(0) { |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 101 | mPullerManager->ForceClearPullerCache(); |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 102 | } |
| 103 | |
Yao Chen | ef99c4f | 2017-09-22 16:26:54 -0700 | [diff] [blame] | 104 | StatsLogProcessor::~StatsLogProcessor() { |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 105 | } |
| 106 | |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 107 | static void flushProtoToBuffer(ProtoOutputStream& proto, vector<uint8_t>* outData) { |
| 108 | outData->clear(); |
| 109 | outData->resize(proto.size()); |
| 110 | size_t pos = 0; |
| 111 | sp<android::util::ProtoReader> reader = proto.data(); |
| 112 | while (reader->readBuffer() != NULL) { |
| 113 | size_t toRead = reader->currentToRead(); |
| 114 | std::memcpy(&((*outData)[pos]), reader->readBuffer(), toRead); |
| 115 | pos += toRead; |
| 116 | reader->move(toRead); |
| 117 | } |
| 118 | } |
| 119 | |
Yangster-mac | e2cd6d5 | 2017-11-09 20:38:30 -0800 | [diff] [blame] | 120 | void StatsLogProcessor::onAnomalyAlarmFired( |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 121 | const int64_t& timestampNs, |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 122 | unordered_set<sp<const InternalAlarm>, SpHash<InternalAlarm>> alarmSet) { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 123 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Bookatz | cc5adef2 | 2017-11-21 14:36:23 -0800 | [diff] [blame] | 124 | for (const auto& itr : mMetricsManagers) { |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 125 | itr.second->onAnomalyAlarmFired(timestampNs, alarmSet); |
| 126 | } |
| 127 | } |
| 128 | void StatsLogProcessor::onPeriodicAlarmFired( |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 129 | const int64_t& timestampNs, |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 130 | unordered_set<sp<const InternalAlarm>, SpHash<InternalAlarm>> alarmSet) { |
| 131 | |
| 132 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 133 | for (const auto& itr : mMetricsManagers) { |
| 134 | itr.second->onPeriodicAlarmFired(timestampNs, alarmSet); |
Yangster-mac | e2cd6d5 | 2017-11-09 20:38:30 -0800 | [diff] [blame] | 135 | } |
| 136 | } |
| 137 | |
Yao Chen | 8a8d16c | 2018-02-08 14:50:40 -0800 | [diff] [blame] | 138 | void updateUid(Value* value, int hostUid) { |
| 139 | int uid = value->int_value; |
| 140 | if (uid != hostUid) { |
| 141 | value->setInt(hostUid); |
| 142 | } |
| 143 | } |
| 144 | |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 145 | void StatsLogProcessor::mapIsolatedUidToHostUidIfNecessaryLocked(LogEvent* event) const { |
Yao Chen | c40a19d | 2018-03-15 16:48:25 -0700 | [diff] [blame] | 146 | if (android::util::AtomsInfo::kAtomsWithAttributionChain.find(event->GetTagId()) != |
| 147 | android::util::AtomsInfo::kAtomsWithAttributionChain.end()) { |
Yao Chen | 8a8d16c | 2018-02-08 14:50:40 -0800 | [diff] [blame] | 148 | for (auto& value : *(event->getMutableValues())) { |
| 149 | if (value.mField.getPosAtDepth(0) > kAttributionField) { |
| 150 | break; |
| 151 | } |
| 152 | if (isAttributionUidField(value)) { |
| 153 | const int hostUid = mUidMap->getHostUidOrSelf(value.mValue.int_value); |
| 154 | updateUid(&value.mValue, hostUid); |
| 155 | } |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 156 | } |
Yao Chen | c40a19d | 2018-03-15 16:48:25 -0700 | [diff] [blame] | 157 | } else { |
| 158 | auto it = android::util::AtomsInfo::kAtomsWithUidField.find(event->GetTagId()); |
| 159 | if (it != android::util::AtomsInfo::kAtomsWithUidField.end()) { |
| 160 | int uidField = it->second; // uidField is the field number in proto, |
| 161 | // starting from 1 |
| 162 | if (uidField > 0 && (int)event->getValues().size() >= uidField && |
| 163 | (event->getValues())[uidField - 1].mValue.getType() == INT) { |
| 164 | Value& value = (*event->getMutableValues())[uidField - 1].mValue; |
| 165 | const int hostUid = mUidMap->getHostUidOrSelf(value.int_value); |
| 166 | updateUid(&value, hostUid); |
| 167 | } else { |
| 168 | ALOGE("Malformed log, uid not found. %s", event->ToString().c_str()); |
| 169 | } |
| 170 | } |
Yao Chen | 312e898 | 2017-12-05 15:29:03 -0800 | [diff] [blame] | 171 | } |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 172 | } |
| 173 | |
| 174 | void StatsLogProcessor::onIsolatedUidChangedEventLocked(const LogEvent& event) { |
| 175 | status_t err = NO_ERROR, err2 = NO_ERROR, err3 = NO_ERROR; |
| 176 | bool is_create = event.GetBool(3, &err); |
| 177 | auto parent_uid = int(event.GetLong(1, &err2)); |
| 178 | auto isolated_uid = int(event.GetLong(2, &err3)); |
| 179 | if (err == NO_ERROR && err2 == NO_ERROR && err3 == NO_ERROR) { |
| 180 | if (is_create) { |
| 181 | mUidMap->assignIsolatedUid(isolated_uid, parent_uid); |
| 182 | } else { |
Bookatz | 3c64886 | 2018-05-25 13:32:43 -0700 | [diff] [blame] | 183 | mUidMap->removeIsolatedUid(isolated_uid); |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 184 | } |
| 185 | } else { |
| 186 | ALOGE("Failed to parse uid in the isolated uid change event."); |
| 187 | } |
| 188 | } |
| 189 | |
Yangster-mac | 892f3d3 | 2018-05-02 14:16:48 -0700 | [diff] [blame] | 190 | void StatsLogProcessor::resetConfigs() { |
| 191 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 192 | resetConfigsLocked(getElapsedRealtimeNs()); |
| 193 | } |
| 194 | |
| 195 | void StatsLogProcessor::resetConfigsLocked(const int64_t timestampNs) { |
| 196 | std::vector<ConfigKey> configKeys; |
| 197 | for (auto it = mMetricsManagers.begin(); it != mMetricsManagers.end(); it++) { |
| 198 | configKeys.push_back(it->first); |
| 199 | } |
| 200 | resetConfigsLocked(timestampNs, configKeys); |
| 201 | } |
| 202 | |
Yao Chen | 3ff3a49 | 2018-08-06 16:17:37 -0700 | [diff] [blame] | 203 | void StatsLogProcessor::OnLogEvent(LogEvent* event) { |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 204 | OnLogEvent(event, getElapsedRealtimeNs()); |
| 205 | } |
| 206 | |
| 207 | void StatsLogProcessor::OnLogEvent(LogEvent* event, int64_t elapsedRealtimeNs) { |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 208 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Yao Chen | 876889c | 2018-05-02 11:16:16 -0700 | [diff] [blame] | 209 | |
| 210 | #ifdef VERY_VERBOSE_PRINTING |
| 211 | if (mPrintAllLogs) { |
| 212 | ALOGI("%s", event->ToString().c_str()); |
| 213 | } |
| 214 | #endif |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 215 | const int64_t eventElapsedTimeNs = event->GetElapsedTimestampNs(); |
Yangster-mac | b8382a1 | 2018-04-04 10:39:12 -0700 | [diff] [blame] | 216 | |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 217 | resetIfConfigTtlExpiredLocked(eventElapsedTimeNs); |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 218 | |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 219 | StatsdStats::getInstance().noteAtomLogged( |
Yangster-mac | 330af58 | 2018-02-08 15:24:38 -0800 | [diff] [blame] | 220 | event->GetTagId(), event->GetElapsedTimestampNs() / NS_PER_SEC); |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 221 | |
David Chen | 2158296 | 2017-11-01 17:32:46 -0700 | [diff] [blame] | 222 | // Hard-coded logic to update the isolated uid's in the uid-map. |
Stefan Lafon | ae2df01 | 2017-11-14 09:17:21 -0800 | [diff] [blame] | 223 | // The field numbers need to be currently updated by hand with atoms.proto |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 224 | if (event->GetTagId() == android::util::ISOLATED_UID_CHANGED) { |
| 225 | onIsolatedUidChangedEventLocked(*event); |
David Chen | cfc311d | 2018-01-23 17:55:54 -0800 | [diff] [blame] | 226 | } |
| 227 | |
tsaichristine | d21aacf | 2019-10-07 14:47:38 -0700 | [diff] [blame] | 228 | StateManager::getInstance().onLogEvent(*event); |
| 229 | |
David Chen | cfc311d | 2018-01-23 17:55:54 -0800 | [diff] [blame] | 230 | if (mMetricsManagers.empty()) { |
| 231 | return; |
| 232 | } |
| 233 | |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 234 | int64_t curTimeSec = getElapsedRealtimeSec(); |
Yangster-mac | 330af58 | 2018-02-08 15:24:38 -0800 | [diff] [blame] | 235 | if (curTimeSec - mLastPullerCacheClearTimeSec > StatsdStats::kPullerCacheClearIntervalSec) { |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 236 | mPullerManager->ClearPullerCacheIfNecessary(curTimeSec * NS_PER_SEC); |
Yangster-mac | 330af58 | 2018-02-08 15:24:38 -0800 | [diff] [blame] | 237 | mLastPullerCacheClearTimeSec = curTimeSec; |
Chenjie Yu | fa22d65 | 2018-02-05 14:37:48 -0800 | [diff] [blame] | 238 | } |
| 239 | |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 240 | |
David Chen | cfc311d | 2018-01-23 17:55:54 -0800 | [diff] [blame] | 241 | if (event->GetTagId() != android::util::ISOLATED_UID_CHANGED) { |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 242 | // Map the isolated uid to host uid if necessary. |
| 243 | mapIsolatedUidToHostUidIfNecessaryLocked(event); |
| 244 | } |
| 245 | |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 246 | std::unordered_set<int> uidsWithActiveConfigsChanged; |
| 247 | std::unordered_map<int, std::vector<int64_t>> activeConfigsPerUid; |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 248 | // pass the event to metrics managers. |
| 249 | for (auto& pair : mMetricsManagers) { |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 250 | int uid = pair.first.GetUid(); |
| 251 | int64_t configId = pair.first.GetId(); |
| 252 | bool isPrevActive = pair.second->isActive(); |
Yangster-mac | d40053e | 2018-01-09 16:29:22 -0800 | [diff] [blame] | 253 | pair.second->onLogEvent(*event); |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 254 | bool isCurActive = pair.second->isActive(); |
| 255 | // Map all active configs by uid. |
| 256 | if (isCurActive) { |
| 257 | auto activeConfigs = activeConfigsPerUid.find(uid); |
| 258 | if (activeConfigs != activeConfigsPerUid.end()) { |
| 259 | activeConfigs->second.push_back(configId); |
| 260 | } else { |
| 261 | vector<int64_t> newActiveConfigs; |
| 262 | newActiveConfigs.push_back(configId); |
| 263 | activeConfigsPerUid[uid] = newActiveConfigs; |
| 264 | } |
| 265 | } |
| 266 | // The activation state of this config changed. |
| 267 | if (isPrevActive != isCurActive) { |
| 268 | VLOG("Active status changed for uid %d", uid); |
| 269 | uidsWithActiveConfigsChanged.insert(uid); |
| 270 | StatsdStats::getInstance().noteActiveStatusChanged(pair.first, isCurActive); |
| 271 | } |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 272 | flushIfNecessaryLocked(pair.first, *(pair.second)); |
David Chen | 2158296 | 2017-11-01 17:32:46 -0700 | [diff] [blame] | 273 | } |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 274 | |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 275 | // Don't use the event timestamp for the guardrail. |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 276 | for (int uid : uidsWithActiveConfigsChanged) { |
| 277 | // Send broadcast so that receivers can pull data. |
| 278 | auto lastBroadcastTime = mLastActivationBroadcastTimes.find(uid); |
| 279 | if (lastBroadcastTime != mLastActivationBroadcastTimes.end()) { |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 280 | if (elapsedRealtimeNs - lastBroadcastTime->second < |
| 281 | StatsdStats::kMinActivationBroadcastPeriodNs) { |
Tej Singh | 16ca28f | 2019-06-24 11:58:23 -0700 | [diff] [blame] | 282 | StatsdStats::getInstance().noteActivationBroadcastGuardrailHit(uid); |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 283 | VLOG("StatsD would've sent an activation broadcast but the rate limit stopped us."); |
| 284 | return; |
| 285 | } |
| 286 | } |
| 287 | auto activeConfigs = activeConfigsPerUid.find(uid); |
| 288 | if (activeConfigs != activeConfigsPerUid.end()) { |
| 289 | if (mSendActivationBroadcast(uid, activeConfigs->second)) { |
| 290 | VLOG("StatsD sent activation notice for uid %d", uid); |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 291 | mLastActivationBroadcastTimes[uid] = elapsedRealtimeNs; |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 292 | } |
| 293 | } else { |
| 294 | std::vector<int64_t> emptyActiveConfigs; |
| 295 | if (mSendActivationBroadcast(uid, emptyActiveConfigs)) { |
| 296 | VLOG("StatsD sent EMPTY activation notice for uid %d", uid); |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 297 | mLastActivationBroadcastTimes[uid] = elapsedRealtimeNs; |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 298 | } |
| 299 | } |
| 300 | } |
| 301 | } |
| 302 | |
| 303 | void StatsLogProcessor::GetActiveConfigs(const int uid, vector<int64_t>& outActiveConfigs) { |
| 304 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 305 | GetActiveConfigsLocked(uid, outActiveConfigs); |
| 306 | } |
| 307 | |
| 308 | void StatsLogProcessor::GetActiveConfigsLocked(const int uid, vector<int64_t>& outActiveConfigs) { |
| 309 | outActiveConfigs.clear(); |
| 310 | for (auto& pair : mMetricsManagers) { |
| 311 | if (pair.first.GetUid() == uid && pair.second->isActive()) { |
| 312 | outActiveConfigs.push_back(pair.first.GetId()); |
| 313 | } |
| 314 | } |
Yao Chen | ab273e2 | 2017-09-06 12:53:50 -0700 | [diff] [blame] | 315 | } |
| 316 | |
Yangster-mac | c04feba | 2018-04-02 14:37:33 -0700 | [diff] [blame] | 317 | void StatsLogProcessor::OnConfigUpdated(const int64_t timestampNs, const ConfigKey& key, |
| 318 | const StatsdConfig& config) { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 319 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 320 | WriteDataToDiskLocked(key, timestampNs, CONFIG_UPDATED, NO_TIME_CONSTRAINTS); |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 321 | OnConfigUpdatedLocked(timestampNs, key, config); |
| 322 | } |
| 323 | |
| 324 | void StatsLogProcessor::OnConfigUpdatedLocked( |
| 325 | const int64_t timestampNs, const ConfigKey& key, const StatsdConfig& config) { |
Tej Singh | 484524a | 2018-02-01 15:10:05 -0800 | [diff] [blame] | 326 | VLOG("Updated configuration for key %s", key.ToString().c_str()); |
Yangster-mac | 932ecec | 2018-02-01 10:23:52 -0800 | [diff] [blame] | 327 | sp<MetricsManager> newMetricsManager = |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 328 | new MetricsManager(key, config, mTimeBaseNs, timestampNs, mUidMap, mPullerManager, |
| 329 | mAnomalyAlarmMonitor, mPeriodicAlarmMonitor); |
Yao Chen | caf339d | 2017-10-06 16:01:10 -0700 | [diff] [blame] | 330 | if (newMetricsManager->isConfigValid()) { |
David Chen | d689689 | 2017-10-25 11:49:03 -0700 | [diff] [blame] | 331 | mUidMap->OnConfigUpdated(key); |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 332 | newMetricsManager->refreshTtl(timestampNs); |
Yao Chen | d10f7b1 | 2017-12-18 12:53:50 -0800 | [diff] [blame] | 333 | mMetricsManagers[key] = newMetricsManager; |
Yao Chen | b356151 | 2017-11-21 18:07:17 -0800 | [diff] [blame] | 334 | VLOG("StatsdConfig valid"); |
Yao Chen | caf339d | 2017-10-06 16:01:10 -0700 | [diff] [blame] | 335 | } else { |
| 336 | // If there is any error in the config, don't use it. |
Yao Chen | b356151 | 2017-11-21 18:07:17 -0800 | [diff] [blame] | 337 | ALOGE("StatsdConfig NOT valid"); |
Yao Chen | caf339d | 2017-10-06 16:01:10 -0700 | [diff] [blame] | 338 | } |
yro | 00698da | 2017-09-15 10:06:40 -0700 | [diff] [blame] | 339 | } |
Bookatz | 906a35c | 2017-09-20 15:26:44 -0700 | [diff] [blame] | 340 | |
Yangster | 7c334a1 | 2017-11-22 14:24:24 -0800 | [diff] [blame] | 341 | size_t StatsLogProcessor::GetMetricsSize(const ConfigKey& key) const { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 342 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Yao Chen | 729093d | 2017-10-16 10:33:26 -0700 | [diff] [blame] | 343 | auto it = mMetricsManagers.find(key); |
| 344 | if (it == mMetricsManagers.end()) { |
| 345 | ALOGW("Config source %s does not exist", key.ToString().c_str()); |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 346 | return 0; |
Yao Chen | 729093d | 2017-10-16 10:33:26 -0700 | [diff] [blame] | 347 | } |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 348 | return it->second->byteSize(); |
| 349 | } |
| 350 | |
Yao Chen | a80e5c0 | 2018-09-04 13:55:29 -0700 | [diff] [blame] | 351 | void StatsLogProcessor::dumpStates(int out, bool verbose) { |
Yao Chen | 884c8c1 | 2018-01-26 10:36:25 -0800 | [diff] [blame] | 352 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Yao Chen | a80e5c0 | 2018-09-04 13:55:29 -0700 | [diff] [blame] | 353 | FILE* fout = fdopen(out, "w"); |
| 354 | if (fout == NULL) { |
| 355 | return; |
Yao Chen | 884c8c1 | 2018-01-26 10:36:25 -0800 | [diff] [blame] | 356 | } |
Yao Chen | a80e5c0 | 2018-09-04 13:55:29 -0700 | [diff] [blame] | 357 | fprintf(fout, "MetricsManager count: %lu\n", (unsigned long)mMetricsManagers.size()); |
| 358 | for (auto metricsManager : mMetricsManagers) { |
| 359 | metricsManager.second->dumpStates(fout, verbose); |
| 360 | } |
| 361 | |
| 362 | fclose(fout); |
Yao Chen | 884c8c1 | 2018-01-26 10:36:25 -0800 | [diff] [blame] | 363 | } |
| 364 | |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 365 | /* |
Bookatz | 9cc7b66 | 2018-11-06 10:39:21 -0800 | [diff] [blame] | 366 | * onDumpReport dumps serialized ConfigMetricsReportList into proto. |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 367 | */ |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 368 | void StatsLogProcessor::onDumpReport(const ConfigKey& key, const int64_t dumpTimeStampNs, |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 369 | const bool include_current_partial_bucket, |
Bookatz | ff71cad | 2018-09-20 17:17:49 -0700 | [diff] [blame] | 370 | const bool erase_data, |
Chenjie Yu | e36018b | 2018-04-16 15:18:30 -0700 | [diff] [blame] | 371 | const DumpReportReason dumpReportReason, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 372 | const DumpLatency dumpLatency, |
Bookatz | ff71cad | 2018-09-20 17:17:49 -0700 | [diff] [blame] | 373 | ProtoOutputStream* proto) { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 374 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Yangster-mac | 2087716 | 2017-12-22 17:19:39 -0800 | [diff] [blame] | 375 | |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 376 | // Start of ConfigKey. |
Bookatz | ff71cad | 2018-09-20 17:17:49 -0700 | [diff] [blame] | 377 | uint64_t configKeyToken = proto->start(FIELD_TYPE_MESSAGE | FIELD_ID_CONFIG_KEY); |
| 378 | proto->write(FIELD_TYPE_INT32 | FIELD_ID_UID, key.GetUid()); |
| 379 | proto->write(FIELD_TYPE_INT64 | FIELD_ID_ID, (long long)key.GetId()); |
| 380 | proto->end(configKeyToken); |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 381 | // End of ConfigKey. |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 382 | |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 383 | bool keepFile = false; |
| 384 | auto it = mMetricsManagers.find(key); |
| 385 | if (it != mMetricsManagers.end() && it->second->shouldPersistLocalHistory()) { |
| 386 | keepFile = true; |
| 387 | } |
| 388 | |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 389 | // Then, check stats-data directory to see there's any file containing |
| 390 | // ConfigMetricsReport from previous shutdowns to concatenate to reports. |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 391 | StorageManager::appendConfigMetricsReport( |
| 392 | key, proto, erase_data && !keepFile /* should remove file after appending it */, |
| 393 | dumpReportReason == ADB_DUMP /*if caller is adb*/); |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 394 | |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 395 | if (it != mMetricsManagers.end()) { |
| 396 | // This allows another broadcast to be sent within the rate-limit period if we get close to |
| 397 | // filling the buffer again soon. |
| 398 | mLastBroadcastTimes.erase(key); |
| 399 | |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 400 | vector<uint8_t> buffer; |
| 401 | onConfigMetricsReportLocked(key, dumpTimeStampNs, include_current_partial_bucket, |
| 402 | erase_data, dumpReportReason, dumpLatency, |
| 403 | false /* is this data going to be saved on disk */, &buffer); |
| 404 | proto->write(FIELD_TYPE_MESSAGE | FIELD_COUNT_REPEATED | FIELD_ID_REPORTS, |
| 405 | reinterpret_cast<char*>(buffer.data()), buffer.size()); |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 406 | } else { |
| 407 | ALOGW("Config source %s does not exist", key.ToString().c_str()); |
| 408 | } |
Bookatz | ff71cad | 2018-09-20 17:17:49 -0700 | [diff] [blame] | 409 | } |
| 410 | |
| 411 | /* |
| 412 | * onDumpReport dumps serialized ConfigMetricsReportList into outData. |
| 413 | */ |
| 414 | void StatsLogProcessor::onDumpReport(const ConfigKey& key, const int64_t dumpTimeStampNs, |
| 415 | const bool include_current_partial_bucket, |
| 416 | const bool erase_data, |
| 417 | const DumpReportReason dumpReportReason, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 418 | const DumpLatency dumpLatency, |
Bookatz | ff71cad | 2018-09-20 17:17:49 -0700 | [diff] [blame] | 419 | vector<uint8_t>* outData) { |
| 420 | ProtoOutputStream proto; |
| 421 | onDumpReport(key, dumpTimeStampNs, include_current_partial_bucket, erase_data, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 422 | dumpReportReason, dumpLatency, &proto); |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 423 | |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 424 | if (outData != nullptr) { |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 425 | flushProtoToBuffer(proto, outData); |
| 426 | VLOG("output data size %zu", outData->size()); |
yro | 17adac9 | 2017-11-08 23:16:29 -0800 | [diff] [blame] | 427 | } |
Yao Chen | 8a8d16c | 2018-02-08 14:50:40 -0800 | [diff] [blame] | 428 | |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 429 | StatsdStats::getInstance().noteMetricsReportSent(key, proto.size()); |
Yao Chen | 729093d | 2017-10-16 10:33:26 -0700 | [diff] [blame] | 430 | } |
| 431 | |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 432 | /* |
| 433 | * onConfigMetricsReportLocked dumps serialized ConfigMetricsReport into outData. |
| 434 | */ |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 435 | void StatsLogProcessor::onConfigMetricsReportLocked( |
| 436 | const ConfigKey& key, const int64_t dumpTimeStampNs, |
| 437 | const bool include_current_partial_bucket, const bool erase_data, |
| 438 | const DumpReportReason dumpReportReason, const DumpLatency dumpLatency, |
| 439 | const bool dataSavedOnDisk, vector<uint8_t>* buffer) { |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 440 | // We already checked whether key exists in mMetricsManagers in |
| 441 | // WriteDataToDisk. |
| 442 | auto it = mMetricsManagers.find(key); |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 443 | if (it == mMetricsManagers.end()) { |
| 444 | return; |
| 445 | } |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 446 | int64_t lastReportTimeNs = it->second->getLastReportTimeNs(); |
| 447 | int64_t lastReportWallClockNs = it->second->getLastReportWallClockNs(); |
| 448 | |
Yangster-mac | 9def8e3 | 2018-04-17 13:55:51 -0700 | [diff] [blame] | 449 | std::set<string> str_set; |
| 450 | |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 451 | ProtoOutputStream tempProto; |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 452 | // First, fill in ConfigMetricsReport using current data on memory, which |
| 453 | // starts from filling in StatsLogReport's. |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 454 | it->second->onDumpReport(dumpTimeStampNs, include_current_partial_bucket, erase_data, |
| 455 | dumpLatency, &str_set, &tempProto); |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 456 | |
David Chen | 9e6dbbd | 2018-05-07 17:52:29 -0700 | [diff] [blame] | 457 | // Fill in UidMap if there is at least one metric to report. |
| 458 | // This skips the uid map if it's an empty config. |
| 459 | if (it->second->getNumMetrics() > 0) { |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 460 | uint64_t uidMapToken = tempProto.start(FIELD_TYPE_MESSAGE | FIELD_ID_UID_MAP); |
dwchen | 730403e | 2018-10-29 11:41:56 -0700 | [diff] [blame] | 461 | mUidMap->appendUidMap( |
| 462 | dumpTimeStampNs, key, it->second->hashStringInReport() ? &str_set : nullptr, |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 463 | it->second->versionStringsInReport(), it->second->installerInReport(), &tempProto); |
| 464 | tempProto.end(uidMapToken); |
David Chen | 9e6dbbd | 2018-05-07 17:52:29 -0700 | [diff] [blame] | 465 | } |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 466 | |
| 467 | // Fill in the timestamps. |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 468 | tempProto.write(FIELD_TYPE_INT64 | FIELD_ID_LAST_REPORT_ELAPSED_NANOS, |
| 469 | (long long)lastReportTimeNs); |
| 470 | tempProto.write(FIELD_TYPE_INT64 | FIELD_ID_CURRENT_REPORT_ELAPSED_NANOS, |
| 471 | (long long)dumpTimeStampNs); |
| 472 | tempProto.write(FIELD_TYPE_INT64 | FIELD_ID_LAST_REPORT_WALL_CLOCK_NANOS, |
| 473 | (long long)lastReportWallClockNs); |
| 474 | tempProto.write(FIELD_TYPE_INT64 | FIELD_ID_CURRENT_REPORT_WALL_CLOCK_NANOS, |
| 475 | (long long)getWallClockNs()); |
Chenjie Yu | e36018b | 2018-04-16 15:18:30 -0700 | [diff] [blame] | 476 | // Dump report reason |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 477 | tempProto.write(FIELD_TYPE_INT32 | FIELD_ID_DUMP_REPORT_REASON, dumpReportReason); |
Yangster-mac | 9def8e3 | 2018-04-17 13:55:51 -0700 | [diff] [blame] | 478 | |
David Chen | 56ae0d9 | 2018-05-11 16:00:22 -0700 | [diff] [blame] | 479 | for (const auto& str : str_set) { |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 480 | tempProto.write(FIELD_TYPE_STRING | FIELD_COUNT_REPEATED | FIELD_ID_STRINGS, str); |
| 481 | } |
| 482 | |
| 483 | flushProtoToBuffer(tempProto, buffer); |
| 484 | |
| 485 | // save buffer to disk if needed |
| 486 | if (erase_data && !dataSavedOnDisk && it->second->shouldPersistLocalHistory()) { |
| 487 | VLOG("save history to disk"); |
| 488 | string file_name = StorageManager::getDataHistoryFileName((long)getWallClockSec(), |
| 489 | key.GetUid(), key.GetId()); |
| 490 | StorageManager::writeFile(file_name.c_str(), buffer->data(), buffer->size()); |
Yangster-mac | 9def8e3 | 2018-04-17 13:55:51 -0700 | [diff] [blame] | 491 | } |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 492 | } |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 493 | |
Yao Chen | 163d260 | 2018-04-10 10:39:53 -0700 | [diff] [blame] | 494 | void StatsLogProcessor::resetConfigsLocked(const int64_t timestampNs, |
| 495 | const std::vector<ConfigKey>& configs) { |
| 496 | for (const auto& key : configs) { |
Yangster-mac | b142cc8 | 2018-03-30 15:22:08 -0700 | [diff] [blame] | 497 | StatsdConfig config; |
| 498 | if (StorageManager::readConfigFromDisk(key, &config)) { |
| 499 | OnConfigUpdatedLocked(timestampNs, key, config); |
| 500 | StatsdStats::getInstance().noteConfigReset(key); |
| 501 | } else { |
| 502 | ALOGE("Failed to read backup config from disk for : %s", key.ToString().c_str()); |
| 503 | auto it = mMetricsManagers.find(key); |
| 504 | if (it != mMetricsManagers.end()) { |
| 505 | it->second->refreshTtl(timestampNs); |
| 506 | } |
| 507 | } |
| 508 | } |
yro | 4beccbe | 2018-03-15 19:42:05 -0700 | [diff] [blame] | 509 | } |
| 510 | |
Yao Chen | 163d260 | 2018-04-10 10:39:53 -0700 | [diff] [blame] | 511 | void StatsLogProcessor::resetIfConfigTtlExpiredLocked(const int64_t timestampNs) { |
| 512 | std::vector<ConfigKey> configKeysTtlExpired; |
| 513 | for (auto it = mMetricsManagers.begin(); it != mMetricsManagers.end(); it++) { |
| 514 | if (it->second != nullptr && !it->second->isInTtl(timestampNs)) { |
| 515 | configKeysTtlExpired.push_back(it->first); |
| 516 | } |
| 517 | } |
| 518 | if (configKeysTtlExpired.size() > 0) { |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 519 | WriteDataToDiskLocked(CONFIG_RESET, NO_TIME_CONSTRAINTS); |
Yao Chen | 163d260 | 2018-04-10 10:39:53 -0700 | [diff] [blame] | 520 | resetConfigsLocked(timestampNs, configKeysTtlExpired); |
| 521 | } |
| 522 | } |
| 523 | |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 524 | void StatsLogProcessor::OnConfigRemoved(const ConfigKey& key) { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 525 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 526 | auto it = mMetricsManagers.find(key); |
| 527 | if (it != mMetricsManagers.end()) { |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 528 | WriteDataToDiskLocked(key, getElapsedRealtimeNs(), CONFIG_REMOVED, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 529 | NO_TIME_CONSTRAINTS); |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 530 | mMetricsManagers.erase(it); |
David Chen | d689689 | 2017-10-25 11:49:03 -0700 | [diff] [blame] | 531 | mUidMap->OnConfigRemoved(key); |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 532 | } |
Yao Chen | b356151 | 2017-11-21 18:07:17 -0800 | [diff] [blame] | 533 | StatsdStats::getInstance().noteConfigRemoved(key); |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 534 | |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 535 | mLastBroadcastTimes.erase(key); |
Chenjie Yu | fa22d65 | 2018-02-05 14:37:48 -0800 | [diff] [blame] | 536 | |
Tej Singh | 6ede28b | 2019-01-29 17:06:54 -0800 | [diff] [blame] | 537 | int uid = key.GetUid(); |
| 538 | bool lastConfigForUid = true; |
| 539 | for (auto it : mMetricsManagers) { |
| 540 | if (it.first.GetUid() == uid) { |
| 541 | lastConfigForUid = false; |
| 542 | break; |
| 543 | } |
| 544 | } |
| 545 | if (lastConfigForUid) { |
| 546 | mLastActivationBroadcastTimes.erase(uid); |
| 547 | } |
| 548 | |
Chenjie Yu | fa22d65 | 2018-02-05 14:37:48 -0800 | [diff] [blame] | 549 | if (mMetricsManagers.empty()) { |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 550 | mPullerManager->ForceClearPullerCache(); |
Chenjie Yu | fa22d65 | 2018-02-05 14:37:48 -0800 | [diff] [blame] | 551 | } |
Joe Onorato | 9fc9edf | 2017-10-15 20:08:52 -0700 | [diff] [blame] | 552 | } |
| 553 | |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 554 | void StatsLogProcessor::flushIfNecessaryLocked(const ConfigKey& key, |
| 555 | MetricsManager& metricsManager) { |
| 556 | int64_t elapsedRealtimeNs = getElapsedRealtimeNs(); |
David Chen | d9269e2 | 2017-12-05 13:43:51 -0800 | [diff] [blame] | 557 | auto lastCheckTime = mLastByteSizeTimes.find(key); |
| 558 | if (lastCheckTime != mLastByteSizeTimes.end()) { |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 559 | if (elapsedRealtimeNs - lastCheckTime->second < StatsdStats::kMinByteSizeCheckPeriodNs) { |
David Chen | d9269e2 | 2017-12-05 13:43:51 -0800 | [diff] [blame] | 560 | return; |
| 561 | } |
| 562 | } |
| 563 | |
| 564 | // We suspect that the byteSize() computation is expensive, so we set a rate limit. |
| 565 | size_t totalBytes = metricsManager.byteSize(); |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 566 | mLastByteSizeTimes[key] = elapsedRealtimeNs; |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 567 | bool requestDump = false; |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 568 | if (totalBytes > StatsdStats::kMaxMetricsBytesPerConfig) { |
| 569 | // Too late. We need to start clearing data. |
| 570 | metricsManager.dropData(elapsedRealtimeNs); |
Chenjie Yu | c3c30c0 | 2018-10-26 09:48:07 -0700 | [diff] [blame] | 571 | StatsdStats::getInstance().noteDataDropped(key, totalBytes); |
David Chen | 1294295 | 2017-12-04 14:28:43 -0800 | [diff] [blame] | 572 | VLOG("StatsD had to toss out metrics for %s", key.ToString().c_str()); |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 573 | } else if ((totalBytes > StatsdStats::kBytesPerConfigTriggerGetData) || |
| 574 | (mOnDiskDataConfigs.find(key) != mOnDiskDataConfigs.end())) { |
| 575 | // Request to send a broadcast if: |
| 576 | // 1. in memory data > threshold OR |
| 577 | // 2. config has old data report on disk. |
| 578 | requestDump = true; |
| 579 | } |
| 580 | |
| 581 | if (requestDump) { |
David Chen | d9269e2 | 2017-12-05 13:43:51 -0800 | [diff] [blame] | 582 | // Send broadcast so that receivers can pull data. |
| 583 | auto lastBroadcastTime = mLastBroadcastTimes.find(key); |
| 584 | if (lastBroadcastTime != mLastBroadcastTimes.end()) { |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 585 | if (elapsedRealtimeNs - lastBroadcastTime->second < |
| 586 | StatsdStats::kMinBroadcastPeriodNs) { |
David Chen | d9269e2 | 2017-12-05 13:43:51 -0800 | [diff] [blame] | 587 | VLOG("StatsD would've sent a broadcast but the rate limit stopped us."); |
David Chen | 1d7b0cd | 2017-11-15 14:20:04 -0800 | [diff] [blame] | 588 | return; |
| 589 | } |
| 590 | } |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 591 | if (mSendBroadcast(key)) { |
| 592 | mOnDiskDataConfigs.erase(key); |
| 593 | VLOG("StatsD triggered data fetch for %s", key.ToString().c_str()); |
Tej Singh | 480392f | 2019-10-23 15:53:46 -0700 | [diff] [blame] | 594 | mLastBroadcastTimes[key] = elapsedRealtimeNs; |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 595 | StatsdStats::getInstance().noteBroadcastSent(key); |
| 596 | } |
yro | 31eb67b | 2017-10-24 13:33:21 -0700 | [diff] [blame] | 597 | } |
| 598 | } |
| 599 | |
Chenjie Yu | e36018b | 2018-04-16 15:18:30 -0700 | [diff] [blame] | 600 | void StatsLogProcessor::WriteDataToDiskLocked(const ConfigKey& key, |
Yangster-mac | 892f3d3 | 2018-05-02 14:16:48 -0700 | [diff] [blame] | 601 | const int64_t timestampNs, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 602 | const DumpReportReason dumpReportReason, |
| 603 | const DumpLatency dumpLatency) { |
yro | 028091c | 2018-05-09 16:03:27 -0700 | [diff] [blame] | 604 | if (mMetricsManagers.find(key) == mMetricsManagers.end() || |
| 605 | !mMetricsManagers.find(key)->second->shouldWriteToDisk()) { |
Yangster-mac | 892f3d3 | 2018-05-02 14:16:48 -0700 | [diff] [blame] | 606 | return; |
| 607 | } |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 608 | vector<uint8_t> buffer; |
David Chen | 56ae0d9 | 2018-05-11 16:00:22 -0700 | [diff] [blame] | 609 | onConfigMetricsReportLocked(key, timestampNs, true /* include_current_partial_bucket*/, |
Yao Chen | 9a43b4f | 2019-04-10 10:43:20 -0700 | [diff] [blame] | 610 | true /* erase_data */, dumpReportReason, dumpLatency, true, |
| 611 | &buffer); |
| 612 | string file_name = |
| 613 | StorageManager::getDataFileName((long)getWallClockSec(), key.GetUid(), key.GetId()); |
| 614 | StorageManager::writeFile(file_name.c_str(), buffer.data(), buffer.size()); |
| 615 | |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 616 | // We were able to write the ConfigMetricsReport to disk, so we should trigger collection ASAP. |
| 617 | mOnDiskDataConfigs.insert(key); |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 618 | } |
| 619 | |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 620 | void StatsLogProcessor::SaveActiveConfigsToDisk(int64_t currentTimeNs) { |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 621 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
jianjin | 996f40d | 2019-03-29 13:53:48 -0700 | [diff] [blame] | 622 | const int64_t timeNs = getElapsedRealtimeNs(); |
| 623 | // Do not write to disk if we already have in the last few seconds. |
jianjin | 996f40d | 2019-03-29 13:53:48 -0700 | [diff] [blame] | 624 | if (static_cast<unsigned long long> (timeNs) < |
| 625 | mLastActiveMetricsWriteNs + WRITE_DATA_COOL_DOWN_SEC * NS_PER_SEC) { |
| 626 | ALOGI("Statsd skipping writing active metrics to disk. Already wrote data in last %d seconds", |
| 627 | WRITE_DATA_COOL_DOWN_SEC); |
| 628 | return; |
| 629 | } |
| 630 | mLastActiveMetricsWriteNs = timeNs; |
| 631 | |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 632 | ProtoOutputStream proto; |
Tej Singh | f53d445 | 2019-05-09 18:17:59 -0700 | [diff] [blame] | 633 | WriteActiveConfigsToProtoOutputStreamLocked(currentTimeNs, DEVICE_SHUTDOWN, &proto); |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 634 | |
| 635 | string file_name = StringPrintf("%s/active_metrics", STATS_ACTIVE_METRIC_DIR); |
| 636 | StorageManager::deleteFile(file_name.c_str()); |
| 637 | android::base::unique_fd fd( |
| 638 | open(file_name.c_str(), O_WRONLY | O_CREAT | O_CLOEXEC, S_IRUSR | S_IWUSR)); |
| 639 | if (fd == -1) { |
| 640 | ALOGE("Attempt to write %s but failed", file_name.c_str()); |
| 641 | return; |
| 642 | } |
| 643 | proto.flush(fd.get()); |
| 644 | } |
| 645 | |
Tej Singh | f53d445 | 2019-05-09 18:17:59 -0700 | [diff] [blame] | 646 | void StatsLogProcessor::WriteActiveConfigsToProtoOutputStream( |
| 647 | int64_t currentTimeNs, const DumpReportReason reason, ProtoOutputStream* proto) { |
| 648 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 649 | WriteActiveConfigsToProtoOutputStreamLocked(currentTimeNs, reason, proto); |
| 650 | } |
| 651 | |
| 652 | void StatsLogProcessor::WriteActiveConfigsToProtoOutputStreamLocked( |
| 653 | int64_t currentTimeNs, const DumpReportReason reason, ProtoOutputStream* proto) { |
| 654 | for (const auto& pair : mMetricsManagers) { |
| 655 | const sp<MetricsManager>& metricsManager = pair.second; |
| 656 | uint64_t configToken = proto->start(FIELD_TYPE_MESSAGE | FIELD_COUNT_REPEATED | |
| 657 | FIELD_ID_ACTIVE_CONFIG_LIST_CONFIG); |
| 658 | metricsManager->writeActiveConfigToProtoOutputStream(currentTimeNs, reason, proto); |
| 659 | proto->end(configToken); |
| 660 | } |
| 661 | } |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 662 | void StatsLogProcessor::LoadActiveConfigsFromDisk() { |
| 663 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 664 | string file_name = StringPrintf("%s/active_metrics", STATS_ACTIVE_METRIC_DIR); |
| 665 | int fd = open(file_name.c_str(), O_RDONLY | O_CLOEXEC); |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 666 | if (-1 == fd) { |
| 667 | VLOG("Attempt to read %s but failed", file_name.c_str()); |
| 668 | StorageManager::deleteFile(file_name.c_str()); |
| 669 | return; |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 670 | } |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 671 | string content; |
| 672 | if (!android::base::ReadFdToString(fd, &content)) { |
| 673 | ALOGE("Attempt to read %s but failed", file_name.c_str()); |
| 674 | close(fd); |
| 675 | StorageManager::deleteFile(file_name.c_str()); |
| 676 | return; |
| 677 | } |
| 678 | |
| 679 | close(fd); |
| 680 | |
| 681 | ActiveConfigList activeConfigList; |
| 682 | if (!activeConfigList.ParseFromString(content)) { |
| 683 | ALOGE("Attempt to read %s but failed; failed to load active configs", file_name.c_str()); |
| 684 | StorageManager::deleteFile(file_name.c_str()); |
| 685 | return; |
| 686 | } |
Tej Singh | f53d445 | 2019-05-09 18:17:59 -0700 | [diff] [blame] | 687 | // Passing in mTimeBaseNs only works as long as we only load from disk is when statsd starts. |
| 688 | SetConfigsActiveStateLocked(activeConfigList, mTimeBaseNs); |
| 689 | StorageManager::deleteFile(file_name.c_str()); |
| 690 | } |
| 691 | |
| 692 | void StatsLogProcessor::SetConfigsActiveState(const ActiveConfigList& activeConfigList, |
| 693 | int64_t currentTimeNs) { |
| 694 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 695 | SetConfigsActiveStateLocked(activeConfigList, currentTimeNs); |
| 696 | } |
| 697 | |
| 698 | void StatsLogProcessor::SetConfigsActiveStateLocked(const ActiveConfigList& activeConfigList, |
| 699 | int64_t currentTimeNs) { |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 700 | for (int i = 0; i < activeConfigList.config_size(); i++) { |
| 701 | const auto& config = activeConfigList.config(i); |
| 702 | ConfigKey key(config.uid(), config.id()); |
| 703 | auto it = mMetricsManagers.find(key); |
| 704 | if (it == mMetricsManagers.end()) { |
| 705 | ALOGE("No config found for config %s", key.ToString().c_str()); |
| 706 | continue; |
| 707 | } |
| 708 | VLOG("Setting active config %s", key.ToString().c_str()); |
Tej Singh | f53d445 | 2019-05-09 18:17:59 -0700 | [diff] [blame] | 709 | it->second->loadActiveConfig(config, currentTimeNs); |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 710 | } |
| 711 | VLOG("Successfully loaded %d active configs.", activeConfigList.config_size()); |
Chenjie Yu | c7939cb | 2019-02-04 17:25:45 -0800 | [diff] [blame] | 712 | } |
| 713 | |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 714 | void StatsLogProcessor::WriteDataToDiskLocked(const DumpReportReason dumpReportReason, |
| 715 | const DumpLatency dumpLatency) { |
Yangster-mac | 892f3d3 | 2018-05-02 14:16:48 -0700 | [diff] [blame] | 716 | const int64_t timeNs = getElapsedRealtimeNs(); |
Tej Singh | 42f9e06 | 2018-11-09 10:01:00 -0800 | [diff] [blame] | 717 | // Do not write to disk if we already have in the last few seconds. |
| 718 | // This is to avoid overwriting files that would have the same name if we |
| 719 | // write twice in the same second. |
| 720 | if (static_cast<unsigned long long> (timeNs) < |
| 721 | mLastWriteTimeNs + WRITE_DATA_COOL_DOWN_SEC * NS_PER_SEC) { |
| 722 | ALOGI("Statsd skipping writing data to disk. Already wrote data in last %d seconds", |
| 723 | WRITE_DATA_COOL_DOWN_SEC); |
| 724 | return; |
| 725 | } |
| 726 | mLastWriteTimeNs = timeNs; |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 727 | for (auto& pair : mMetricsManagers) { |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 728 | WriteDataToDiskLocked(pair.first, timeNs, dumpReportReason, dumpLatency); |
Yangster-mac | e68f3a5 | 2018-04-04 00:01:43 -0700 | [diff] [blame] | 729 | } |
| 730 | } |
| 731 | |
Muhammad Qureshi | 844694b | 2019-04-05 10:10:40 -0700 | [diff] [blame] | 732 | void StatsLogProcessor::WriteDataToDisk(const DumpReportReason dumpReportReason, |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 733 | const DumpLatency dumpLatency) { |
Yangster-mac | b0d0628 | 2018-01-05 15:44:07 -0800 | [diff] [blame] | 734 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Olivier Gaillard | 6c75ecd | 2019-02-20 09:57:33 +0000 | [diff] [blame] | 735 | WriteDataToDiskLocked(dumpReportReason, dumpLatency); |
yro | 947fbce | 2017-11-15 22:50:23 -0800 | [diff] [blame] | 736 | } |
| 737 | |
Yangster-mac | 15f6bbc | 2018-04-08 11:52:26 -0700 | [diff] [blame] | 738 | void StatsLogProcessor::informPullAlarmFired(const int64_t timestampNs) { |
Yangster | 6df5fcc | 2018-04-12 11:04:29 -0700 | [diff] [blame] | 739 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
Chenjie Yu | e221920 | 2018-06-08 10:07:51 -0700 | [diff] [blame] | 740 | mPullerManager->OnAlarmFired(timestampNs); |
Yangster-mac | 15f6bbc | 2018-04-08 11:52:26 -0700 | [diff] [blame] | 741 | } |
| 742 | |
David Chen | d37bc23 | 2018-04-12 18:05:11 -0700 | [diff] [blame] | 743 | int64_t StatsLogProcessor::getLastReportTimeNs(const ConfigKey& key) { |
| 744 | auto it = mMetricsManagers.find(key); |
| 745 | if (it == mMetricsManagers.end()) { |
| 746 | return 0; |
| 747 | } else { |
| 748 | return it->second->getLastReportTimeNs(); |
| 749 | } |
| 750 | } |
| 751 | |
Tej Singh | 9ec159a | 2019-11-14 11:59:48 -0800 | [diff] [blame] | 752 | void StatsLogProcessor::notifyAppUpgrade(const int64_t& eventTimeNs, const string& apk, |
| 753 | const int uid, const int64_t version) { |
| 754 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 755 | ALOGW("Received app upgrade"); |
| 756 | for (auto it : mMetricsManagers) { |
| 757 | it.second->notifyAppUpgrade(eventTimeNs, apk, uid, version); |
| 758 | } |
| 759 | } |
| 760 | |
| 761 | void StatsLogProcessor::notifyAppRemoved(const int64_t& eventTimeNs, const string& apk, |
| 762 | const int uid) { |
| 763 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 764 | ALOGW("Received app removed"); |
| 765 | for (auto it : mMetricsManagers) { |
| 766 | it.second->notifyAppRemoved(eventTimeNs, apk, uid); |
| 767 | } |
| 768 | } |
| 769 | |
| 770 | void StatsLogProcessor::onUidMapReceived(const int64_t& eventTimeNs) { |
| 771 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 772 | ALOGW("Received uid map"); |
| 773 | for (auto it : mMetricsManagers) { |
| 774 | it.second->onUidMapReceived(eventTimeNs); |
| 775 | } |
| 776 | } |
| 777 | |
David Chen | 4894490 | 2018-05-03 10:29:11 -0700 | [diff] [blame] | 778 | void StatsLogProcessor::noteOnDiskData(const ConfigKey& key) { |
| 779 | std::lock_guard<std::mutex> lock(mMetricsMutex); |
| 780 | mOnDiskDataConfigs.insert(key); |
| 781 | } |
| 782 | |
Yao Chen | ef99c4f | 2017-09-22 16:26:54 -0700 | [diff] [blame] | 783 | } // namespace statsd |
| 784 | } // namespace os |
| 785 | } // namespace android |