Closed Bug 1830263 Opened 2 years ago Closed 2 years ago

Intermittent not set as task failure: TEST-UNEXPECTED-ERROR Page "before each" hook for "should return the page title" (page.spec.js)

Categories

(Remote Protocol :: CDP, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=413934928&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EVbYqbM8RoKSC7Oh8Akhpw/runs/0/artifacts/public/logs/live_backing.log


This sometimes gets logged as puppeteer test failure but the task does not get set as failed.

[task 2023-04-27T08:20:58.042Z] PID 608 | 1682583658042	RemoteAgent	TRACE	Received DOM event TabSelect for [object XULElement]
[task 2023-04-27T08:20:58.045Z] PID 608 | 1682583658045	RemoteAgent	TRACE	Received DOM event load for [object HTMLDocument]
[task 2023-04-27T08:20:58.060Z] PID 608 | 1682583658060	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 <- {"method":"Target.targetCreated","params":{"targetInfo":{"targetId":"0632e5cd-3907-439a-9d21-701f8a15c7b4","type":"page","title":"","url":"about:blank","attached":false,"browserContextId":99}}}
[task 2023-04-27T08:20:58.061Z] PID 608 | 1682583658060	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 <- {"method":"Target.targetCreated","params":{"targetInfo":{"targetId":"86faa0e1-9c91-4fbe-a883-e862a36a0d9e","type":"page","title":"","url":"about:blank","attached":false,"browserContextId":100}}}
[task 2023-04-27T08:20:58.061Z] PID 608 | 1682583658060	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 <- {"id":1843,"error":{"message":"Unexpected tab opened: about:blank","data":"createTarget@chrome://remote/content/cdp/domains/parent/Target.sys.mjs:137:13\n"}}
[task 2023-04-27T08:20:58.101Z] TEST-UNEXPECTED-ERROR Page "before each" hook for "should return the page title" (page.spec.js)
[task 2023-04-27T08:20:58.101Z] PID 608 | ["fail",{"title":"\"before each\" hook for \"should return the page title\"","fullTitle":"Page \"before each\" hook for \"should return the page title\"","file":"/builds/worker/checkouts/gecko/remote/test/puppeteer/test/build/page.spec.js","duration":132,"currentRetry":0,"err":"Protocol error (Target.createTarget): Unexpected tab opened: about:blank createTarget@chrome://remote/content/cdp/domains/parent/Target.sys.mjs:137:13\n","stack":"ProtocolError: Protocol error (Target.createTarget): Unexpected tab opened: about:blank createTarget@chrome://remote/content/cdp/domains/parent/Target.sys.mjs:137:13\n\n    at /builds/worker/checkouts/gecko/remote/test/puppeteer/packages/puppeteer-core/src/common/Connection.ts:124:16\n    at new Promise (<anonymous>)\n    at Connection.send (/builds/worker/checkouts/gecko/remote/test/puppeteer/packages/puppeteer-core/src/common/Connection.ts:120:12)\n    at CDPBrowser._createPageInContext (/builds/worker/checkouts/gecko/remote/test/puppeteer/packages/puppeteer-core/src/common/Browser.ts:413:47)\n    at CDPBrowserContext.newPage (/builds/worker/checkouts/gecko/remote/test/puppeteer/packages/puppeteer-core/src/common/Browser.ts:738:26)\n    at Context.<anonymous> (/builds/worker/checkouts/gecko/remote/test/puppeteer/test/src/mocha-utils.ts:211:38)\n    at runMicrotasks (<anonymous>)\n    at processTicksAndRejections (node:internal/process/task_queues:96:5)"}]
[task 2023-04-27T08:20:58.106Z] PID 608 | 1682583658106	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 -> {"method":"Target.disposeBrowserContext","params":{"browserContextId":100},"id":1844}
[task 2023-04-27T08:20:58.136Z] PID 608 | 1682583658134	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 <- {"method":"Target.targetDestroyed","params":{"targetId":"86faa0e1-9c91-4fbe-a883-e862a36a0d9e"}}
[task 2023-04-27T08:20:58.144Z] PID 608 | 1682583658143	RemoteAgent	DEBUG	CDPConnection df01c552-0f05-4ec8-8b84-011cf0647882 <- {"id":1844,"result":{}}

The failure here comes from Unexpected tab opened: about:blank when creating a new target.

Here it would mean that the content browser of the created tab is actually different from the one of the target-created event. This is strange given that we set the browser correctly in watchForTabs().

Maybe the browser got replaced here?

Status: NEW → RESOLVED
Closed: 2 years ago
Component: Marionette → CDP
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.