1510014 - Intermittent gfx\tests\marionette\test_pref_rollout_workaround.py WrPrefRolloutWorkAroundTestCase.test_wr_rollout_workaround_on_non_qualifying_hw | AssertionError: Should start out as WR opt-in

Status: RESOLVED INCOMPLETE

(Core :: Graphics, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=213891371&repo=mozilla-central

https://queue.taskcluster.net/v1/task/O1mwgmKPS6qvJ3JzbqiBUg/runs/0/artifacts/public/logs/live_backing.log

18:20:47     INFO -  TEST-START | gfx\tests\marionette\test_pref_rollout_workaround.py WrPrefRolloutWorkAroundTestCase.test_wr_rollout_workaround_on_non_qualifying_hw
18:20:47     INFO -  1543256447966	Marionette	DEBUG	Accepted connection 5 from 127.0.0.1:49898
18:20:47     INFO -  1543256447968	Marionette	TRACE	5 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
18:20:47     INFO -  1543256447969	Marionette	DEBUG	[6442450945] Frame script loaded
18:20:47     INFO -  1543256447971	Marionette	DEBUG	[6442450945] Frame script registered
18:20:47     INFO -  1543256447972	Marionette	TRACE	5 <- [1,1,null,{"sessionId":"2385f284-f7fc-46b8-b7f7-dd9f85af1e24","capabilities":{"browserName":"firefox","browserVersion":"65.0a ... p\\tmpttf1i7.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
18:20:47     INFO -  1543256447974	Marionette	TRACE	5 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
18:20:47     INFO -  1543256447975	Marionette	TRACE	5 <- [1,2,null,{"value":null}]
18:20:47     INFO -  1543256447979	Marionette	TRACE	5 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
18:20:47     INFO -  1543256447981	Marionette	TRACE	5 <- [1,3,null,{"value":null}]
18:20:47     INFO -  1543256447982	Marionette	TRACE	5 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
18:20:47     INFO -  1543256447983	Marionette	TRACE	5 <- [1,4,null,{"value":null}]
18:20:47     INFO -  1543256447985	Marionette	TRACE	5 -> [0,5,"Marionette:GetContext",{}]
18:20:47     INFO -  1543256447986	Marionette	TRACE	5 <- [1,5,null,{"value":"content"}]
18:20:47     INFO -  1543256447988	Marionette	TRACE	5 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
18:20:47     INFO -  1543256447989	Marionette	TRACE	5 <- [1,6,null,{"value":null}]
18:20:48     INFO -  1543256447996	Marionette	TRACE	5 -> [0,7,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["gfx.webrender.all.qualified.gfxPref-default-o ... = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","sandbox":"default","line":932}]
18:20:48     INFO -  1543256447998	Marionette	TRACE	5 <- [1,7,null,{"value":null}]
18:20:48     INFO -  1543256448000	Marionette	TRACE	5 -> [0,8,"Marionette:SetContext",{"value":"content"}]
18:20:48     INFO -  1543256448000	Marionette	TRACE	5 <- [1,8,null,{"value":null}]
18:20:48     INFO -  1543256448002	Marionette	TRACE	5 -> [0,9,"Marionette:GetContext",{}]
18:20:48     INFO -  1543256448002	Marionette	TRACE	5 <- [1,9,null,{"value":"content"}]
18:20:48     INFO -  1543256448003	Marionette	TRACE	5 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
18:20:48     INFO -  1543256448004	Marionette	TRACE	5 <- [1,10,null,{"value":null}]
18:20:48     INFO -  1543256448006	Marionette	TRACE	5 -> [0,11,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["gfx.webrender.all.qualified.hardware-overrid ... = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","sandbox":"default","line":932}]
18:20:48     INFO -  1543256448008	Marionette	TRACE	5 <- [1,11,null,{"value":null}]
18:20:48     INFO -  1543256448010	Marionette	TRACE	5 -> [0,12,"Marionette:SetContext",{"value":"content"}]
18:20:48     INFO -  1543256448010	Marionette	TRACE	5 <- [1,12,null,{"value":null}]
18:20:48     INFO -  1543256448012	Marionette	TRACE	5 -> [0,13,"Marionette:GetContext",{}]
18:20:48     INFO -  1543256448012	Marionette	TRACE	5 <- [1,13,null,{"value":"content"}]
18:20:48     INFO -  1543256448014	Marionette	TRACE	5 -> [0,14,"Marionette:SetContext",{"value":"chrome"}]
18:20:48     INFO -  1543256448015	Marionette	TRACE	5 <- [1,14,null,{"value":null}]
18:20:48     INFO -  1543256448017	Marionette	TRACE	5 -> [0,15,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["layers.acceleration.force-enabled",true,fals ... = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","sandbox":"default","line":932}]
18:20:48     INFO -  1543256448020	Marionette	TRACE	5 <- [1,15,null,{"value":null}]
18:20:48     INFO -  1543256448022	Marionette	TRACE	5 -> [0,16,"Marionette:SetContext",{"value":"content"}]
18:20:48     INFO -  1543256448022	Marionette	TRACE	5 <- [1,16,null,{"value":null}]
18:20:48     INFO -  1543256448023	Marionette	TRACE	5 -> [0,17,"Marionette:GetContext",{}]
18:20:48     INFO -  1543256448024	Marionette	TRACE	5 <- [1,17,null,{"value":"content"}]
18:20:48     INFO -  1543256448025	Marionette	TRACE	5 -> [0,18,"Marionette:AcceptConnections",{"value":false}]
18:20:48     INFO -  1543256448026	Marionette	INFO	Stopped listening on port 2828
18:20:48     INFO -  1543256448026	Marionette	TRACE	5 <- [1,18,null,{"value":null}]
18:20:48     INFO -  1543256448028	Marionette	TRACE	5 -> [0,19,"Marionette:GetContext",{}]
18:20:48     INFO -  1543256448028	Marionette	TRACE	5 <- [1,19,null,{"value":"content"}]
18:20:48     INFO -  1543256448030	Marionette	TRACE	5 -> [0,20,"Marionette:SetContext",{"value":"chrome"}]
18:20:48     INFO -  1543256448030	Marionette	TRACE	5 <- [1,20,null,{"value":null}]
18:20:48     INFO -  1543256448032	Marionette	TRACE	5 -> [0,21,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"Z:\\task_1543256028\\build\\ven ... ancelQuit, \"quit-application-requested\", null);\n                return cancelQuit.data;","sandbox":"default","line":1067}]
18:20:48     INFO -  1543256448038	Marionette	TRACE	5 <- [1,21,null,{"value":false}]
18:20:48     INFO -  1543256448039	Marionette	TRACE	5 -> [0,22,"Marionette:SetContext",{"value":"content"}]
18:20:48     INFO -  1543256448039	Marionette	TRACE	5 <- [1,22,null,{"value":null}]
18:20:48     INFO -  1543256448041	Marionette	TRACE	5 -> [0,23,"Marionette:Quit",{"flags":["eForceQuit","eRestart"]}]
18:20:48     INFO -  1543256448137	Marionette	TRACE	5 <- [1,23,null,{"cause":"restart"}]
18:20:48     INFO -  JavaScript error: jar:file:///Z:/task_1543256028/build/application/firefox/omni.ja!/components/nsUrlClassifierListManager.js, line 597: TypeError: this.tablesData[table] is undefined; can't access its "provider" property
18:20:48     INFO -  [Child 4720, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  [Child 4720, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  [Parent 3764, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  [Child 7652, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  1543256448248	Marionette	DEBUG	Closed connection 5
18:20:48     INFO -  [Child 2532, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  [Child 2532, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346
18:20:48     INFO -  [Parent 3764, Gecko_IOThread] WARNING: file z:/build/build/src/ipc/chromium/src/base/process_util_win.cc, line 188
18:20:48     INFO -  1543256448540	Marionette	DEBUG	Received observer notification xpcom-will-shutdown
18:20:48     INFO -  1543256448540	Marionette	DEBUG	Remote service is inactive
18:20:48     INFO -  [GPU 7780, Chrome_ChildThrea
18:20:48     INFO -  ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
18:20:50     INFO -  self.wr_status()=unavailable,basic
18:20:50    ERROR -  TEST-UNEXPECTED-FAIL | gfx\tests\marionette\test_pref_rollout_workaround.py WrPrefRolloutWorkAroundTestCase.test_wr_rollout_workaround_on_non_qualifying_hw | AssertionError: Should start out as WR opt-in
18:20:50     INFO -  Traceback (most recent call last):
18:20:50     INFO -    File "Z:\task_1543256028\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 159, in run
18:20:50     INFO -      testMethod()
18:20:50     INFO -    File "Z:\task_1543256028\build\tests\marionette\tests\gfx\tests\marionette\test_pref_rollout_workaround.py", line 40, in test_wr_rollout_workaround_on_non_qualifying_hw
18:20:50     INFO -      self.assertEqual(status, 'opt-in', 'Should start out as WR opt-in')
18:20:50     INFO -  TEST-INFO took 2832ms
18:20:50     INFO -  TEST-START | gfx\tests\marionette\test_pref_rollout_workaround.py WrPrefRolloutWorkAroundTestCase.test_wr_rollout_workaround_on_qualifying_hw
18:20:53     INFO -  self.wr_status()=unavailable,basic

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:
* mozilla-inbound: 1
* autoland: 7
* mozilla-central: 1

Platform breakdown:
* windows10-64: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2018-11-26&endday=2018-12-02&tree=all

Comment 2

[Intermittent Failures Robot]

4 failures in 1862 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 2
* autoland: 2

Platform breakdown:
* windows10-64: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2018-12-03&endday=2018-12-09&tree=all

Comment 3

[Intermittent Failures Robot]

2 failures in 2485 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1
* mozilla-inbound: 1

Platform breakdown:
* windows10-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2018-12-10&endday=2018-12-16&tree=all

Comment 4

[Intermittent Failures Robot]

5 failures in 2648 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* autoland: 4

Platform breakdown:
* windows10-64: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2018-12-17&endday=2018-12-23&tree=all

Comment 5

[Intermittent Failures Robot]

2 failures in 1668 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1
* mozilla-beta: 1

Platform breakdown:
* windows10-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2018-12-31&endday=2019-01-06&tree=all

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3
• mozilla-inbound: 3
• mozilla-central: 1

Platform breakdown:

• windows10-64: 7

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2019-01-07&endday=2019-01-13&tree=all

Comment 7

[Intermittent Failures Robot]

3 failures in 2378 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 2
• mozilla-inbound: 1

Platform breakdown:

• windows10-64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2019-01-14&endday=2019-01-20&tree=all

Comment 8

[Intermittent Failures Robot]

1 failures in 2628 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2019-01-28&endday=2019-02-03&tree=all

Comment 9

[Intermittent Failures Robot]

4 failures in 2658 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3
• mozilla-inbound: 1

Platform breakdown:

• windows10-64: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2019-02-04&endday=2019-02-10&tree=all

Comment 10

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Comment 11

[Intermittent Failures Robot]

1 failures in 2818 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-beta: 1

Platform breakdown:

• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1510014&startday=2019-03-04&endday=2019-03-10&tree=all