When scenarios configured to start one after another like this:
scenarios: (100.00%) 8 scenarios, 1 max VUs, 10m8s max duration (incl. graceful stop):
* s1_1VUs_5k: 1 looping VUs for 1m15s (gracefulStop: 1s)
* s2_1VUs_5k: 1 looping VUs for 1m15s (startTime: 1m16s, gracefulStop: 1s)
If iteration from first scenario does not finish during the gracefulStop period the browser is forcibly closed and following can be seen in log:
time=“2025-01-16T10:46:04+02:00” level=warning msg=“Unexpected DevTools server error: context deadline exceeded” category=“ExecutionContext:eval” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“fid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 furl:"my-url" sel:"[class*=\"MacroNavigator-module_greybox\"]"” category=“Frame:waitForSelector” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“fid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 furl:"my-url"” category=“Frame:document” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 stid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 fid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 ectxid:1 efurl:my-url” category=“ExecutionContext:getInjectedScript” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 stid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 fid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 ectxid:1 furl:"my-url" forceCallable:true returnByValue:false” category=“ExecutionContext:eval” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 tid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 method:"Runtime.callFunctionOn"” category=“Session:Execute” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 tid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 method:"Runtime.callFunctionOn"” category=“Session:Execute:<-evCancelCtx.Done():return” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 tid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 method:"Runtime.callFunctionOn"” category=“Session:Execute:s.conn.send” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 tid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 method:"Runtime.callFunctionOn"” category=“Session:Execute:<-evCancelCtx.Done():return” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“wsURL:"ws://127.0.0.1:49325/devtools/browser/c7299fe4-37df-4655-bea7-e012ef695ade" sid:44A73B417619F0E7DE0554D73CA59929 err:” category=“Connection:send:<-ctx.Done” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“sid:44A73B417619F0E7DE0554D73CA59929 stid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 fid:B0D1A4903D54CB1A26EAC1C3FE0D1C36 ectxid:1 furl:"my-url" remoteObject is nil” category=“ExecutionContext:eval” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=warning error=“context is done before all ‘IterEnd’ events were processed”
time=“2025-01-16T10:46:04+02:00” level=debug msg=“Executor finished successfully” executor=s1_1VUs_5k startTime=0s type=constant-vus
time=“2025-01-16T10:46:04+02:00” level=debug category=“Browser:Close” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug category=“Browser:GracefulClose” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
time=“2025-01-16T10:46:04+02:00” level=debug msg=“wsURL:"ws://127.0.0.1:49325/devtools/browser/c7299fe4-37df-4655-bea7-e012ef695ade" method:"Browser.close"” category=“connection:Execute” elapsed=“0 ms” iteration_id=1b0713520b47f85 source=browser
Next scenario fails to open the browser and receives this log repeatedly:
level=debug msg=“received IO error: websocket: close 1006 (abnormal closure): unexpected EOF, connection is closing: true” category=cdp elapsed=“37 ms” iteration_id=1b0713520b47f85 source=browser.
test starts with this code to get the page:
const context = await browser.newContext();
context.setDefaultTimeout(parseInt(__ENV.DEFAULT_TIMEOUT));
const page = await context.newPage();
await page.setViewportSize({
width: 1920,
height: 1080,
});
return page;