Closed Bug 1707502 Opened 5 years ago Closed 4 years ago

Intermittent browser/base/content/test/about/browser_aboutCertError.js | Warning: Potential Security Risk Ahead - false == true - got false, expected true (operator ==)

Categories

(Core :: DOM: Security, defect, P5)

Product:
Core
Component:
DOM: Security
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, Whiteboard: [domsecurity-intermittent])

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

[task 2021-04-26T05:07:11.677Z] 05:07:11     INFO - TEST-START | browser/base/content/test/about/browser_aboutCertError.js
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:11.755Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:11.756Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:11.756Z] 05:07:11     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.412Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.414Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.416Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.417Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.417Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:12.417Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:242
[task 2021-04-26T05:07:12.417Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:256
[task 2021-04-26T05:07:12.417Z] 05:07:12     INFO - GECKO(2017) | err = 3 /builds/worker/checkouts/gecko/xpcom/build/mach_override.c:261
[task 2021-04-26T05:07:13.124Z] 05:07:13     INFO - GECKO(2017) | JavaScript error: resource://testing-common/ContentEventListenerChild.jsm, line 138: InvalidStateError: JSWindowActorChild.sendAsyncMessage: JSWindowActorChild cannot send at the moment
[task 2021-04-26T05:07:17.127Z] 05:07:17     INFO - GECKO(2017) | JavaScript error: resource://testing-common/ContentEventListenerChild.jsm, line 147: TypeError: can't access property "chromeEventHandler", this.docShell is null
[task 2021-04-26T05:07:18.518Z] 05:07:18     INFO - GECKO(2017) | JavaScript error: resource://testing-common/ContentEventListenerChild.jsm, line 147: TypeError: can't access property "chromeEventHandler", this.docShell is null
[task 2021-04-26T05:07:18.518Z] 05:07:18     INFO - GECKO(2017) | JavaScript error: resource://testing-common/ContentEventListenerChild.jsm, line 147: TypeError: can't access property "chromeEventHandler", this.docShell is null
[task 2021-04-26T05:07:19.620Z] 05:07:19     INFO - TEST-INFO | started process screencapture
[task 2021-04-26T05:07:19.912Z] 05:07:19     INFO - TEST-INFO | screencapture: exit 0
[task 2021-04-26T05:07:19.912Z] 05:07:19     INFO - <snipped 29 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
[task 2021-04-26T05:07:19.912Z] 05:07:19     INFO - Buffered messages logged at 22:07:13
[task 2021-04-26T05:07:19.912Z] 05:07:19     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | !webNavigation.canGoBack - 
<...>
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Shows the correct certificate in the page - "self-signed.example.com" == "self-signed.example.com" - 
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Leaving test bound checkViewCertificate
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Entering test bound checkBadStsCertHeadline
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Loading a bad sts cert error page and checking that the correct headline is shown
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Loading and waiting for the cert error
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Buffered messages finished
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Warning: Potential Security Risk Ahead - false == true - got false, expected true (operator ==)
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - Stack trace:
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - ok@resource://specialpowers/SpecialPowersSandbox.jsm:87:21
[task 2021-04-26T05:07:19.928Z] 05:07:19     INFO - @chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:479:11
[task 2021-04-26T05:07:19.930Z] 05:07:19     INFO - Loading cert error page in an iframe
[task 2021-04-26T05:07:20.127Z] 05:07:20     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:20.132Z] 05:07:20     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Did Not Connect: Potential Security Issue - false == true - got false, expected true (operator ==)
[task 2021-04-26T05:07:20.132Z] 05:07:20     INFO - Stack trace:
[task 2021-04-26T05:07:20.132Z] 05:07:20     INFO - ok@resource://specialpowers/SpecialPowersSandbox.jsm:87:21
[task 2021-04-26T05:07:20.132Z] 05:07:20     INFO - @chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:474:11
[task 2021-04-26T05:07:20.136Z] 05:07:20     INFO - Leaving test bound checkBadStsCertHeadline
[task 2021-04-26T05:07:20.136Z] 05:07:20     INFO - Entering test bound checkSandboxedIframe
[task 2021-04-26T05:07:20.136Z] 05:07:20     INFO - Loading a bad sts cert error in a sandboxed iframe and check that the correct headline is shown
[task 2021-04-26T05:07:20.136Z] 05:07:20     INFO - Loading cert error page in an iframe
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Title shows Did Not Connect: Potential Security Issue - false == true - got false, expected true (operator ==)
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - Stack trace:
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - @chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:516:12
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Correct error message found - "SEC_ERROR_EXPIRED_CERTIFICATE" == "SEC_ERROR_EXPIRED_CERTIFICATE" - 
[task 2021-04-26T05:07:20.713Z] 05:07:20     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Error message is a link - "a" == "a" - 
[task 2021-04-26T05:07:20.719Z] 05:07:20     INFO - Leaving test bound checkSandboxedIframe
[task 2021-04-26T05:07:20.719Z] 05:07:20     INFO - Entering test bound checkViewSource
[task 2021-04-26T05:07:20.719Z] 05:07:20     INFO - Loading a bad sts cert error in a sandboxed iframe and check that the correct headline is shown
[task 2021-04-26T05:07:21.038Z] 05:07:21     INFO - Loading and waiting for the cert error
[task 2021-04-26T05:07:21.145Z] 05:07:21     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Correct error message found - "SEC_ERROR_EXPIRED_CERTIFICATE" == "SEC_ERROR_EXPIRED_CERTIFICATE" - 
[task 2021-04-26T05:07:21.145Z] 05:07:21     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Error message is a link - "a" == "a" - 
[task 2021-04-26T05:07:21.145Z] 05:07:21     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:21.150Z] 05:07:21     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | "Your Computer Clock is Wrong" == "Warning: Potential Security Risk Ahead" - got "Your Computer Clock is Wrong", expected "Warning: Potential Security Risk Ahead" (operator ==)
[task 2021-04-26T05:07:21.150Z] 05:07:21     INFO - Stack trace:
[task 2021-04-26T05:07:21.150Z] 05:07:21     INFO - @chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:558:12
[task 2021-04-26T05:07:21.155Z] 05:07:21     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Should list hostname in error message. - true == true - 
[task 2021-04-26T05:07:21.155Z] 05:07:21     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:21.155Z] 05:07:21     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError.js | Should list hostname in what to do text. - false == true - got false, expected true (operator ==)
[task 2021-04-26T05:07:21.155Z] 05:07:21     INFO - Stack trace:
[task 2021-04-26T05:07:21.155Z] 05:07:21     INFO - @chrome://mochitests/content/browser/browser/base/content/test/about/browser_aboutCertError.js:570:12
[task 2021-04-26T05:07:21.156Z] 05:07:21     INFO - Clicking the exceptionDialogButton in advanced panel
[task 2021-04-26T05:07:21.161Z] 05:07:21     INFO - Loading the url after adding exception
[task 2021-04-26T05:07:21.244Z] 05:07:21     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError.js | Exception has been added - true == true - 
[task 2021-04-26T05:07:21.356Z] 05:07:21     INFO - Leaving test bound checkViewSource
[task 2021-04-26T05:07:21.388Z] 05:07:21     INFO - GECKO(2017) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-04-26T05:07:21.388Z] 05:07:21     INFO - GECKO(2017) | MEMORY STAT | vsize 12239MB | residentFast 1324MB | heapAllocated 115MB
[task 2021-04-26T05:07:21.388Z] 05:07:21     INFO - TEST-OK | browser/base/content/test/about/browser_aboutCertError.js | took 9702ms
[task 2021-04-26T05:07:21.388Z] 05:07:21     INFO - checking window state
[task 2021-04-26T05:07:21.388Z] 05:07:21     INFO - TEST-START | browser/base/content/test/about/browser_aboutCertError_clockSkew.js
[task 2021-04-26T05:07:26.704Z] 05:07:26     INFO - GECKO(2017) | 2021-04-25 22:07:26.690 firefox[2017:37566] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
[task 2021-04-26T05:07:28.683Z] 05:07:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - Buffered messages logged at 22:07:21
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - Entering test bound checkWrongSystemTimeWarning
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - Loading a bad cert page with a skewed clock
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - Loading and waiting for the cert error
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | Wrong time message information is visible - 
[task 2021-04-26T05:07:28.684Z] 05:07:28     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | Correct error message found - 
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | URL found in error message - 
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | Correct local date displayed - 
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - TEST-PASS | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | time-errors in the Learn More URL - 
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - Leaving test bound checkWrongSystemTimeWarning
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - Entering test bound checkCertError
[task 2021-04-26T05:07:28.685Z] 05:07:28     INFO - Loading a bad cert page
[task 2021-04-26T05:07:28.686Z] 05:07:28     INFO - Loading and waiting for the cert error
[task 2021-04-26T05:07:28.686Z] 05:07:28     INFO - Buffered messages finished
[task 2021-04-26T05:07:28.686Z] 05:07:28     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | Uncaught exception - undefined - timed out after 50 tries.
[task 2021-04-26T05:07:28.687Z] 05:07:28     INFO - Leaving test bound checkCertError
[task 2021-04-26T05:07:28.701Z] 05:07:28     INFO - GECKO(2017) | MEMORY STAT | vsize 12237MB | residentFast 1309MB | heapAllocated 100MB
[task 2021-04-26T05:07:28.701Z] 05:07:28     INFO - TEST-OK | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | took 7311ms
[task 2021-04-26T05:07:28.702Z] 05:07:28     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-04-26T05:07:28.707Z] 05:07:28     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/about/browser_aboutCertError_clockSkew.js | Found an unexpected tab at the end of test run: https://expired.example.com/ - 
[task 2021-04-26T05:07:28.736Z] 05:07:28     INFO - checking window state
[task 2021-04-26T05:07:28.770Z] 05:07:28     INFO - TEST-START | browser/base/content/test/about/browser_aboutCertError_exception.js```

The screenshot of this browser-chrome failures shows a blank home screen. It should show the running browser. Joel, is this an issue with macOS 11 test configurations?

Flags: needinfo?(jmaher)

this seems to be expected with OSX 11, I haven't seen a screenshot yet.

Flags: needinfo?(jmaher)

The Bugbug bot thinks this bug should belong to the 'Core::DOM: Security' component, and is moving the bug to that component. Please revert this change in case you think the bot is wrong.

Component: General → DOM: Security
Product: Firefox → Core
Whiteboard: [domsecurity-intermittent]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

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