blob: 987992dbd67d34487d792f4c9e987cfab9c372fb (
plain)
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
|
// @tags: [does_not_support_stepdowns]
// tests getlog as well as slow querying logging
// We turn off gossiping the mongo shell's clusterTime because it causes the slow command log
// messages to get truncated since they'll exceed 512 characters. The truncated log messages will
// fail to match the find and update patterns defined later on in this test.
TestData.skipGossipingClusterTime = true;
glcol = db.getLogTest2;
glcol.drop();
contains = function(arr, func) {
var i = arr.length;
while (i--) {
if (func(arr[i])) {
return true;
}
}
return false;
};
// test doesn't work when talking to mongos
if (db.isMaster().msg != "isdbgrid") {
// run a slow query
glcol.save({"SENTINEL": 1});
glcol.findOne({
"SENTINEL": 1,
"$where": function() {
sleep(1000);
return true;
}
});
// run a slow update
glcol.update({
"SENTINEL": 1,
"$where": function() {
sleep(1000);
return true;
}
},
{"x": "x"});
var resp = db.adminCommand({getLog: "global"});
assert(resp.ok == 1, "error executing getLog command");
assert(resp.log, "no log field");
assert(resp.log.length > 0, "no log lines");
// ensure that slow query is logged in detail
assert(contains(resp.log, function(v) {
print(v);
var opString = db.getMongo().useReadCommands() ? " find " : " query ";
var filterString = db.getMongo().useReadCommands() ? "filter:" : "command:";
return v.indexOf(opString) != -1 && v.indexOf(filterString) != -1 &&
v.indexOf("keysExamined:") != -1 && v.indexOf("docsExamined:") != -1 &&
v.indexOf("SENTINEL") != -1;
}));
// same, but for update
assert(contains(resp.log, function(v) {
return v.indexOf(" update ") != -1 && v.indexOf("command") != -1 &&
v.indexOf("keysExamined:") != -1 && v.indexOf("docsExamined:") != -1 &&
v.indexOf("SENTINEL") != -1;
}));
}
|
