[k6 browser]Several errros when increasing the number of VUs

Grafana k6 k6-browser
1

Hello,
My OS is Windows 10, I have installed k6 v0.43.0, no errors when running with 5 VUs, duration 60 secs, when increasing the number of VUs, I am getting several errors, is there some limitation about number of VUs ? how could I avoid to get those kind of errors?

  1. ERRO[0030] process with PID 35832 unexpectedly ended: exit status 1 category=browser elapsed=“221 ms” goroutine=219
  2. ERRO[0031] communicating with browser: read tcp 127.0.0.1:54381->127.0.0.1:54378: wsarecv: An existing connection was forcibly closed by the remote host. category=cdp elapsed=“0 ms” goroutine=459
  3. ERRO[0033] Uncaught (in promise) GoError: disposing browser context: canceled
  4. ERRO[0059] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 784C7DC0112F0D376102A7C83E09A2C4: sending a message to browser: read tcp 127.0.0.1:54387->127.0.0.1:54386: wsarecv: An existing connection was forcibly closed by the remote host.
  5. ERRO[0032] Uncaught (in promise) GoError: clicking on “input[value="Go!"]”: canceled
  6. ERRO[0032] Uncaught (in promise) navigating frame to “https://test.k6.io/”: navigating to “https://test.k6.io/”: read tcp 127.0.0.1:54381->127.0.0.1:54378: wsarecv: An existing connection was forcibly closed by the remote host. executor=constant-vus scenario=default
  7. ERRO[0029] cleaning up the user data directory: remove (see it is a know issue )

Details of errors:

  scenarios: (100.00%) 1 scenario, 15 max VUs, 1m30s max duration (incl. graceful stop):
           * default: 15 looping VUs for 1m0s (gracefulStop: 30s)

ERRO[0029] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4275141411\BrowserMetrics\BrowserMetrics-64234324-86F8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=196
ERRO[0029] process with PID 34552 unexpectedly ended: exit status 1  category=browser elapsed="372 ms" goroutine=167
ERRO[0029] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-447474528\BrowserMetrics\BrowserMetrics-64234324-8BF8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=91
ERRO[0030] process with PID 35832 unexpectedly ended: exit status 1  category=browser elapsed="221 ms" goroutine=219
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54392->127.0.0.1:54388: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=629
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54335->127.0.0.1:54313: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=184
ERRO[0031] communicating with browser: read tcp 127.0.0.1:54381->127.0.0.1:54378: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=459
ERRO[0031] process with PID 33340 unexpectedly ended: exit status 1  category=browser elapsed="886 ms" goroutine=31
ERRO[0031] process with PID 28148 unexpectedly ended: exit status 1  category=browser elapsed="643 ms" goroutine=49
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54387->127.0.0.1:54386: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=574
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54379->127.0.0.1:54377: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=426
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54351->127.0.0.1:54329: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=177
ERRO[0030] communicating with browser: read tcp 127.0.0.1:54318->127.0.0.1:54317: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=293
ERRO[0031] process with PID 23468 unexpectedly ended: exit status 1  category=browser elapsed="566 ms" goroutine=236
ERRO[0030] process with PID 19648 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=181
ERRO[0031] communicating with browser: read tcp 127.0.0.1:54347->127.0.0.1:54325: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=336
ERRO[0031] communicating with browser: read tcp 127.0.0.1:54391->127.0.0.1:54390: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=594
ERRO[0032] Uncaught (in promise) GoError: clicking on "input[value=\"Go!\"]": canceled
        at reflect.methodValueCall (native)
        at file:///C:/Repos/script.js:14:4(49)  executor=constant-vus scenario=default
ERRO[0033] process with PID 4436 unexpectedly ended: exit status 1  category=browser elapsed="2118 ms" goroutine=233
ERRO[0032] process with PID 10452 unexpectedly ended: exit status 1  category=browser elapsed="2093 ms" goroutine=216
ERRO[0033] Uncaught (in promise) GoError: disposing browser context: canceled
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0032] process with PID 8912 unexpectedly ended: exit status 1  category=browser elapsed="1861 ms" goroutine=101
ERRO[0032] Uncaught (in promise) navigating frame to "https://test.k6.io/": navigating to "https://test.k6.io/": read tcp 127.0.0.1:54381->127.0.0.1:54378: wsarecv: An existing connection was forcibly closed by the remote host.  executor=constant-vus scenario=default
ERRO[0032] process with PID 27308 unexpectedly ended: exit status 1  category=browser elapsed="1661 ms" goroutine=71
ERRO[0032] Uncaught (in promise) GoError: disposing browser context: canceled
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0033] process with PID 13940 unexpectedly ended: exit status 1  category=browser elapsed="2037 ms" goroutine=213
ERRO[0032] process with PID 4288 unexpectedly ended: exit status 1  category=browser elapsed="1984 ms" goroutine=230
ERRO[0033] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1041759569\BrowserMetrics\BrowserMetrics-64234342-5C08.pma: Access is denied.  category=browser elapsed="2332 ms" goroutine=181
ERRO[0033] Uncaught (in promise) GoError: clicking on "input[value=\"Go!\"]": canceled
        at reflect.methodValueCall (native)
        at file:///C:/Repos/script.js:14:4(49)  executor=constant-vus scenario=default
ERRO[0035] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2777997649\BrowserMetrics\BrowserMetrics-64234345-2B0C.pma: Access is denied.  category=browser elapsed="1973 ms" goroutine=213
ERRO[0058] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3815595238\BrowserMetrics\BrowserMetrics-64234341-8470.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=196
ERRO[0058] process with PID 33904 unexpectedly ended: exit status 1  category=browser elapsed="320 ms" goroutine=5086
ERRO[0058] communicating with browser: write tcp 127.0.0.1:54391->127.0.0.1:54390: wsasend: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="25384 ms" goroutine=595
ERRO[0059] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 784C7DC0112F0D376102A7C83E09A2C4: sending a message to browser: read tcp 127.0.0.1:54387->127.0.0.1:54386: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0058] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 9D32E092D3679CB6FF5A5107557AA77B: read tcp 127.0.0.1:54391->127.0.0.1:54390: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0060] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID FCFAAEA3BD0924EB1F186F1F3D5E3948: sending a message to browser: read tcp 127.0.0.1:54335->127.0.0.1:54313: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0058] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4001754700\BrowserMetrics\BrowserMetrics-6423435D-6F48.pma: Access is denied.  category=browser elapsed="331 ms" goroutine=5086
ERRO[0059] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 3BE5CF61D4DA3F7F4F30B5EC0C3FE414: sending a message to browser: read tcp 127.0.0.1:54379->127.0.0.1:54377: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default
ERRO[0063] communicating with browser: read tcp 127.0.0.1:54616->127.0.0.1:54615: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=4982
ERRO[0063] process with PID 27536 unexpectedly ended: exit status 1  category=browser elapsed="113 ms" goroutine=5931
ERRO[0063] Uncaught (in promise) GoError: disposing browser context: canceled
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/script.js:24:4(87)  executor=constant-vus scenario=default

My Script:

import { chromium } from 'k6/experimental/browser';

export default async function () {
  const browser = chromium.launch({ headless: false });
  const page = browser.newPage();
 
  try {
    await page.goto('https://test.k6.io/my_messages.php', { waitUntil: 'networkidle' });

    // Enter login credentials
    page.locator('input[name="login"]').type('admin');
    page.locator('input[name="password"]').type('123');
    page.locator('input[name="password"]');
    page.locator('input[value="Go!"]').click()
    await page.waitForNavigation();
    await page.waitForSelector('input[value="Logout"]');

    // Navigate to Home page
    await page.goto(`https://test.k6.io/`, { waitUntil: 'load' });
    await page.waitForSelector('a[href="https://twitter.com/k6_io"]');
    
    page.screenshot({ path: 'screenshot.png' });
  } finally {
    page.close();
    browser.close();
  }
}

you could reproduce the errors running with set "K6_BROWSER_ENABLED=true" && k6 run --vus 15 --duration 60s script.js
Thank you in advance.

3

Hi @vsanabria,

Thanks for the detailed explanation. It seems like the script does not properly use promises and wait for them to finish. I’ve changed your script as the follows and the test run has finished without GoErrors. The other errors like “unexpectedly killed”, “err:fetching response body” are coming from the browser and you don’t need to worry about them—as they are for informational purposes only.

By the way, you can use page.click directly instead of a locator if you are not planning to reuse the same locator afterward.

import { chromium } from 'k6/experimental/browser';

export default async function () {
  const browser = chromium.launch({ headless: false });
  const page = browser.newPage();
 
  try {
    await page.goto('https://test.k6.io/my_messages.php', { waitUntil: 'networkidle' });

    // Enter login credentials
    page.locator('input[name="login"]').type('admin');
    page.locator('input[name="password"]').type('123');
    
    await Promise.all([
      page.waitForNavigation(),
      page.click('input[type="submit"]'),
    ]);

    await Promise.all([
      page.waitForNavigation(),
      page.click('input[value="Logout"]'),
    ]);

    // Navigate to Home page
    await page.goto(`https://test.k6.io/`, { waitUntil: 'load' });    
    page.screenshot({ path: 'screenshot.png' });
  } finally {
    page.close();
    browser.close();
  }
}

Please let us know if this helps.

Thanks.

4

Hi Inac
Thanks for your response.

I run the script with your changes, the above 5. error is not generated, the 6. error is still reproduced sometimes when increasing the number of VUs for example with 30

Uncaught (in promise) navigating frame to "https://test.k6.io/": navigating to "https://test.k6.io/": websocket: close 1001 (going away)  executor=constant-vus scenario=default

I noticed you removed the "await page.waitForSelector('a[href="https://twitter.com/k6_io"]');" line after go to “https://test.k6.io/” page, is there some special reason to don’t use page.waitForSelector after page.goto?. In the website where I am running the script, after going to a page a table takes some time to load the data so in order to make sure that table’s data is displayed I am using page.waitForSelector after page.goto, but sometimes I got next error, is there other way more efficient to do it ?

ERRO[0055] Uncaught (in promise) GoError: waiting for selector "a[href=\"https://twitter.com/k6_io\"]": waiting for selector "a[href=\"https://twitter.com/k6_io\"]" did not result in any nodes
        at github.com/grafana/xk6-browser/api.Page.WaitForSelector-fm (native)

When you said :

The other errors like “unexpectedly killed”, “err:fetching response body” are coming from the browser and you don’t need to worry about them—as they are for informational purposes only.

As they are information purpose, they are not affect to results of metrics , am I right ? if it is correct, could you please confirm me, if I should ignore next kind of errors?
a.

process with PID 45608 unexpectedly ended: exit status 1  category=browser elapsed="17224 ms" goroutine=252

b.

communicating with browser: read tcp 127.0.0.1:58311->127.0.0.1:58305: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=5966

c.

communicating with browser: write tcp 127.0.0.1:50230->127.0.0.1:50229: wsasend: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="2045 ms" goroutine=14511

d

Uncaught (in promise) GoError: disposing browser context: disposing browser context 
Uncaught (in promise) GoError: disposing browser context: canceled

e

unexpectedly ended: exec: error sending signal to Cmd: TerminateProcess: Access is denied.

f

cleaning up the user data directory: remove ... : Access is denied.

g

 cleaning up the user data directory: remove ..... :The process cannot access the file because it is being used by another process.  category="Browser:Close"

My script updated with your comments:

import { chromium } from 'k6/experimental/browser';

export default async function () {
  const browser = chromium.launch({ headless: false });
  const page = browser.newPage();

  try {
    await page.goto('https://test.k6.io/my_messages.php', { waitUntil: 'networkidle' });

    // Enter login credentials
    page.locator('input[name="login"]').type('admin');
    page.locator('input[name="password"]').type('123');

    await Promise.all([
      page.waitForNavigation(),
      page.click('input[type="submit"]'),
    ]);

    await Promise.all([
      page.waitForNavigation(),
      page.click('input[value="Logout"]'),
    ]);

    // Navigate to Home page
    await page.goto(`https://test.k6.io/`, { waitUntil: 'load' });
    await page.waitForSelector('a[href="https://twitter.com/k6_io"]'); // I want to keep to make sure that data is loaded (In my case the page is opened but I want to wait until a table's data appears)
    page.screenshot({ path: 'screenshot.png' });
  } finally {
    console.log("FINALLY")
    page.close();
    browser.close();
  }
}

Console output with 30 VUs

ERRO[0018] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3122084267\BrowserMetrics\BrowserMetrics-64258472-A0FC.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=212
ERRO[0018] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-557808225\BrowserMetrics\BrowserMetrics-64258472-3C0.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=154
ERRO[0019] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3122084267\BrowserMetrics\BrowserMetrics-64258472-A0FC.pma: Access is denied.  category="BrowserType:Launch" elapsed="0 ms" goroutine=119
ERRO[0021] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1584664376\BrowserMetrics\BrowserMetrics-64258473-95C0.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=226
ERRO[0021] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3813324828\BrowserMetrics\BrowserMetrics-64258473-8DB8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=160
ERRO[0023] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2677814727\BrowserMetrics\BrowserMetrics-64258474-5938.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=213
ERRO[0023] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-822630697\BrowserMetrics\BrowserMetrics-64258474-27E8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=157
ERRO[0024] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2736173999\BrowserMetrics\BrowserMetrics-64258473-1EA8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=215
ERRO[0025] process with PID 8112 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=239
ERRO[0025] process with PID 7848 unexpectedly ended: exit status 1  category=browser elapsed="716 ms" goroutine=171
ERRO[0028] process with PID 22840 unexpectedly ended: exit status 1  category=browser elapsed="5188 ms" goroutine=332
ERRO[0025] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2039433026\BrowserMetrics\BrowserMetrics-64258474-658C.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=219
ERRO[0028] process with PID 15152 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=256
ERRO[0025] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4004379564\BrowserMetrics\BrowserMetrics-64258476-7CD8.pma: Access is denied.  category="Browser:Close" elapsed="0 ms" goroutine=228
ERRO[0027] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1666487199\BrowserMetrics\BrowserMetrics-64258473-1FB0.pma: Access is denied.  category="Browser:Close" elapsed="2400 ms" goroutine=218
ERRO[0030] process with PID 22640 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=335
ERRO[0030] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3677225569\BrowserMetrics\BrowserMetrics-64258488-B288.pma: Access is denied.  category=browser elapsed="2728 ms" goroutine=332
ERRO[0030] process with PID 17968 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=382
ERRO[0031] communicating with browser: read tcp 127.0.0.1:53524->127.0.0.1:53523: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=3912
ERRO[0031] process with PID 22416 unexpectedly ended: exit status 1  category=browser elapsed="433 ms" goroutine=28
ERRO[0030] process with PID 38336 unexpectedly ended: exit status 1  category=browser elapsed="9213 ms" goroutine=109
ERRO[0031] process with PID 32924 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=174
ERRO[0031] process with PID 960 unexpectedly ended: exit status 1  category=browser elapsed="13093 ms" goroutine=124
ERRO[0031] process with PID 31960 unexpectedly ended: exit status 1  category=browser elapsed="5386 ms" goroutine=313
ERRO[0031] process with PID 25996 unexpectedly ended: exit status 1  category=browser elapsed="5416 ms" goroutine=413
ERRO[0031] communicating with browser: read tcp 127.0.0.1:53378->127.0.0.1:53369: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=576
ERRO[0034] process with PID 28144 unexpectedly ended: exit status 1  category=browser elapsed="2599 ms" goroutine=236
ERRO[0034] communicating with browser: read tcp 127.0.0.1:53470->127.0.0.1:53469: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=2667
ERRO[0033] process with PID 32244 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=395
ERRO[0034] process with PID 36280 unexpectedly ended: exit status 1  category=browser elapsed="12484 ms" goroutine=106
ERRO[0033] process with PID 11992 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=259
ERRO[0033] process with PID 10216 unexpectedly ended: exit status 1  category=browser elapsed="9413 ms" goroutine=112
ERRO[0033] communicating with browser: read tcp 127.0.0.1:53468->127.0.0.1:53467: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=2453
ERRO[0035] process with PID 7484 unexpectedly ended: exit status 1  category=browser elapsed="2166 ms" goroutine=398
ERRO[0033] process with PID 38716 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=544
ERRO[0033] process with PID 18048 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=185
ERRO[0032] process with PID 17460 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=637
ERRO[0033] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-190244115\BrowserMetrics\BrowserMetrics-64258491-786C.pma: Access is denied.  category=browser elapsed="2332 ms" goroutine=313
ERRO[0032] process with PID 10532 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=344
ERRO[0033] process with PID 15800 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=200
ERRO[0033] communicating with browser: read tcp 127.0.0.1:53513->127.0.0.1:53512: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=2959
ERRO[0032] process with PID 41212 unexpectedly ended: exit status 1  category=browser elapsed="14638 ms" goroutine=233
ERRO[0033] process with PID 33600 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=250
ERRO[0032] process with PID 28276 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=253
ERRO[0037] process with PID 32776 unexpectedly ended: exit status 1  category=browser elapsed="3083 ms" goroutine=95
ERRO[0034] communicating with browser: read tcp 127.0.0.1:53376->127.0.0.1:53363: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=570
ERRO[0037] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4167538351\BrowserMetrics\BrowserMetrics-64258477-973C.pma: Access is denied.  category="Browser:Close" elapsed="4477 ms" goroutine=224
ERRO[0035] process with PID 21496 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=354
ERRO[0035] process with PID 16012 unexpectedly ended: exit status 1  category=browser elapsed="1418 ms" goroutine=287
ERRO[0038] process with PID 40588 unexpectedly ended: exit status 1  category=browser elapsed="3198 ms" goroutine=274
ERRO[0034] process with PID 46544 unexpectedly ended: exit status 1  category=browser elapsed="15198 ms" goroutine=9994
ERRO[0035] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-394546928\BrowserMetrics\BrowserMetrics-64258477-5870.pma: Access is denied.  category="Browser:Close" elapsed="5533 ms" goroutine=227
ERRO[0036] process with PID 24432 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=11377
ERRO[0039] process with PID 45704 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=12843
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1101696511\BrowserMetrics\BrowserMetrics-64258472-2ED8.pma: Access is denied.  category="Browser:Close" elapsed="4871 ms" goroutine=214
ERRO[0039] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4178587868\BrowserMetrics\BrowserMetrics-64258497-3CC4.pma: Access is denied.  category=browser elapsed="3356 ms" goroutine=11377
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-257689403\BrowserMetrics\BrowserMetrics-64258473-6E74.pma: Access is denied.  category="Browser:Close" elapsed="5949 ms" goroutine=159
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4054880968\BrowserMetrics\BrowserMetrics-64258486-5F70.pma: Access is denied.  category=browser elapsed="8327 ms" goroutine=109
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2720448132\BrowserMetrics\BrowserMetrics-64258473-4680.pma: Access is denied.  category="Browser:Close" elapsed="5329 ms" goroutine=225
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1820302516\BrowserMetrics\BrowserMetrics-64258485-6E40.pma: Access is denied.  category=browser elapsed="7543 ms" goroutine=124
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2850639081\6caa76c1-ef70-4d9c-8306-736fcb3d8478.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="6000 ms" goroutine=216
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2134657545\BrowserMetrics\BrowserMetrics-64258476-7DF4.pma: Access is denied.  category="Browser:Close" elapsed="5512 ms" goroutine=156
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4078273384\011d1df0-8ab1-4fe9-8292-83770deace78.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="3630 ms" goroutine=151
ERRO[0039] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2479464440\BrowserMetrics\BrowserMetrics-64258473-3DB8.pma: Access is denied.  category="Browser:Close" elapsed="5992 ms" goroutine=158
ERRO[0038] process with PID 32352 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=14175
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3688006110\BrowserMetrics\BrowserMetrics-6425848A-7E60.pma: Access is denied.  category=browser elapsed="12910 ms" goroutine=171
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2599664515\aea9c637-4112-468b-a886-a39cbcdb39fa.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="4286 ms" goroutine=155
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3383713239\BrowserMetrics\BrowserMetrics-64258478-4434.pma: Access is denied.  category="Browser:Close" elapsed="5520 ms" goroutine=211
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1445823766\BrowserMetrics\BrowserMetrics-64258473-809C.pma: Access is denied.  category="Browser:Close" elapsed="7111 ms" goroutine=222
ERRO[0038] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1654220096\BrowserMetrics\BrowserMetrics-64258490-9264.pma: Access is denied.  category=browser elapsed="7229 ms" goroutine=413
ERRO[0039] process with PID 24292 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=13789
ERRO[0043] Uncaught (in promise) GoError: waiting for selector "a[href=\"https://twitter.com/k6_io\"]": getting new document handle: document element handle is nil
        at github.com/grafana/xk6-browser/api.Page.WaitForSelector-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:26:31(81)  executor=constant-vus scenario=default
ERRO[0039] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1197709060\BrowserMetrics\BrowserMetrics-64258488-8D7C.pma: Access is denied.  category=browser elapsed="5309 ms" goroutine=106
ERRO[0040] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3247934210\BrowserMetrics\BrowserMetrics-64258489-5EE4.pma: Access is denied.  category=browser elapsed="6861 ms" goroutine=112
ERRO[0042] process with PID 30828 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=16612
ERRO[0042] process with PID 38792 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=16716
ERRO[0041] process with PID 36220 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=12429
ERRO[0042] process with PID 37476 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=16306
ERRO[0046] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-971353458\lockfile: The process cannot access the file because it is being used by another process.  category=browser elapsed="8020 ms" goroutine=14175
ERRO[0047] process with PID 24736 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=20597
ERRO[0049] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1197709060\BrowserMetrics\BrowserMetrics-64258488-8D7C.pma: Access is denied.  category="Browser:Close" elapsed="8033 ms" goroutine=160
ERRO[0050] process with PID 47352 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=20730
ERRO[0050] process with PID 12448 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=21020
ERRO[0050] process with PID 43088 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=20462
ERRO[0051] process with PID 15556 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=20782
ERRO[0051] process with PID 14460 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=21005
ERRO[0051] process with PID 16340 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=20985
ERRO[0053] process with PID 38396 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=22021
ERRO[0053] process with PID 17596 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=21394
ERRO[0053] process with PID 28220 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=21133
ERRO[0053] process with PID 12704 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=21725
ERRO[0055] Uncaught (in promise) GoError: waiting for selector "a[href=\"https://twitter.com/k6_io\"]": waiting for selector "a[href=\"https://twitter.com/k6_io\"]" did not result in any nodes
        at github.com/grafana/xk6-browser/api.Page.WaitForSelector-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:26:31(81)  executor=constant-vus scenario=default
ERRO[0055] process with PID 35084 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=22420
ERRO[0055] process with PID 17720 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=22168
ERRO[0056] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1654220096\BrowserMetrics\BrowserMetrics-64258490-9264.pma: Access is denied.  category="Browser:Close" elapsed="13236 ms" goroutine=219
ERRO[0056] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1631020931\BrowserMetrics\BrowserMetrics-64258490-9788.pma: Access is denied.  category="Browser:Close" elapsed="13658 ms" goroutine=218
ERRO[0056] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID E0842C857B4FDFC7348A17D83760DF83: sending a message to browser: read tcp 127.0.0.1:53378->127.0.0.1:53369: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:30:4(99)  executor=constant-vus scenario=default
ERRO[0056] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-839232655\BrowserMetrics\BrowserMetrics-64258497-A850.pma: Access is denied.  category="Browser:Close" elapsed="6325 ms" goroutine=161
ERRO[0056] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID F4388D5693F9ECF9662A1C556E1A979B: sending a message to browser: read tcp 127.0.0.1:53468->127.0.0.1:53467: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:30:4(99)  executor=constant-vus scenario=default
ERRO[0056] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-2872727361\27040ff2-135e-41d2-94be-472ed86c5f44.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="6330 ms" goroutine=210
ERRO[0056] process with PID 44840 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=22106
ERRO[0058] process with PID 19548 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=22670
ERRO[0058] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 6A8973F810A4E1FF88B6EAA7314C70F6: sending a message to browser: read tcp 127.0.0.1:53470->127.0.0.1:53469: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:30:4(99)  executor=constant-vus scenario=default
ERRO[0059] Uncaught (in promise) GoError: disposing browser context: disposing browser context ID 209F3142752DDEA409D7E8E3451CFB73: read tcp 127.0.0.1:53524->127.0.0.1:53523: wsarecv: An existing connection was forcibly closed by the remote host.
        at github.com/grafana/xk6-browser/api.Page.Close-fm (native)
        at file:///C:/Repos/testWeb_fix_Comm.js:30:4(99)  executor=constant-vus scenario=default
ERRO[0059] communicating with browser: write tcp 127.0.0.1:53524->127.0.0.1:53523: wsasend: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="27189 ms" goroutine=3913
ERRO[0060] process with PID 31676 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=24257
ERRO[0060] process with PID 20636 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=23424
ERRO[0062] process with PID 21904 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=27754
ERRO[0062] process with PID 31540 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=28358
ERRO[0063] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1287187232\BrowserMetrics\BrowserMetrics-64258499-44BC.pma: Access is denied.  category="Browser:Close" elapsed="10583 ms" goroutine=214
ERRO[0065] process with PID 10524 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=30789
ERRO[0067] process with PID 29660 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=30629
ERRO[0069] process with PID 4600 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31431
ERRO[0069] process with PID 46588 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31370
ERRO[0069] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-975525751\BrowserMetrics\BrowserMetrics-6425849B-890C.pma: Access is denied.  category="Browser:Close" elapsed="14066 ms" goroutine=158
ERRO[0069] process with PID 18056 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=30762
ERRO[0070] process with PID 32780 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31494
ERRO[0071] process with PID 38404 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31400
ERRO[0072] process with PID 42932 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31532
ERRO[0072] process with PID 34256 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31752
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1290028748\BrowserMetrics\BrowserMetrics-6425849B-AF28.pma: Access is denied.  category="Browser:Close" elapsed="16099 ms" goroutine=156
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-651929099\9b9dce42-377e-4a92-9ad5-9b8c93ad10f0.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="9736 ms" goroutine=160
ERRO[0072] process with PID 46908 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31830
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3674455946\BrowserMetrics\BrowserMetrics-642584AA-85D0.pma: Access is denied.  category="Browser:Close" elapsed="713 ms" goroutine=226
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3789826893\BrowserMetrics\BrowserMetrics-642584A9-11F8.pma: Access is denied.  category="Browser:Close" elapsed="3349 ms" goroutine=228
ERRO[0073] communicating with browser: read tcp 127.0.0.1:53599->127.0.0.1:53598: wsarecv: An existing connection was forcibly closed by the remote host.  category=cdp elapsed="0 ms" goroutine=26837
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-680208230\BrowserMetrics\BrowserMetrics-642584AA-4688.pma: Access is denied.  category="Browser:Close" elapsed="3044 ms" goroutine=223
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1262738829\6130c735-a144-481e-ad6a-4642b06d5e96.tmp: The process cannot access the file because it is being used by another process.  category="Browser:Close" elapsed="3410 ms" goroutine=219
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4046652517\BrowserMetrics\BrowserMetrics-642584AA-800C.pma: Access is denied.  category="Browser:Close" elapsed="2749 ms" goroutine=218
ERRO[0072] process with PID 44444 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31897
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1859821028\BrowserMetrics\BrowserMetrics-642584A9-9604.pma: Access is denied.  category="Browser:Close" elapsed="1328 ms" goroutine=224
ERRO[0072] process with PID 13872 unexpectedly ended: exit status 1  category=browser elapsed="0 ms" goroutine=31650
ERRO[0072] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-3260115434\BrowserMetrics\BrowserMetrics-642584AA-B73C.pma: Access is denied.  category="Browser:Close" elapsed="280 ms" goroutine=212
ERRO[0074] Uncaught (in promise) clicking on "input[value=\"Logout\"]": read tcp 127.0.0.1:53599->127.0.0.1:53598: wsarecv: An existing connection was forcibly closed by the remote host.  executor=constant-vus scenario=default
ERRO[0074] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-4013736160\BrowserMetrics\BrowserMetrics-642584AC-AD9C.pma: Access is denied.  category="Browser:Close" elapsed="1357 ms" goroutine=154
ERRO[0074] cleaning up the user data directory: remove C:\Users\VSANAB~1\AppData\Local\Temp\xk6-browser-data-1578487636\BrowserMetrics\BrowserMetrics-642584AA-3630.pma: Access is denied.  category="Browser:Close" elapsed="1720 ms" goroutine=161
ERRO[0073] process with PID 42068 unexpectedly ended: exit status 1  category=browser elapsed="138 ms" goroutine=22810

 running (1m14.5s), 00/30 VUs, 77 complete and 0 interrupted iterations
5

Hi @vsanabria,

It sounds like your computer doesn’t have enough resources to run a 30 VU test (each VU starts a new Chrome browser process, which run 30 tests concurrently). The Chrome browser is a resource heavy process so you will need a high spec computer to be able to run all those tests.

Hope that helps clarify something,
Ankur

1 Like
7

Hey,

Why are you navigating to the homepage in your app after logging in, is this not done by the app?

// Navigate to Home page
await page.goto(https://test.k6.io/, { waitUntil: ‘load’ });
page.screenshot({ path: ‘screenshot.png’ });

And when you get there are you not checking anything? I have the same issue.

8

@harveysmith,

What is the issue that you are having? What are you trying to test and why?

Cheers,
Ankur

9

Hey,

If I want too interact with a page I must use Page.Goto as opposed to http.get (URL)

If I use the first was, I don’t seem to get back a response I can assert on. If I use http.get(URL) i do get a response but cant interact with the page.

10

Hi @harveysmith,

Your issue doesn’t seem to be related to this topic. Let’s carry on with the conversation in No response from page.goto('myurl.com').

Cheers,
Ankur