1869309 - Perma beta dom/webauthn/tests/browser/browser_webauthn_prompts.js | Test timed out | Found a tab after previous test timed out: https://example.com/

Status: RESOLVED FIXED

(Core :: DOM: Web Authentication, defect)

Description

[Treeherder Bug Filer]

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=439595146&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Jo9CdVhIRqqQ4zbQw9tV9Q/runs/0/artifacts/public/logs/live_backing.log

---

[task 2023-12-11T10:00:07.315Z] 10:00:07     INFO - TEST-PASS | dom/webauthn/tests/browser/browser_webauthn_prompts.js | a DOM element is fullscreen - 
[task 2023-12-11T10:00:07.315Z] 10:00:07     INFO - TEST-PASS | dom/webauthn/tests/browser/browser_webauthn_prompts.js | webauthn-prompt-register-direct prompt visible - 
[task 2023-12-11T10:00:07.318Z] 10:00:07     INFO - TEST-PASS | dom/webauthn/tests/browser/browser_webauthn_prompts.js | request is active - 
[task 2023-12-11T10:00:07.318Z] 10:00:07     INFO - TEST-PASS | dom/webauthn/tests/browser/browser_webauthn_prompts.js | no DOM element is fullscreen - 
[task 2023-12-11T10:00:07.318Z] 10:00:07     INFO - Console message: PopupNotifications._onButtonEvent: Button click happened before the security delay: -1675.171650999997ms
[task 2023-12-11T10:00:07.318Z] 10:00:07     INFO - Buffered messages finished
[task 2023-12-11T10:00:07.320Z] 10:00:07     INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_webauthn_prompts.js | Test timed out - 
[task 2023-12-11T10:00:07.320Z] 10:00:07     INFO - GECKO(3853) | MEMORY STAT | vsize 8002MB | residentFast 378MB | heapAllocated 135MB
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - TEST-OK | dom/webauthn/tests/browser/browser_webauthn_prompts.js | took 90085ms
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - TEST-UNEXPECTED-FAIL | dom/webauthn/tests/browser/browser_webauthn_prompts.js | Found a tab after previous test timed out: https://example.com/ - 
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - GECKO(3853) | [Child 3857: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 12498a800 == 1 [pid = 3857] [id = 3]
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - GECKO(3853) | [Child 3857: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (10fd593e0) [pid = 3857] [serial = 8] [outer = 0]
[task 2023-12-11T10:00:07.323Z] 10:00:07     INFO - GECKO(3853) | [Child 3857: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (12498b000) [pid = 3857] [serial = 9] [outer = 10fd593e0]
[task 2023-12-11T10:00:07.324Z] 10:00:07     INFO - GECKO(3853) | [Child 3886, Main Thread] WARNING: '!windowRoot', file /builds/worker/checkouts/gecko/dom/webauthn/WebAuthnManagerBase.cpp:112
[task 2023-12-11T10:00:07.324Z] 10:00:07     INFO - checking window state
[task 2023-12-11T10:00:07.324Z] 10:00:07     INFO - GECKO(3853) | [Parent 3853: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (12385d000) [pid = 3853] [serial = 32] [outer = 1328fb7a0]
[task 2023-12-11T10:00:07.326Z] 10:00:07     INFO - GECKO(3853) | [WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2023-12-11T10:00:07.330Z] 10:00:07     INFO - GECKO(3853) | [Child 3855: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 123491800 == 0 [pid = 3855] [id = 6] [url = about:blank]
[task 2023-12-11T10:00:07.365Z] 10:00:07     INFO - GECKO(3853) | [Child 3859: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11328fc00 == 0 [pid = 3859] [id = 0] [url = about:newtab]
[task 2023-12-11T10:00:07.415Z] 10:00:07     INFO - GECKO(3853) | [Child 3859: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10a4593e0) [pid = 3859] [serial = 1] [outer = 0] [url = about:newtab]
[task 2023-12-11T10:00:07.416Z] 10:00:07     INFO - GECKO(3853) | [Child 3859: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (113299c00) [pid = 3859] [serial = 3] [outer = 0] [url = about:newtab]
[task 2023-12-11T10:00:08.042Z] 10:00:08     INFO - GECKO(3853) | [Child 3886: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 11918dc00 == 0 [pid = 3886] [id = 0] [url = https://example.com/]
[task 2023-12-11T10:00:08.056Z] 10:00:08     INFO - GECKO(3853) | [Child 3855: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (123492000) [pid = 3855] [serial = 20] [outer = 0] [url = about:blank]
[task 2023-12-11T10:00:08.062Z] 10:00:08     INFO - GECKO(3853) | [Child 3855: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (10e8593e0) [pid = 3855] [serial = 19] [outer = 0] [url = about:blank]
[task 2023-12-11T10:00:08.070Z] 10:00:08     INFO - GECKO(3853) | [Child 3886: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (11919a000) [pid = 3886] [serial = 3] [outer = 0] [url = https://example.com/]
[task 2023-12-11T10:00:08.077Z] 10:00:08     INFO - GECKO(3853) | [Child 3886: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (1104593e0) [pid = 3886] [serial = 1] [outer = 0] [url = https://example.com/]
[task 2023-12-11T10:00:09.038Z] 10:00:09     INFO - GECKO(3853) | [Parent 3853: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (1325d7c00) [pid = 3853] [serial = 9] [outer = 0] [url = about:blank]
[task 2023-12-11T10:00:09.236Z] 10:00:09     INFO - GECKO(3853) | Completed ShutdownLeaks collections in process 3859
[task 2023-12-11T10:00:09.277Z] 10:00:09     INFO - GECKO(3853) | Completed ShutdownLeaks collections in process 3855
[task 2023-12-11T10:00:09.366Z] 10:00:09     INFO - GECKO(3853) | Completed ShutdownLeaks collections in process 3854
[task 2023-12-11T10:00:09.376Z] 10:00:09     INFO - GECKO(3853) | Completed ShutdownLeaks collections in process 3857
[task 2023-12-11T10:00:09.441Z] 10:00:09     INFO - GECKO(3853) | [Parent 3853: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (123865400) [pid = 3853] [serial = 33] [outer = 1328fb7a0]
[task 2023-12-11T10:00:11.534Z] 10:00:11     INFO - GECKO(3853) | [Parent 3853: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (12385d000) [pid = 3853] [serial = 32] [outer = 0] [url = about:blank]
[task 2023-12-11T10:00:11.926Z] 10:00:11     INFO - GECKO(3853) | Completed ShutdownLeaks collections in process 3853
[task 2023-12-11T10:00:11.926Z] 10:00:11     INFO - TEST-START | Shutdown
[task 2023-12-11T10:00:11.927Z] 10:00:11     INFO - Browser Chrome Test Summary
[task 2023-12-11T10:00:11.927Z] 10:00:11     INFO - Passed:  71
[task 2023-12-11T10:00:11.928Z] 10:00:11     INFO - Failed:  2
[task 2023-12-11T10:00:11.928Z] 10:00:11     INFO - Todo:    0
[task 2023-12-11T10:00:11.928Z] 10:00:11     INFO - Mode:    e10s
[task 2023-12-11T10:00:11.929Z] 10:00:11     INFO - *** End BrowserChrome Test Results ***

Comment 1

[Norisz Fay [:noriszfay]]

This seems to have become perma on beta after Bug 1865914 landed as seen here.

Comment 2

[Emma Zühlcke [:emz]]

It perma fails on beta because of Bug 1865914 and macOS native full screen only enabled in Nightly: https://searchfox.org/mozilla-central/rev/c003be8b9727672e7d30972983b375f4c200233f/modules/libpref/init/all.js#3211-3215

Comment 3

[Emma Zühlcke [:emz]]

Attachment: Bug 1869309 - Fix test failure by waiting for PopupNotification security delay to expire before clicking the button. r=Gijs!

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/001488ebae60
Fix test failure by waiting for PopupNotification security delay to expire before clicking the button. r=Gijs

Comment 6

[Sandor Molnar[:smolnar]]

https://hg.mozilla.org/mozilla-central/rev/001488ebae60

Comment 7

[BugBot [:suhaib / :marco/ :calixte]]

The patch landed in nightly and beta is affected.
:pbz, is this bug important enough to require an uplift?

• If yes, please nominate the patch for beta approval.
• If no, please set status-firefox121 to wontfix.

For more information, please visit BugBot documentation.

Comment 8

[Emma Zühlcke [:emz]]

Comment on attachment 9367985 [details]
Bug 1869309 - Fix test failure by waiting for PopupNotification security delay to expire before clicking the button. r=Gijs!

Beta/Release Uplift Approval Request

• User impact if declined: No user impact, this fixes a perma test failure.
• Is this code covered by automated tests?: Yes
• Has the fix been verified in Nightly?: No
• Needs manual test from QE?: No
• If yes, steps to reproduce:
• List of other uplifts needed: None
• Risk to taking this patch: Low
• Why is the change risky/not risky? (and alternatives if risky): Test only change.
• String changes made/needed:
• Is Android affected?: No

ESR Uplift Approval Request

• If this is not a sec:{high,crit} bug, please state case for ESR consideration: Test only change.
• User impact if declined: No user impact, this fixes a perma test failure.
• Fix Landed on Version: 122
• Risk to taking this patch: Low
• Why is the change risky/not risky? (and alternatives if risky): Test only change.

Comment 9

[Ryan VanderMeulen [:RyanVM]]

Comment on attachment 9367985 [details]
Bug 1869309 - Fix test failure by waiting for PopupNotification security delay to expire before clicking the button. r=Gijs!

Approved for mozilla-release and esr115, thanks.

Comment 10

[Pulsebot]

https://hg.mozilla.org/releases/mozilla-release/rev/bb22fcd79ecf

Comment 11

[Ryan VanderMeulen [:RyanVM]]

Comment on attachment 9367985 [details]
Bug 1869309 - Fix test failure by waiting for PopupNotification security delay to expire before clicking the button. r=Gijs!

Actually, this isn't needed on ESR. The regressing bug was uplifted there, but the specific failing sub-test doesn't exist there (landed in 119) and AFAICT there's no other equivalent failures happening elsewhere.

Comment 12

[Intermittent Failures Robot]

13 failures in 4224 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 13

Platform and build breakdown:

• macosx1015-64-qr: 5
  • debug: 5
• macosx1015-64-shippable-qr: 2
  • opt: 2
• macosx1015-64-devedition-qr: 1
  • opt: 1
• macosx1100-64-shippable-qr: 5
  • opt: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1869309&startday=2023-12-11&endday=2023-12-17&tree=all