File: logging_timer.cc

package info (click to toggle)
chromium 139.0.7258.127-1
  • links: PTS, VCS
  • area: main
  • in suites:
  • size: 6,122,068 kB
  • sloc: cpp: 35,100,771; ansic: 7,163,530; javascript: 4,103,002; python: 1,436,920; asm: 946,517; xml: 746,709; pascal: 187,653; perl: 88,691; sh: 88,436; objc: 79,953; sql: 51,488; cs: 44,583; fortran: 24,137; makefile: 22,147; tcl: 15,277; php: 13,980; yacc: 8,984; ruby: 7,485; awk: 3,720; lisp: 3,096; lex: 1,327; ada: 727; jsp: 228; sed: 36
file content (98 lines) | stat: -rw-r--r-- 2,485 bytes parent folder | download | duplicates (7)
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
// Copyright 2017 The Chromium Authors
// Use of this source code is governed by a BSD-style license that can be
// found in the LICENSE file.

#include "extensions/test/logging_timer.h"

#include <map>

#include "base/lazy_instance.h"
#include "base/logging.h"
#include "base/time/tick_clock.h"

namespace extensions {

namespace {

const base::TickClock* g_clock_for_testing = nullptr;

// A global record of all tracked times.
class TimeTracker {
 public:
  TimeTracker() = default;

  TimeTracker(const TimeTracker&) = delete;
  TimeTracker& operator=(const TimeTracker&) = delete;

  ~TimeTracker() = default;

  void IncrementTime(const char* key, base::TimeDelta elapsed) {
    auto& data = tracked_times_[key];
    data.total_time += elapsed;
    data.num_samples++;
  }

  base::TimeDelta GetTrackedTime(const char* key) {
    auto iter = tracked_times_.find(key);
    return iter != tracked_times_.end() ? iter->second.total_time
                                        : base::TimeDelta();
  }

  void Print() {
    for (const auto& key_value : tracked_times_) {
      LOG(WARNING) << "\n"
                   << key_value.first << ":"
                   << "\n    total: " << key_value.second.total_time
                   << "\n    average: " << key_value.second.average_time();
    }
  }

 private:
  struct Data {
    base::TimeDelta total_time;
    size_t num_samples = 0u;

    base::TimeDelta average_time() const {
      return num_samples == 0u ? base::TimeDelta() : total_time / num_samples;
    }
  };

  // NOTE(devlin): If we find that these map lookups are too expensive, we
  // could instead use a c-style array similar to RuntimeCallStats.
  std::map<const char*, Data> tracked_times_;
};

base::TimeTicks GetNow() {
  return g_clock_for_testing ? g_clock_for_testing->NowTicks()
                             : base::TimeTicks::Now();
}

TimeTracker& GetTimeTracker() {
  static TimeTracker time_tracker;
  return time_tracker;
}

}  // namespace

LoggingTimer::LoggingTimer(const char* key) : start_(GetNow()), key_(key) {}

LoggingTimer::~LoggingTimer() {
  GetTimeTracker().IncrementTime(key_, GetNow() - start_);
}

// static
base::TimeDelta LoggingTimer::GetTrackedTime(const char* key) {
  return GetTimeTracker().GetTrackedTime(key);
}

// static
void LoggingTimer::Print() {
  GetTimeTracker().Print();
}

// static
void LoggingTimer::set_clock_for_testing(const base::TickClock* clock) {
  g_clock_for_testing = clock;
}

}  // namespace extensions