Perma [tier 2] toolkit/xre/test/marionette/test_win32k_enrollment.py TestWin32kAutostart.test_1 | marionette_driver.errors.JavascriptException: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]"
Categories
(Toolkit :: Startup and Profile System, defect, P5)
Tracking
()
| Tracking | Status | |
|---|---|---|
| firefox-esr91 | --- | unaffected |
| firefox97 | --- | unaffected |
| firefox98 | --- | unaffected |
| firefox99 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: bobowen)
References
(Regression)
Details
(Keywords: intermittent-failure, regression)
Attachments
(1 file)
Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=369150635&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/GrYPhYn8QZyz6U_HKro0NA/runs/0/artifacts/public/logs/live_backing.log
[task 2022-02-24T23:48:38.908Z] 23:48:38 INFO - TEST-START | toolkit/xre/test/marionette/test_win32k_enrollment.py TestWin32kAutostart.test_1
[task 2022-02-24T23:48:38.910Z] 23:48:38 INFO - 1645746518909 Marionette DEBUG Accepted connection 2 from 127.0.0.1:53585
[task 2022-02-24T23:48:38.918Z] 23:48:38 INFO - 1645746518918 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-02-24T23:48:38.922Z] 23:48:38 INFO - 1645746518922 RemoteAgent TRACE [19] Document already finished loading: about:blank
[task 2022-02-24T23:48:38.924Z] 23:48:38 INFO - 1645746518923 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"c8fd0ab0-78b1-4586-88ff-db1236f5541c","capabilities":{"browserName":"firefox","browserVersion":"99.0a ... 8.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2022-02-24T23:48:38.924Z] 23:48:38 INFO - 1645746518924 Marionette DEBUG 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2022-02-24T23:48:38.925Z] 23:48:38 INFO - 1645746518925 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2022-02-24T23:48:38.926Z] 23:48:38 INFO - 1645746518926 Marionette DEBUG 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2022-02-24T23:48:38.927Z] 23:48:38 INFO - 1645746518927 Marionette DEBUG 2 <- [1,3,null,{"value":null}]
[task 2022-02-24T23:48:38.928Z] 23:48:38 INFO - 1645746518928 Marionette DEBUG 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2022-02-24T23:48:38.929Z] 23:48:38 INFO - 1645746518929 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2022-02-24T23:48:38.931Z] 23:48:38 INFO - 1645746518931 Marionette DEBUG 2 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.931Z] 23:48:38 INFO - 1645746518932 Marionette DEBUG 2 <- [1,5,null,{"value":null}]
[task 2022-02-24T23:48:38.933Z] 23:48:38 INFO - 1645746518933 Marionette DEBUG 2 -> [0,6,"Marionette:GetContext",{}]
[task 2022-02-24T23:48:38.933Z] 23:48:38 INFO - 1645746518934 Marionette DEBUG 2 <- [1,6,null,{"value":"chrome"}]
[task 2022-02-24T23:48:38.934Z] 23:48:38 INFO - 1645746518935 Marionette DEBUG 2 -> [0,7,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.935Z] 23:48:38 INFO - 1645746518935 Marionette DEBUG 2 <- [1,7,null,{"value":null}]
[task 2022-02-24T23:48:38.938Z] 23:48:38 INFO - 1645746518938 Marionette DEBUG 2 -> [0,8,"WebDriver:ExecuteScript",{"script":"// We're running in a function, in a sandbox, that inherits from an\n // X ... e":"C:\\Users\\task_1645744163\\build\\tests\\marionette\\tests\\toolkit\\xre\\test\\marionette\\test_win32k_enrollment.py"}]
[task 2022-02-24T23:48:38.940Z] 23:48:38 INFO - 1645746518941 Marionette TRACE [7] MarionetteCommands actor created for window id 2
[task 2022-02-24T23:48:38.943Z] 23:48:38 INFO - 1645746518943 Marionette DEBUG 2 <- [1,8,null,{"value":null}]
[task 2022-02-24T23:48:38.944Z] 23:48:38 INFO - 1645746518944 Marionette DEBUG 2 -> [0,9,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.944Z] 23:48:38 INFO - 1645746518944 Marionette DEBUG 2 <- [1,9,null,{"value":null}]
[task 2022-02-24T23:48:38.945Z] 23:48:38 INFO - 1645746518945 Marionette DEBUG 2 -> [0,10,"Marionette:GetContext",{}]
[task 2022-02-24T23:48:38.945Z] 23:48:38 INFO - 1645746518946 Marionette DEBUG 2 <- [1,10,null,{"value":"chrome"}]
[task 2022-02-24T23:48:38.946Z] 23:48:38 INFO - 1645746518946 Marionette DEBUG 2 -> [0,11,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.946Z] 23:48:38 INFO - 1645746518947 Marionette DEBUG 2 <- [1,11,null,{"value":null}]
[task 2022-02-24T23:48:38.948Z] 23:48:38 INFO - 1645746518948 Marionette DEBUG 2 -> [0,12,"WebDriver:ExecuteScript",{"script":"return Services.prefs.getBoolPref(\"security.sandbox.content.win32k-disable\");"," ... e":"C:\\Users\\task_1645744163\\build\\tests\\marionette\\tests\\toolkit\\xre\\test\\marionette\\test_win32k_enrollment.py"}]
[task 2022-02-24T23:48:38.951Z] 23:48:38 INFO - 1645746518951 Marionette DEBUG 2 <- [1,12,{"error":"javascript error","message":"[Exception... \"Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED ... ommandsChild.jsm:223:21\nreceiveMessage@chrome://remote/content/marionette/actors/MarionetteCommandsChild.jsm:95:31\n"},null]
[task 2022-02-24T23:48:38.952Z] 23:48:38 INFO - 1645746518952 Marionette DEBUG 2 -> [0,13,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.952Z] 23:48:38 INFO - 1645746518952 Marionette DEBUG 2 <- [1,13,null,{"value":null}]
[task 2022-02-24T23:48:38.954Z] 23:48:38 INFO - 1645746518954 Marionette DEBUG 2 -> [0,14,"Marionette:GetContext",{}]
[task 2022-02-24T23:48:38.954Z] 23:48:38 INFO - 1645746518954 Marionette DEBUG 2 <- [1,14,null,{"value":"chrome"}]
[task 2022-02-24T23:48:38.955Z] 23:48:38 INFO - 1645746518955 Marionette DEBUG 2 -> [0,15,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:38.955Z] 23:48:38 INFO - 1645746518955 Marionette DEBUG 2 <- [1,15,null,{"value":null}]
[task 2022-02-24T23:48:38.956Z] 23:48:38 INFO - 1645746518956 Marionette DEBUG 2 -> [0,16,"WebDriver:TakeScreenshot",{"id":null,"full":true,"hash":false,"scroll":true}]
[task 2022-02-24T23:48:39.016Z] 23:48:39 INFO - 1645746519015 Marionette DEBUG 2 <- [1,16,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQHCAYAAACjlsT7AAAgAElEQVR4XuzdC5RkdX0n8H/DzMDA8FDQoAyIyghkAREQiPh+7CHmrOJG ... ABAgQIECBAgAABAgQIECDQBRyA3U6SAAECBAgQIECAAAECBAgQIECAwL2AA/B+IgUJECBAgAABAgQIECBAgAABAgQIdIEBwXb/gFpDBsgAAAAASUVORK5CYII="}]
[task 2022-02-24T23:48:39.018Z] 23:48:39 INFO - 1645746519018 Marionette DEBUG 2 -> [0,17,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:39.018Z] 23:48:39 INFO - 1645746519018 Marionette DEBUG 2 <- [1,17,null,{"value":null}]
[task 2022-02-24T23:48:39.019Z] 23:48:39 INFO - 1645746519019 Marionette DEBUG 2 -> [0,18,"Marionette:GetContext",{}]
[task 2022-02-24T23:48:39.020Z] 23:48:39 INFO - 1645746519020 Marionette DEBUG 2 <- [1,18,null,{"value":"chrome"}]
[task 2022-02-24T23:48:39.021Z] 23:48:39 INFO - 1645746519021 Marionette DEBUG 2 -> [0,19,"Marionette:SetContext",{"value":"content"}]
[task 2022-02-24T23:48:39.021Z] 23:48:39 INFO - 1645746519021 Marionette DEBUG 2 <- [1,19,null,{"value":null}]
[task 2022-02-24T23:48:39.022Z] 23:48:39 INFO - 1645746519022 Marionette DEBUG 2 -> [0,20,"WebDriver:GetPageSource",{}]
[task 2022-02-24T23:48:39.028Z] 23:48:39 INFO - 1645746519028 Marionette TRACE [19] MarionetteCommands actor created for window id 2147483649
[task 2022-02-24T23:48:39.029Z] 23:48:39 INFO - 1645746519029 Marionette DEBUG 2 <- [1,20,null,{"value":"<html><head></head><body></body></html>"}]
[task 2022-02-24T23:48:39.030Z] 23:48:39 INFO - 1645746519030 Marionette DEBUG 2 -> [0,21,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-02-24T23:48:39.031Z] 23:48:39 INFO - 1645746519031 Marionette DEBUG 2 <- [1,21,null,{"value":null}]
[task 2022-02-24T23:48:39.033Z] 23:48:39 ERROR - TEST-UNEXPECTED-ERROR | toolkit/xre/test/marionette/test_win32k_enrollment.py TestWin32kAutostart.test_1 | marionette_driver.errors.JavascriptException: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: C:\Users\task_1645744163\build\tests\marionette\tests\toolkit\xre\test\marionette\test_win32k_enrollment.py :: <TOP_LEVEL> :: line 52" data: no]
[task 2022-02-24T23:48:39.034Z] 23:48:39 INFO - stacktrace:
[task 2022-02-24T23:48:39.034Z] 23:48:39 INFO - @C:\Users\task_1645744163\build\tests\marionette\tests\toolkit\xre\test\marionette\test_win32k_enrollment.py:52:29
[task 2022-02-24T23:48:39.035Z] 23:48:39 INFO - @C:\Users\task_1645744163\build\tests\marionette\tests\toolkit\xre\test\marionette\test_win32k_enrollment.py:53:8
[task 2022-02-24T23:48:39.035Z] 23:48:39 INFO - evaluate.sandbox/promise<@chrome://remote/content/marionette/evaluate.js:157:10
[task 2022-02-24T23:48:39.035Z] 23:48:39 INFO - evaluate.sandbox@chrome://remote/content/marionette/evaluate.js:133:17
[task 2022-02-24T23:48:39.036Z] 23:48:39 INFO - executeScript@chrome://remote/content/marionette/actors/MarionetteCommandsChild.jsm:223:21
[task 2022-02-24T23:48:39.036Z] 23:48:39 INFO - receiveMessage@chrome://remote/content/marionette/actors/MarionetteCommandsChild.jsm:95:31
[task 2022-02-24T23:48:39.036Z] 23:48:39 INFO - Traceback (most recent call last):
[task 2022-02-24T23:48:39.037Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 183, in run
[task 2022-02-24T23:48:39.037Z] 23:48:39 INFO - self.setUp()
[task 2022-02-24T23:48:39.038Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\tests\marionette\tests\toolkit\xre\test\marionette\test_win32k_enrollment.py", line 181, in setUp
[task 2022-02-24T23:48:39.038Z] 23:48:39 INFO - self.default_is = self.execute_script(prefJS)
[task 2022-02-24T23:48:39.038Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\tests\marionette\tests\toolkit\xre\test\marionette\test_win32k_enrollment.py", line 51, in execute_script
[task 2022-02-24T23:48:39.039Z] 23:48:39 INFO - code, new_sandbox=False, sandbox=self.SANDBOX_NAME, *args, **kwargs
[task 2022-02-24T23:48:39.039Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 1693, in execute_script
[task 2022-02-24T23:48:39.039Z] 23:48:39 INFO - rv = self._send_message("WebDriver:ExecuteScript", body, key="value")
[task 2022-02-24T23:48:39.040Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\venv\lib\site-packages\marionette_driver\decorators.py", line 27, in _
[task 2022-02-24T23:48:39.040Z] 23:48:39 INFO - return func(*args, **kwargs)
[task 2022-02-24T23:48:39.041Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 668, in _send_message
[task 2022-02-24T23:48:39.041Z] 23:48:39 INFO - self._handle_error(err)
[task 2022-02-24T23:48:39.041Z] 23:48:39 INFO - File "C:\Users\task_1645744163\build\venv\lib\site-packages\marionette_driver\marionette.py", line 680, in _handle_error
[task 2022-02-24T23:48:39.042Z] 23:48:39 INFO - raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2022-02-24T23:48:39.042Z] 23:48:39 INFO - TEST-INFO took 123ms
[task 2022-02-24T23:48:39.042Z] 23:48:39 INFO - 1645746519034 Marionette DEBUG 2 -> [0,22,"WebDriver:DeleteSession",{}]
[task 2022-02-24T23:48:39.042Z] 23:48:39 INFO - 1645746519036 Marionette DEBUG 2 <- [1,22,null,{"value":null}]
[task 2022-02-24T23:48:39.043Z] 23:48:39 INFO - TEST-START | toolkit/xre/test/marionette/test_win32k_enrollment.py TestWin32kAutostart.test_10
Comment 1•4 years ago
|
||
Hello Bob, can you please take a look at this?
Comment 2•4 years ago
|
||
Set release status flags based on info from the regressing bug 1750742
| Assignee | ||
Comment 3•4 years ago
|
||
(In reply to Cristian Tuns from comment #1)
Hello Bob, can you please take a look at this?
Yes I'll pick this up now.
| Assignee | ||
Comment 4•4 years ago
|
||
I guess the issue here is that ccov doesn't have the sandbox enabled.
What I really don't understand is why this wasn't failing before we flipped the pref to turn on win32k lockdown.
| Assignee | ||
Comment 5•4 years ago
|
||
Got it ... when we enabled win32k lockdown on Nightly we removed the Nightly experiment and moved the pref back into the MOZ_SANDBOX #if.
The Nightly experiments can't have #ifs.
Anyway I guess we should just skip this when the sandbox is disabled.
Updated•4 years ago
|
| Assignee | ||
Comment 6•4 years ago
|
||
CCov builds don't enable the sandbox so win32k test is not relevant.
Comment 8•4 years ago
|
||
| bugherder | ||
| Comment hidden (Intermittent Failures Robot) |
Description
•