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
99
100
101
102
103
104
105
106
107
|
// Copyright (c) 2010 The Chromium Authors. All rights reserved.
// Use of this source code is governed by a BSD-style license that can be
// found in the LICENSE file.
#include "base/vlog.h"
#include "base/basictypes.h"
#include "base/logging.h"
#include "base/third_party/dynamic_annotations/dynamic_annotations.h"
#include "base/time.h"
#include "testing/gtest/include/gtest/gtest.h"
namespace logging {
namespace {
class VlogTest : public testing::Test {
};
TEST_F(VlogTest, NoVmodule) {
EXPECT_EQ(0, VlogInfo("", "").GetVlogLevel("test1"));
EXPECT_EQ(0, VlogInfo("0", "").GetVlogLevel("test2"));
EXPECT_EQ(0, VlogInfo("blah", "").GetVlogLevel("test3"));
EXPECT_EQ(0, VlogInfo("0blah1", "").GetVlogLevel("test4"));
EXPECT_EQ(1, VlogInfo("1", "").GetVlogLevel("test5"));
EXPECT_EQ(5, VlogInfo("5", "").GetVlogLevel("test6"));
}
TEST_F(VlogTest, Vmodule) {
const char kVSwitch[] = "-1";
const char kVModuleSwitch[] =
"foo=,bar=0,baz=blah,,qux=0blah1,quux=1,corge=5";
VlogInfo vlog_info(kVSwitch, kVModuleSwitch);
EXPECT_EQ(-1, vlog_info.GetVlogLevel("/path/to/grault.cc"));
EXPECT_EQ(0, vlog_info.GetVlogLevel("/path/to/foo.cc"));
EXPECT_EQ(0, vlog_info.GetVlogLevel("D:\\Path\\To\\bar-inl.mm"));
EXPECT_EQ(-1, vlog_info.GetVlogLevel("D:\\path\\to what/bar_unittest.m"));
EXPECT_EQ(0, vlog_info.GetVlogLevel("baz.h"));
EXPECT_EQ(0, vlog_info.GetVlogLevel("/another/path/to/qux.h"));
EXPECT_EQ(1, vlog_info.GetVlogLevel("/path/to/quux"));
EXPECT_EQ(5, vlog_info.GetVlogLevel("c:\\path/to/corge.h"));
}
#define BENCHMARK(iters, elapsed, code) \
do { \
base::TimeTicks start = base::TimeTicks::Now(); \
for (int i = 0; i < iters; ++i) code; \
base::TimeTicks end = base::TimeTicks::Now(); \
elapsed = end - start; \
double cps = iters / elapsed.InSecondsF(); \
LOG(INFO) << cps << " cps (" << elapsed.InSecondsF() \
<< "s elapsed)"; \
} while (0)
double GetSlowdown(const base::TimeDelta& base,
const base::TimeDelta& elapsed) {
return elapsed.InSecondsF() / base.InSecondsF();
}
TEST_F(VlogTest, Perf) {
const char* kVlogs[] = {
"/path/to/foo.cc",
"C:\\path\\to\\bar.h",
"/path/to/not-matched.mm",
"C:\\path\\to\\baz-inl.mm",
"C:\\path\\to\\qux.mm",
"/path/to/quux.mm",
"/path/to/another-not-matched.mm",
};
const int kVlogCount = arraysize(kVlogs);
const int kBenchmarkIterations = RunningOnValgrind() ? 30000 : 10000000;
base::TimeDelta null_elapsed;
{
VlogInfo null_vlog_info("", "");
BENCHMARK(kBenchmarkIterations, null_elapsed, {
EXPECT_NE(-1, null_vlog_info.GetVlogLevel(kVlogs[i % kVlogCount]));
});
}
{
VlogInfo small_vlog_info("0", "foo=1,bar=2,baz=3,qux=4,quux=5");
base::TimeDelta elapsed;
BENCHMARK(kBenchmarkIterations, elapsed, {
EXPECT_NE(-1, small_vlog_info.GetVlogLevel(kVlogs[i % kVlogCount]));
});
LOG(INFO) << "slowdown = " << GetSlowdown(null_elapsed, elapsed)
<< "x";
}
{
VlogInfo pattern_vlog_info("0", "fo*=1,ba?=2,b*?z=3,*ux=4,?uux=5");
base::TimeDelta elapsed;
BENCHMARK(kBenchmarkIterations, elapsed, {
EXPECT_NE(-1, pattern_vlog_info.GetVlogLevel(kVlogs[i % kVlogCount]));
});
LOG(INFO) << "slowdown = " << GetSlowdown(null_elapsed, elapsed)
<< "x";
}
}
#undef BENCHMARK
} // namespace
} // namespace logging
|
