Closed Bug 1632898 Opened 4 years ago Closed 4 years ago

Intermittent toolkit/components/pictureinpicture/tests/browser_durationChange.js | Uncaught exception - at resource://testing-common/BrowserTestUtils.jsm:996 - TypeError: can't access property "getAttribute", win.document.documentElement is null

Categories

(Toolkit :: Video/Audio Controls, defect, P5)

Product:
Toolkit
Component:
Video/Audio Controls
Type:
defect

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1630211

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

...
...
[task 2020-04-24T15:35:41.848Z] 15:35:41     INFO - Hovering the toggle rect now.
[task 2020-04-24T15:35:41.849Z] 15:35:41     INFO - Right-clicking on toggle.
[task 2020-04-24T15:35:41.850Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - [] deepEqual [] - 
[task 2020-04-24T15:35:41.851Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No Picture-in-Picture window found. - 
[task 2020-04-24T15:35:41.851Z] 15:35:41     INFO - Clicking on toggle, and expecting no Picture-in-Picture window opens
[task 2020-04-24T15:35:41.852Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - [] deepEqual [] - 
[task 2020-04-24T15:35:41.853Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No Picture-in-Picture window found. - 
[task 2020-04-24T15:35:41.853Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] - 
[task 2020-04-24T15:35:41.854Z] 15:35:41     INFO - Testing video with id: no-controls
[task 2020-04-24T15:35:41.855Z] 15:35:41     INFO - Checking toggle policy
[task 2020-04-24T15:35:41.855Z] 15:35:41     INFO - Buffered messages logged at 15:35:37
[task 2020-04-24T15:35:41.856Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No toggle policy should be set. - true == true - 
[task 2020-04-24T15:35:41.857Z] 15:35:41     INFO - Hovering the toggle rect now.
[task 2020-04-24T15:35:41.857Z] 15:35:41     INFO - Right-clicking on toggle.
[task 2020-04-24T15:35:41.858Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup"] deepEqual ["pointerdown","mousedown","pointerup","mouseup"] - 
[task 2020-04-24T15:35:41.858Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No Picture-in-Picture window found. - 
[task 2020-04-24T15:35:41.859Z] 15:35:41     INFO - Clicking on toggle, and expecting no Picture-in-Picture window opens
[task 2020-04-24T15:35:41.862Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] - 
[task 2020-04-24T15:35:41.863Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No Picture-in-Picture window found. - 
[task 2020-04-24T15:35:41.864Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - ["pointerdown","mousedown","pointerup","mouseup","click"] deepEqual ["pointerdown","mousedown","pointerup","mouseup","click"] - 
[task 2020-04-24T15:35:41.865Z] 15:35:41     INFO - Buffered messages logged at 15:35:40
[task 2020-04-24T15:35:41.866Z] 15:35:41     INFO - Waiting for videos to be ready
[task 2020-04-24T15:35:41.867Z] 15:35:41     INFO - Testing video with id: with-controls
[task 2020-04-24T15:35:41.867Z] 15:35:41     INFO - Checking toggle policy
[task 2020-04-24T15:35:41.868Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No toggle policy should be set. - true == true - 
[task 2020-04-24T15:35:41.869Z] 15:35:41     INFO - Waiting for toggle to become visible
[task 2020-04-24T15:35:41.870Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Toggle reached target opacity. - true == true - 
[task 2020-04-24T15:35:41.877Z] 15:35:41     INFO - Hovering the toggle rect now.
[task 2020-04-24T15:35:41.879Z] 15:35:41     INFO - Waiting for toggle to reach full opacity
[task 2020-04-24T15:35:41.880Z] 15:35:41     INFO - Buffered messages logged at 15:35:41
[task 2020-04-24T15:35:41.881Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Toggle reached target opacity. - true == true - 
[task 2020-04-24T15:35:41.882Z] 15:35:41     INFO - Right-clicking on toggle.
[task 2020-04-24T15:35:41.883Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Expected to get the right mouse events. - [] deepEqual [] - 
[task 2020-04-24T15:35:41.884Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | No Picture-in-Picture window found. - 
[task 2020-04-24T15:35:41.885Z] 15:35:41     INFO - Clicking on toggle, and expecting a Picture-in-Picture window to open
[task 2020-04-24T15:35:41.885Z] 15:35:41     INFO - TEST-PASS | toolkit/components/pictureinpicture/tests/browser_durationChange.js | A Picture-in-Picture window opened. - 
[task 2020-04-24T15:35:41.887Z] 15:35:41     INFO - Buffered messages finished
[task 2020-04-24T15:35:41.888Z] 15:35:41     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Uncaught exception - at resource://testing-common/BrowserTestUtils.jsm:996 - TypeError: can't access property "getAttribute", win.document.documentElement is null
[task 2020-04-24T15:35:41.888Z] 15:35:41     INFO - Stack trace:
[task 2020-04-24T15:35:41.889Z] 15:35:41     INFO - windowClosed@resource://testing-common/BrowserTestUtils.jsm:996:19
[task 2020-04-24T15:35:41.890Z] 15:35:41     INFO - closeWindow@resource://testing-common/BrowserTestUtils.jsm:977:42
[task 2020-04-24T15:35:41.890Z] 15:35:41     INFO - testToggleHelper@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:512:28
[task 2020-04-24T15:35:41.891Z] 15:35:41     INFO - async*testToggle/<@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:379:15
[task 2020-04-24T15:35:41.892Z] 15:35:41     INFO - async*withNewTab@resource://testing-common/BrowserTestUtils.jsm:146:24
[task 2020-04-24T15:35:41.892Z] 15:35:41     INFO - async*testToggle@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/head.js:364:26
[task 2020-04-24T15:35:41.893Z] 15:35:41     INFO - test_durationChange@chrome://mochitests/content/browser/toolkit/components/pictureinpicture/tests/browser_durationChange.js:39:9
[task 2020-04-24T15:35:41.894Z] 15:35:41     INFO - Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1039:34
[task 2020-04-24T15:35:41.894Z] 15:35:41     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1074:11
[task 2020-04-24T15:35:41.895Z] 15:35:41     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:904:14
[task 2020-04-24T15:35:41.896Z] 15:35:41     INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:918:23
[task 2020-04-24T15:35:41.897Z] 15:35:41     INFO - Leaving test bound test_durationChange
[task 2020-04-24T15:35:41.898Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f9624f2f000 == 2 [pid = 10340] [id = {e6603ca2-c04f-44d8-ac0a-03d0b5cc6e8b}]
[task 2020-04-24T15:35:41.898Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7f9640493520) [pid = 10340] [serial = 17] [outer = (nil)]
[task 2020-04-24T15:35:41.899Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x7f9624f30c00) [pid = 10340] [serial = 18] [outer = 0x7f9640493520]
[task 2020-04-24T15:35:41.900Z] 15:35:41     INFO - GECKO(10209) | [Child 11064: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f20b0e7b400 == 2 [pid = 11064] [id = {29a933c5-1cfe-4a97-839d-fee87a9a5247}]
[task 2020-04-24T15:35:41.900Z] 15:35:41     INFO - GECKO(10209) | [Child 11064: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (0x7f20d8093180) [pid = 11064] [serial = 4] [outer = (nil)]
[task 2020-04-24T15:35:41.900Z] 15:35:41     INFO - GECKO(10209) | [Child 11064: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7f20b0e7d800) [pid = 11064] [serial = 5] [outer = 0x7f20d8093180]
[task 2020-04-24T15:35:41.901Z] 15:35:41     INFO - GECKO(10209) | MEMORY STAT | vsize 3619MB | residentFast 390MB | heapAllocated 140MB
[task 2020-04-24T15:35:41.901Z] 15:35:41     INFO - TEST-OK | toolkit/components/pictureinpicture/tests/browser_durationChange.js | took 6579ms
[task 2020-04-24T15:35:41.902Z] 15:35:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-04-24T15:35:41.902Z] 15:35:41     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Found an unexpected tab at the end of test run: http://example.com/browser/toolkit/components/pictureinpicture/tests/test-page.html - 
[task 2020-04-24T15:35:41.902Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f9624f31400 == 3 [pid = 10340] [id = {1b4a1ae4-5021-433d-b462-f928b678adcf}]
[task 2020-04-24T15:35:41.903Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (0x7f96404936f0) [pid = 10340] [serial = 19] [outer = (nil)]
[task 2020-04-24T15:35:41.903Z] 15:35:41     INFO - GECKO(10209) | [Child 10340: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 8 (0x7f9624f3c000) [pid = 10340] [serial = 20] [outer = 0x7f96404936f0]
[task 2020-04-24T15:35:41.903Z] 15:35:41     INFO - checking window state
[task 2020-04-24T15:35:41.904Z] 15:35:41     INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-04-24T15:35:41.905Z] 15:35:41     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pictureinpicture/tests/browser_durationChange.js | Found an unexpected Toolkit:PictureInPicture at the end of test run -

Bugbug thinks this bug should belong to this component, but please revert this change in case of error.

Component: General → Video/Audio Controls
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.