Closed Bug 1609004 Opened 6 years ago Closed 6 years ago

ubuntu1804 - toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No toggle policy should be set. - false == true - got false, expected true (operator ==)

Categories

(Toolkit :: General, defect, P5)

Product:
Toolkit
Component:
General
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1552288

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

Filed by: egao [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=284349327&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/WcLrWYfvSrO6p5HLDsKjZg/runs/0/artifacts/public/logs/live_backing.log

suite: browser-chrome
chunk: 2

notes: shippable

context:
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - TEST-START | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Buffered messages logged at 08:31:50
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Entering test bound
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Buffered messages finished
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_togglePolicies.js | Uncaught exception received from previously timed out test - [Exception... "(null)" nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)" location: "<unknown>" data: no]
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Waiting for videos to be ready
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Testing video with id: video-transparent-background
[task 2020-01-10T08:31:50.863Z] 08:31:50 INFO - Checking toggle policy
[task 2020-01-10T08:31:50.917Z] 08:31:50 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-10T08:31:50.917Z] 08:31:50 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No toggle policy should be set. - false == true - got false, expected true (operator ==)
[task 2020-01-10T08:31:50.917Z] 08:31:50 INFO - Stack trace:
[task 2020-01-10T08:31:50.918Z] 08:31:50 INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:193:14
[task 2020-01-10T08:31:50.918Z] 08:31:50 INFO - asyncexecute@resource://specialpowers/SpecialPowersSandbox.jsm:140:12
[task 2020-01-10T08:31:50.918Z] 08:31:50 INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1723:15
[task 2020-01-10T08:31:50.918Z] 08:31:50 INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:285:21
[task 2020-01-10T08:31:50.918Z] 08:31:50 INFO - JSWindowActor queryreceiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1055:12
[task 2020-01-10T08:31:50.919Z] 08:31:50 INFO - JSWindowActor queryspawn@resource://specialpowers/SpecialPowersChild.jsm:1678:17
[task 2020-01-10T08:31:50.919Z] 08:31:50 INFO - assertTogglePolicy@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:169:23
[task 2020-01-10T08:31:50.919Z] 08:31:50 INFO - testToggleHelper@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:419:9
[task 2020-01-10T08:31:50.919Z] 08:31:50 INFO - asynctestToggle/<@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:378:15
[task 2020-01-10T08:31:50.920Z] 08:31:50 INFO - asyncwithNewTab@resource://testing-common/BrowserTestUtils.jsm:150:24
[task 2020-01-10T08:31:50.920Z] 08:31:50 INFO - asynctestToggle@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:363:26
[task 2020-01-10T08:31:50.920Z] 08:31:50 INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js:12:9
[task 2020-01-10T08:31:50.920Z] 08:31:50 INFO - Tester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-01-10T08:31:50.920Z] 08:31:50 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-01-10T08:31:50.921Z] 08:31:50 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-01-10T08:31:50.921Z] 08:31:50 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:808:67
[task 2020-01-10T08:31:50.921Z] 08:31:50 INFO - Waiting for toggle to become visible
[task 2020-01-10T08:31:51.022Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true -
[task 2020-01-10T08:31:51.023Z] 08:31:51 INFO - Hovering the toggle rect now.
[task 2020-01-10T08:31:51.025Z] 08:31:51 INFO - Waiting for toggle to reach full opacity
[task 2020-01-10T08:31:51.233Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true -
[task 2020-01-10T08:31:51.233Z] 08:31:51 INFO - Right-clicking on toggle.
[task 2020-01-10T08:31:51.241Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup"] deepEqual ["pointerdown","mousedown","pointerup","mouseup"] -
[task 2020-01-10T08:31:51.241Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No Picture-in-Picture window found. -
[task 2020-01-10T08:31:51.242Z] 08:31:51 INFO - Clicking on toggle, and expecting a Picture-in-Picture window to open
[task 2020-01-10T08:31:51.263Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | A Picture-in-Picture window opened. -
[task 2020-01-10T08:31:51.263Z] 08:31:51 INFO - Console message: [JavaScript Warning: "pictureinpicture.opened_method - Unknown scalar."]
[task 2020-01-10T08:31:51.263Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - [] deepEqual [] -
[task 2020-01-10T08:31:51.263Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] -
[task 2020-01-10T08:31:51.267Z] 08:31:51 INFO - Testing video with id: video-alpha-background
[task 2020-01-10T08:31:51.375Z] 08:31:51 INFO - Checking toggle policy
[task 2020-01-10T08:31:51.579Z] 08:31:51 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-10T08:31:51.579Z] 08:31:51 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No toggle policy should be set. - false == true - got false, expected true (operator ==)
[task 2020-01-10T08:31:51.579Z] 08:31:51 INFO - Stack trace:
[task 2020-01-10T08:31:51.580Z] 08:31:51 INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:193:14
[task 2020-01-10T08:31:51.580Z] 08:31:51 INFO - asyncexecute@resource://specialpowers/SpecialPowersSandbox.jsm:140:12
[task 2020-01-10T08:31:51.580Z] 08:31:51 INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1723:15
[task 2020-01-10T08:31:51.581Z] 08:31:51 INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:285:21
[task 2020-01-10T08:31:51.581Z] 08:31:51 INFO - JSWindowActor queryreceiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1055:12
[task 2020-01-10T08:31:51.581Z] 08:31:51 INFO - JSWindowActor queryspawn@resource://specialpowers/SpecialPowersChild.jsm:1678:17
[task 2020-01-10T08:31:51.581Z] 08:31:51 INFO - assertTogglePolicy@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:169:23
[task 2020-01-10T08:31:51.582Z] 08:31:51 INFO - testToggleHelper@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:419:9
[task 2020-01-10T08:31:51.582Z] 08:31:51 INFO - asynctestToggle/<@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:378:15
[task 2020-01-10T08:31:51.582Z] 08:31:51 INFO - asyncwithNewTab@resource://testing-common/BrowserTestUtils.jsm:150:24
[task 2020-01-10T08:31:51.582Z] 08:31:51 INFO - asynctestToggle@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:363:26
[task 2020-01-10T08:31:51.583Z] 08:31:51 INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js:12:9
[task 2020-01-10T08:31:51.584Z] 08:31:51 INFO - Tester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-01-10T08:31:51.584Z] 08:31:51 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-01-10T08:31:51.584Z] 08:31:51 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-01-10T08:31:51.584Z] 08:31:51 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:808:67
[task 2020-01-10T08:31:51.592Z] 08:31:51 INFO - Waiting for toggle to become visible
[task 2020-01-10T08:31:51.693Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true -
[task 2020-01-10T08:31:51.695Z] 08:31:51 INFO - Hovering the toggle rect now.
[task 2020-01-10T08:31:51.696Z] 08:31:51 INFO - Waiting for toggle to reach full opacity
[task 2020-01-10T08:31:51.901Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true -
[task 2020-01-10T08:31:51.901Z] 08:31:51 INFO - Right-clicking on toggle.
[task 2020-01-10T08:31:51.908Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup"] deepEqual ["pointerdown","mousedown","pointerup","mouseup"] -
[task 2020-01-10T08:31:51.909Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No Picture-in-Picture window found. -
[task 2020-01-10T08:31:51.909Z] 08:31:51 INFO - Clicking on toggle, and expecting a Picture-in-Picture window to open
[task 2020-01-10T08:31:51.917Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | A Picture-in-Picture window opened. -
[task 2020-01-10T08:31:51.920Z] 08:31:51 INFO - Console message: [JavaScript Warning: "pictureinpicture.opened_method - Unknown scalar."]
[task 2020-01-10T08:31:51.924Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - [] deepEqual [] -
[task 2020-01-10T08:31:51.933Z] 08:31:51 INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] -
[task 2020-01-10T08:31:51.949Z] 08:31:51 INFO - Leaving test bound
[task 2020-01-10T08:31:51.973Z] 08:31:51 INFO - GECKO(14070) | MEMORY STAT | vsize 3593MB | residentFast 318MB | heapAllocated 102MB
[task 2020-01-10T08:31:51.973Z] 08:31:51 INFO - TEST-OK | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | took 1636ms
[task 2020-01-10T08:31:51.996Z] 08:31:51 INFO - checking window state

:mconley - I've ni'd you directly as searchfox tells me you wrote this test back in April 2019.

Would you be able to glean why this test fails at high intermittent rate on ubuntu1804 only in shippable/opt?

try: https://treeherder.mozilla.org/#/jobs?repo=try&group_state=expanded&selectedJob=284347248&tier=1%2C2%2C3&revision=eb7fca553fdee919f26cb9670b72dea812a89463&searchStr=browser-chrome

Flags: needinfo?(mconley)

Looks like a duplicate of bug 1552288.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE

To be clear, does the frequency of failing increase on ubuntu1804 for this test? Or does bug 1552288 cover it, and this is just a dupe?

Flags: needinfo?(mconley) → needinfo?(egao)

I have a push with the most recent mozilla-central running at the moment, but I recall that the failure frequency of this test increases significantly with ubuntu1804.

Here's the push: https://treeherder.mozilla.org/#/jobs?repo=try&revision=8da925c20c5aa35dc59e3dbf96579e22791e1add
I will make sure to retrigger the mochitest-browser-chrome suites many times to get a good baseline.

Flags: needinfo?(egao)

Seems to only be observable on ubuntu1804 on the asan variant, chunk 3 in the push above.

In the original comment when the bug was filed, it was noted that this failure was observed on shippable.

Log:

[task 2020-01-20T22:31:04.312Z] 22:31:04     INFO - TEST-START | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js
[task 2020-01-20T22:31:04.313Z] 22:31:04     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-20T22:31:04.314Z] 22:31:04     INFO - Buffered messages logged at 22:31:03
[task 2020-01-20T22:31:04.315Z] 22:31:04     INFO - Entering test bound 
[task 2020-01-20T22:31:04.315Z] 22:31:04     INFO - Buffered messages finished
[task 2020-01-20T22:31:04.316Z] 22:31:04     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_togglePolicies.js | Uncaught exception received from previously timed out test - [Exception... "(null)"  nsresult: "0x80040111 (NS_ERROR_NOT_AVAILABLE)"  location: "<unknown>"  data: no]
[task 2020-01-20T22:31:04.541Z] 22:31:04     INFO - Waiting for videos to be ready
[task 2020-01-20T22:31:04.619Z] 22:31:04     INFO - Testing video with id: video-transparent-background
[task 2020-01-20T22:31:04.741Z] 22:31:04     INFO - Checking toggle policy
[task 2020-01-20T22:31:04.963Z] 22:31:04     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-20T22:31:04.966Z] 22:31:04     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No toggle policy should be set. - false == true - got false, expected true (operator ==)
[task 2020-01-20T22:31:04.967Z] 22:31:04     INFO - Stack trace:
[task 2020-01-20T22:31:04.967Z] 22:31:04     INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:193:14
[task 2020-01-20T22:31:04.968Z] 22:31:04     INFO - async*execute@resource://specialpowers/SpecialPowersSandbox.jsm:140:12
[task 2020-01-20T22:31:04.968Z] 22:31:04     INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1723:15
[task 2020-01-20T22:31:04.969Z] 22:31:04     INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:285:21
[task 2020-01-20T22:31:04.969Z] 22:31:04     INFO - JSWindowActor query*receiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1055:12
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - JSWindowActor query*spawn@resource://specialpowers/SpecialPowersChild.jsm:1678:17
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - assertTogglePolicy@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:169:23
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - testToggleHelper@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:419:9
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - async*testToggle/<@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:378:15
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - async*withNewTab@resource://testing-common/BrowserTestUtils.jsm:150:24
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - async*testToggle@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:363:26
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js:12:9
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - Tester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:808:67
[task 2020-01-20T22:31:04.970Z] 22:31:04     INFO - Waiting for toggle to become visible
[task 2020-01-20T22:31:05.087Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true - 
[task 2020-01-20T22:31:05.094Z] 22:31:05     INFO - Hovering the toggle rect now.
[task 2020-01-20T22:31:05.096Z] 22:31:05     INFO - Waiting for toggle to reach full opacity
[task 2020-01-20T22:31:05.318Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true - 
[task 2020-01-20T22:31:05.318Z] 22:31:05     INFO - Right-clicking on toggle.
[task 2020-01-20T22:31:05.333Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup"] deepEqual ["pointerdown","mousedown","pointerup","mouseup"] - 
[task 2020-01-20T22:31:05.334Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No Picture-in-Picture window found. - 
[task 2020-01-20T22:31:05.335Z] 22:31:05     INFO - Clicking on toggle, and expecting a Picture-in-Picture window to open
[task 2020-01-20T22:31:05.371Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | A Picture-in-Picture window opened. - 
[task 2020-01-20T22:31:05.387Z] 22:31:05     INFO - Console message: [JavaScript Warning: "pictureinpicture.opened_method - Unknown scalar."]
[task 2020-01-20T22:31:05.407Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - [] deepEqual [] - 
[task 2020-01-20T22:31:05.443Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] - 
[task 2020-01-20T22:31:05.451Z] 22:31:05     INFO - Testing video with id: video-alpha-background
[task 2020-01-20T22:31:05.567Z] 22:31:05     INFO - Checking toggle policy
[task 2020-01-20T22:31:05.771Z] 22:31:05     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-01-20T22:31:05.774Z] 22:31:05     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No toggle policy should be set. - false == true - got false, expected true (operator ==)
[task 2020-01-20T22:31:05.775Z] 22:31:05     INFO - Stack trace:
[task 2020-01-20T22:31:05.776Z] 22:31:05     INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:193:14
[task 2020-01-20T22:31:05.776Z] 22:31:05     INFO - async*execute@resource://specialpowers/SpecialPowersSandbox.jsm:140:12
[task 2020-01-20T22:31:05.777Z] 22:31:05     INFO - _spawnTask@resource://specialpowers/SpecialPowersChild.jsm:1723:15
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - receiveMessage@resource://specialpowers/SpecialPowersChild.jsm:285:21
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - JSWindowActor query*receiveMessage@resource://specialpowers/SpecialPowersParent.jsm:1055:12
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - JSWindowActor query*spawn@resource://specialpowers/SpecialPowersChild.jsm:1678:17
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - assertTogglePolicy@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:169:23
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - testToggleHelper@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:419:9
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - async*testToggle/<@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:378:15
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - async*withNewTab@resource://testing-common/BrowserTestUtils.jsm:150:24
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - async*testToggle@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:363:26
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - @chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js:12:9
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - Tester_execTest/<@chrome://mochikit/content/browser-test.js:1062:34
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1097:11
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:925:14
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:808:67
[task 2020-01-20T22:31:05.778Z] 22:31:05     INFO - Waiting for toggle to become visible
[task 2020-01-20T22:31:05.892Z] 22:31:05     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true - 
[task 2020-01-20T22:31:05.892Z] 22:31:05     INFO - Hovering the toggle rect now.
[task 2020-01-20T22:31:05.892Z] 22:31:05     INFO - Waiting for toggle to reach full opacity
[task 2020-01-20T22:31:06.109Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Toggle reached target opacity. - true == true - 
[task 2020-01-20T22:31:06.109Z] 22:31:06     INFO - Right-clicking on toggle.
[task 2020-01-20T22:31:06.117Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup"] deepEqual ["pointerdown","mousedown","pointerup","mouseup"] - 
[task 2020-01-20T22:31:06.117Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | No Picture-in-Picture window found. - 
[task 2020-01-20T22:31:06.117Z] 22:31:06     INFO - Clicking on toggle, and expecting a Picture-in-Picture window to open
[task 2020-01-20T22:31:06.140Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | A Picture-in-Picture window opened. - 
[task 2020-01-20T22:31:06.148Z] 22:31:06     INFO - Console message: [JavaScript Warning: "pictureinpicture.opened_method - Unknown scalar."]
[task 2020-01-20T22:31:06.164Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - [] deepEqual [] - 
[task 2020-01-20T22:31:06.192Z] 22:31:06     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] - 
[task 2020-01-20T22:31:06.233Z] 22:31:06     INFO - Leaving test bound 
[task 2020-01-20T22:31:06.311Z] 22:31:06     INFO - GECKO(5197) | MEMORY STAT | vsize 20975730MB | residentFast 1112MB
[task 2020-01-20T22:31:06.312Z] 22:31:06     INFO - TEST-OK | toolkit/components/pictureinpicture/tests/browser_toggleTransparentOverlay-1.js | took 2402ms
You need to log in before you can comment on or make changes to this bug.