ed9b2072a6
Old instrumentation was designed to collect promise creation stack and promise scheduled stack together. In DevTools for last 6 months we show only creation stack for promises. We got strong support from users for new model. Now we can drop support for scheduled stacks and simplify implementation. New promise instrumentation is straightforward: - we send kDebugPromiseThen when promise is created by .then call, - we send kDebugPromiseCatch when promise is created by .catch call, - we send kDebugWillHandle before chained callback and kDebugDidHandle after chained callback, - and we send separate kDebugAsyncFunctionPromiseCreated for internal promise inside async await function. Advantages: - we reduce amount of captured stacks (we do not capture stack for promise that constructed not by .then or .catch), - we can consider async task related to .then and .catch as one shot since chained callback is executed once, - on V8 side we can implement required instrumentation using only promise hooks, Disadvantage: - see await-promise test, sometimes scheduled stack was useful since we add catch handler in native code, Implementation details: - on kInit promise hook we need to figure out why promise was created. We analyze builtin functions until first user defined function on current stack. If there is kAsyncFunctionPromiseCreate function then we send kDebugAsyncFunctionPromiseCreated event. If there is kPromiseThen or kPromiseCatch then only if this function is bottom builtin function we send corresponded event to inspector. We need it because Promise.all internally calls .then and in this case we have Promise.all and Promise.then on stack at the same time and we do not need to report this internally created promise to inspector. Bug: chromium:778796 Cq-Include-Trybots: master.tryserver.blink:linux_trusty_blink_rel Change-Id: I53f47ce8c5c4a9897655c3396c249ea59529ae47 Reviewed-on: https://chromium-review.googlesource.com/765208 Commit-Queue: Aleksey Kozyatinskiy <kozyatinskiy@chromium.org> Reviewed-by: Sathya Gunasekaran <gsathya@chromium.org> Reviewed-by: Yang Guo <yangguo@chromium.org> Reviewed-by: Dmitry Gozman <dgozman@chromium.org> Cr-Commit-Position: refs/heads/master@{#49553}
175 lines
6.5 KiB
JavaScript
175 lines
6.5 KiB
JavaScript
// Copyright 2017 the V8 project authors. All rights reserved.
|
|
// Use of this source code is governed by a BSD-style license that can be
|
|
// found in the LICENSE file.
|
|
|
|
let {session, contextGroup, Protocol} = InspectorTest.start('Checks that we drop old async call chains.');
|
|
|
|
Protocol.Debugger.enable();
|
|
Protocol.Runtime.enable();
|
|
InspectorTest.runAsyncTestSuite([
|
|
async function testInfrastructure() {
|
|
Protocol.Debugger.setAsyncCallStackDepth({maxDepth: 128});
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainPromise(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainPromise(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainPromise(5, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainSetTimeout(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainSetTimeout(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(1024);
|
|
runWithAsyncChainSetTimeout(5, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
},
|
|
|
|
async function testZeroLimit() {
|
|
const limit = 0;
|
|
Protocol.Debugger.setAsyncCallStackDepth({maxDepth: 128});
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
},
|
|
|
|
async function testOneLimit() {
|
|
const limit = 1;
|
|
Protocol.Debugger.setAsyncCallStackDepth({maxDepth: 128});
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
},
|
|
|
|
async function testTwoLimit() {
|
|
const limit = 2;
|
|
Protocol.Debugger.setAsyncCallStackDepth({maxDepth: 128});
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(3, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(3, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
},
|
|
|
|
async function testMoreThanTwoLimit() {
|
|
for (let limit = 3; limit <= 7; ++limit) {
|
|
Protocol.Debugger.setAsyncCallStackDepth({maxDepth: 128});
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainPromise(3, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(1, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(2, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
|
|
await setMaxAsyncTaskStacks(limit);
|
|
runWithAsyncChainSetTimeout(3, 'console.trace(42)');
|
|
dumpAsyncChainLength(await Protocol.Runtime.onceConsoleAPICalled());
|
|
}
|
|
},
|
|
]);
|
|
|
|
function runWithAsyncChainPromise(len, source) {
|
|
InspectorTest.log(`Run expression '${source}' with async chain len: ${len}`);
|
|
let asyncCall = `(function asyncCall(num) {
|
|
if (num === 0) {
|
|
${source};
|
|
return;
|
|
}
|
|
Promise.resolve().then(() => asyncCall(num - 1));
|
|
})(${len})`;
|
|
Protocol.Runtime.evaluate({expression: asyncCall});
|
|
}
|
|
|
|
function runWithAsyncChainSetTimeout(len, source) {
|
|
InspectorTest.log(`Run expression '${source}' with async chain len: ${len}`);
|
|
let setTimeoutPrefix = '() => setTimeout(';
|
|
let setTimeoutSuffix = ', 0)';
|
|
Protocol.Runtime.evaluate({
|
|
expression: `setTimeout(${setTimeoutPrefix.repeat(len - 1)}'${source}'${setTimeoutSuffix.repeat(len - 1)}, 0)`
|
|
});
|
|
}
|
|
|
|
function dumpAsyncChainLength(message) {
|
|
let stackTrace = message.params.asyncStackTrace || message.params.stackTrace.parent;
|
|
let asyncChainCount = 0;
|
|
while (stackTrace) {
|
|
++asyncChainCount;
|
|
stackTrace = stackTrace.parent;
|
|
}
|
|
InspectorTest.log(`actual async chain len: ${asyncChainCount}\n`);
|
|
}
|
|
|
|
async function setMaxAsyncTaskStacks(max) {
|
|
let expression = `inspector.setMaxAsyncTaskStacks(${max})`;
|
|
InspectorTest.log(expression);
|
|
await Protocol.Runtime.evaluate({expression});
|
|
}
|