Closed Bug 1592465 Opened 5 years ago Closed 5 years ago

Intermittent docshell/test/navigation/browser_bug343515.js | Tab 2 should have 2 iframes - 1 == 2 - | Test timed out - | A promise chain failed to handle a rejection: TypeError: aWindow is undefined - stack: JS frame :: resource://*/Promise-backend.js ::

Categories

(Core :: DOM: Navigation, defect)

defect
Not set
normal

Tracking

()

RESOLVED FIXED
mozilla72
Tracking Status
firefox-esr68 --- unaffected
firefox70 --- unaffected
firefox71 --- unaffected
firefox72 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: mccr8)

References

(Regression)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [stockwell needswork:owner])

Attachments

(1 file)

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=273561597&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/R7e8WPx0Q5O7Zg4_HXFmoA/runs/0/artifacts/public/logs/live_backing.log


[task 2019-10-29T22:43:04.138Z] 22:43:04 INFO - TEST-START | docshell/test/navigation/browser_bug343515.js
[task 2019-10-29T22:43:04.138Z] 22:43:04 INFO - GECKO(9888) | Chrome file doesn't exist: Z:\task_1572385913\build\tests\mochitest\browser\docshell\test\navigation\head.js
[task 2019-10-29T22:43:04.197Z] 22:43:04 INFO - GECKO(9888) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1572385913\appdata\local\temp\tmpkc7yup.mozrunner\runtests_leaks_tab_pid8476.log
[task 2019-10-29T22:43:04.215Z] 22:43:04 INFO - GECKO(9888) | [Child 8476, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 729
[task 2019-10-29T22:43:04.337Z] 22:43:04 INFO - GECKO(9888) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1572385913\appdata\local\temp\tmpkc7yup.mozrunner\runtests_leaks_tab_pid1088.log
[task 2019-10-29T22:43:04.342Z] 22:43:04 INFO - GECKO(9888) | ++DOCSHELL 0000020DE0555000 == 1 [pid = 8476] [id = {e3d78d5f-f538-4d0a-97a4-fa2b6137f9de}]
[task 2019-10-29T22:43:04.342Z] 22:43:04 INFO - GECKO(9888) | ++DOMWINDOW == 1 (0000020DE6403020) [pid = 8476] [serial = 1] [outer = 0000000000000000]
[task 2019-10-29T22:43:04.342Z] 22:43:04 INFO - GECKO(9888) | ++DOMWINDOW == 2 (0000020DE647FC00) [pid = 8476] [serial = 2] [outer = 0000020DE6403020]
[task 2019-10-29T22:43:04.361Z] 22:43:04 INFO - GECKO(9888) | [Child 1088, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 729
[task 2019-10-29T22:43:04.513Z] 22:43:04 INFO - GECKO(9888) | ++DOMWINDOW == 3 (0000020DE8480C00) [pid = 8476] [serial = 3] [outer = 0000020DE6403020]
[task 2019-10-29T22:43:04.786Z] 22:43:04 INFO - GECKO(9888) | [Child 8476, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1387
[task 2019-10-29T22:43:04.786Z] 22:43:04 INFO - GECKO(9888) | [Child 8476, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1387
[task 2019-10-29T22:43:05.120Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D737954800 == 1 [pid = 1088] [id = {f48b4fac-7b36-4e11-b68b-ed06b57cfc9b}]
[task 2019-10-29T22:43:05.120Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 1 (000001D7379FD020) [pid = 1088] [serial = 1] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.120Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 2 (000001D73DA68800) [pid = 1088] [serial = 2] [outer = 000001D7379FD020]
[task 2019-10-29T22:43:05.232Z] 22:43:05 INFO - GECKO(9888) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1572385913\appdata\local\temp\tmpkc7yup.mozrunner\runtests_leaks_tab_pid3412.log
[task 2019-10-29T22:43:05.250Z] 22:43:05 INFO - GECKO(9888) | [Child 3412, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 729
[task 2019-10-29T22:43:05.269Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 3 (000001D73E77A800) [pid = 1088] [serial = 3] [outer = 000001D7379FD020]
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | [Child 1088, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1387
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | [Child 1088, Main Thread] WARNING: '!aWin', file z:/build/build/src/dom/base/Document.cpp, line 1387
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D73FE16800 == 2 [pid = 1088] [id = {8cc83030-c2e6-43fa-a400-164a13b01df8}]
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 4 (000001D7379FD5C0) [pid = 1088] [serial = 4] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D73FE17000 == 3 [pid = 1088] [id = {edc71e95-a48f-45f0-937f-0aef6397f529}]
[task 2019-10-29T22:43:05.553Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 5 (000001D7379FD7A0) [pid = 1088] [serial = 5] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.555Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 6 (000001D73FE51800) [pid = 1088] [serial = 6] [outer = 000001D7379FD5C0]
[task 2019-10-29T22:43:05.560Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 7 (000001D73FE53400) [pid = 1088] [serial = 7] [outer = 000001D7379FD7A0]
[task 2019-10-29T22:43:05.670Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 8 (000001D73FEC9000) [pid = 1088] [serial = 8] [outer = 000001D7379FD020]
[task 2019-10-29T22:43:05.680Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D73FE1D800 == 4 [pid = 1088] [id = {c12da70c-b76f-4ff0-802b-596ac23ac35d}]
[task 2019-10-29T22:43:05.680Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 9 (000001D7379FD980) [pid = 1088] [serial = 9] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.719Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 10 (000001D73FECD400) [pid = 1088] [serial = 10] [outer = 000001D7379FD980]
[task 2019-10-29T22:43:05.729Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D73FE1E800 == 5 [pid = 1088] [id = {aca046b8-a372-49a1-a181-dab0708cfbcd}]
[task 2019-10-29T22:43:05.729Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 11 (000001D7379FDB60) [pid = 1088] [serial = 11] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.748Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 12 (000001D73FED0800) [pid = 1088] [serial = 12] [outer = 000001D7379FDB60]
[task 2019-10-29T22:43:05.773Z] 22:43:05 INFO - TEST-INFO | started process screenshot
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - TEST-INFO | screenshot: exit 0
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - Buffered messages logged at 22:43:04
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Got expected tab 1 url in step 2 -
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 0 should still be active -
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 1 should not be active -
[task 2019-10-29T22:43:05.851Z] 22:43:05 INFO - Buffered messages logged at 22:43:05
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 0 should be inactive -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 1 should be active -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Got expected tab 2 url in step 3 -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 0 should be inactive -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 1 should be active -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 2 should be inactive -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 2 should have 2 iframes - 2 == 2 -
[task 2019-10-29T22:43:05.852Z] 22:43:05 INFO - step 3, frame 0 info: data:text/html;charset=UTF8,<html><head></head><body>pg2 iframe 0</body></html>
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab2 iframe 0 should be inactive - true == true -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - step 3, frame 1 info: data:text/html;charset=UTF8,<html><head></head><body>pg2 iframe 1</body></html>
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab2 iframe 1 should be inactive - true == true -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Got expected tab 2 url in step 4 -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 0 should be inactive -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 1 should be active -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - Buffered messages finished
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/browser_bug343515.js | Tab 2 should have 2 iframes - 1 == 2 -
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - Stack trace:
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - resource://testing-common/content-task.js line 110 > eval:null:12
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - resource://testing-common/content-task.js:null:111
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - step 4, frame 0 info: http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg3_1.html
[task 2019-10-29T22:43:05.853Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab 2 iframe 0 should have 1 iframes - 1 == 1 -
[task 2019-10-29T22:43:05.854Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab2 iframe 0 should be inactive - false == false -
[task 2019-10-29T22:43:05.854Z] 22:43:05 INFO - TEST-PASS | docshell/test/navigation/browser_bug343515.js | Tab2 iframe 0 subiframe 0 should be inactive - false == false -
[task 2019-10-29T22:43:05.955Z] 22:43:05 INFO - GECKO(9888) | ++DOCSHELL 000001D73793E000 == 6 [pid = 1088] [id = {b9d878fb-f7c7-44a4-90eb-a204d9b9f750}]
[task 2019-10-29T22:43:05.955Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 13 (000001D7379FDD40) [pid = 1088] [serial = 13] [outer = 0000000000000000]
[task 2019-10-29T22:43:05.973Z] 22:43:05 INFO - GECKO(9888) | ++DOMWINDOW == 14 (000001D740B6A400) [pid = 1088] [serial = 14] [outer = 000001D7379FDD40]
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - Console message: [JavaScript Error: "A promise chain failed to handle a rejection. Did you forget to '.catch', or did you forget to 'return'?
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO -
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - Date: Tue Oct 29 2019 22:43:05 GMT+0000 (Greenwich Mean Time)
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - Full Message: TypeError: aWindow is undefined
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - Full Stack: JS frame :: resource://gre/modules/Promise-backend.js :: register :: line 209
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: completePromise :: line 745
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: process :: line 1004
[task 2019-10-29T22:43:08.230Z] 22:43:08 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: walkerLoop :: line 845"]
[task 2019-10-29T22:43:08.378Z] 22:43:08 INFO - GECKO(9888) | --DOCSHELL 000002108C66D800 == 5 [pid = 2788] [id = {98d679ab-3943-4cc3-9a83-5b77de25bf9a}] [url = chrome://gfxsanity/content/sanityparent.html]
[task 2019-10-29T22:43:09.500Z] 22:43:09 INFO - GECKO(9888) | --DOCSHELL 0000021DC7955800 == 1 [pid = 1292] [id = {d2e6bbb1-20b0-4bcf-aad0-499dbddfceb0}] [url = about:blank]
[task 2019-10-29T22:43:10.862Z] 22:43:10 INFO - GECKO(9888) | --DOCSHELL 000001605C755800 == 1 [pid = 7920] [id = {4b90f3d5-0e0f-4ab7-81ba-aeb5f21537e7}] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2019-10-29T22:43:11.123Z] 22:43:11 INFO - GECKO(9888) | --DOCSHELL 0000014CEFC6C000 == 3 [pid = 5072] [id = {25c649db-aca5-4ca4-a52b-396d00f6848b}] [url = moz-extension://4c45ad98-8c59-4030-8618-35fdfd62a8b4/_generated_background_page.html]
[task 2019-10-29T22:43:12.647Z] 22:43:12 INFO - GECKO(9888) | --DOMWINDOW == 13 (0000021093BA1000) [pid = 2788] [serial = 11] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:12.647Z] 22:43:12 INFO - GECKO(9888) | --DOMWINDOW == 12 (000002109247CC00) [pid = 2788] [serial = 7] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:13.602Z] 22:43:13 INFO - GECKO(9888) | --DOMWINDOW == 6 (0000021DCF86D000) [pid = 1292] [serial = 5] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:13.602Z] 22:43:13 INFO - GECKO(9888) | --DOMWINDOW == 5 (0000021DCD871C00) [pid = 1292] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:13.661Z] 22:43:13 INFO - GECKO(9888) | --DOMWINDOW == 4 (0000021DCD80A020) [pid = 1292] [serial = 1] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:14.960Z] 22:43:14 INFO - GECKO(9888) | --DOMWINDOW == 4 (0000016062778C00) [pid = 7920] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:14.979Z] 22:43:14 INFO - GECKO(9888) | --DOMWINDOW == 3 (000001606270B020) [pid = 7920] [serial = 1] [outer = 0000000000000000] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2019-10-29T22:43:15.220Z] 22:43:15 INFO - GECKO(9888) | --DOMWINDOW == 11 (0000014CEFC9B800) [pid = 5072] [serial = 8] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:15.220Z] 22:43:15 INFO - GECKO(9888) | --DOMWINDOW == 10 (0000014CEEF9AC00) [pid = 5072] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:15.220Z] 22:43:15 INFO - GECKO(9888) | --DOMWINDOW == 9 (0000014CEEF9F800) [pid = 5072] [serial = 6] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:15.220Z] 22:43:15 INFO - GECKO(9888) | --DOMWINDOW == 8 (0000014CEEF9E800) [pid = 5072] [serial = 4] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:15.280Z] 22:43:15 INFO - GECKO(9888) | --DOMWINDOW == 7 (0000014CEEF2E980) [pid = 5072] [serial = 7] [outer = 0000000000000000] [url = moz-extension://4c45ad98-8c59-4030-8618-35fdfd62a8b4/_generated_background_page.html]
[task 2019-10-29T22:43:16.676Z] 22:43:16 INFO - GECKO(9888) | --DOMWINDOW == 2 (0000020DE647FC00) [pid = 8476] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:17.451Z] 22:43:17 INFO - GECKO(9888) | --DOMWINDOW == 13 (000001D73DA68800) [pid = 1088] [serial = 2] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:17.693Z] 22:43:17 INFO - GECKO(9888) | --DOMWINDOW == 3 (0000021DD0155400) [pid = 1292] [serial = 7] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:17.693Z] 22:43:17 INFO - GECKO(9888) | --DOMWINDOW == 2 (0000021DCF860000) [pid = 1292] [serial = 3] [outer = 0000000000000000] [url = about:blank]
[task 2019-10-29T22:43:19.032Z] 22:43:19 INFO - GECKO(9888) | --DOMWINDOW == 2 (000001606346F000) [pid = 7920] [serial = 3] [outer = 0000000000000000] [url = chrome://gfxsanity/content/sanitytest.html]
[task 2019-10-29T22:43:19.314Z] 22:43:19 INFO - GECKO(9888) | --DOMWINDOW == 6 (0000014CEFCA8C00) [pid = 5072] [serial = 12] [outer = 0000000000000000] [url = moz-extension://4c45ad98-8c59-4030-8618-35fdfd62a8b4/_generated_background_page.html]
[task 2019-10-29T22:44:34.155Z] 22:44:34 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-29T22:44:34.155Z] 22:44:34 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/browser_bug343515.js | Test timed out -
[task 2019-10-29T22:44:34.155Z] 22:44:34 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/browser_bug343515.js | A promise chain failed to handle a rejection: TypeError: aWindow is undefined - stack: JS frame :: resource://gre/modules/Promise-backend.js :: register :: line 209
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: completePromise :: line 745
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: process :: line 1004
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - JS frame :: resource://gre/modules/Promise-backend.js :: walkerLoop :: line 845Rejection date: Tue Oct 29 2019 22:43:05 GMT+0000 (Greenwich Mean Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 265
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - Stack trace:
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:265
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - chrome://mochikit/content/browser-test.js:nextTest:631
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1190
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1137
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:932
[task 2019-10-29T22:44:34.156Z] 22:44:34 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:805
[task 2019-10-29T22:44:34.215Z] 22:44:34 INFO - GECKO(9888) | MEMORY STAT | vsize 2104190MB | vsizeMaxContiguous 66578915MB | residentFast 265MB | heapAllocated 84MB
[task 2019-10-29T22:44:34.215Z] 22:44:34 INFO - TEST-OK | docshell/test/navigation/browser_bug343515.js | took 90075ms
[task 2019-10-29T22:44:34.215Z] 22:44:34 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-29T22:44:34.215Z] 22:44:34 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/browser_bug343515.js | Found a tab after previous test timed out: http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg3.html -
[task 2019-10-29T22:44:34.220Z] 22:44:34 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-29T22:44:34.220Z] 22:44:34 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/browser_bug343515.js | Found a tab after previous test timed out: http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg1.html -
[task 2019-10-29T22:44:34.239Z] 22:44:34 INFO - GECKO(9888) | --DOCSHELL 000001D73FE1D800 == 5 [pid = 1088] [id = {c12da70c-b76f-4ff0-802b-596ac23ac35d}] [url = http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg3_1.html]
[task 2019-10-29T22:44:34.239Z] 22:44:34 INFO - GECKO(9888) | --DOCSHELL 000001D73FE1E800 == 4 [pid = 1088] [id = {aca046b8-a372-49a1-a181-dab0708cfbcd}] [url = http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg3_1_1.html]
[task 2019-10-29T22:44:34.239Z] 22:44:34 INFO - GECKO(9888) | --DOCSHELL 000001D73793E000 == 3 [pid = 1088] [id = {b9d878fb-f7c7-44a4-90eb-a204d9b9f750}] [url = http://mochi.test:8888/browser/docshell/test/navigation/bug343515_pg3_2.html]
[task 2019-10-29T22:44:34.239Z] 22:44:34 INFO - GECKO(9888) | --DOCSHELL 000001D73FE16800 == 2 [pid = 1088] [id = {8cc83030-c2e6-43fa-a400-164a13b01df8}] [url = data:text/html;charset=UTF8,<html><head></head><body>pg2 iframe 0</body></html>]
[task 2019-10-29T22:44:34.239Z] 22:44:34 INFO - GECKO(9888) | --DOCSHELL 000001D73FE17000 == 1 [pid = 1088] [id = {edc71e95-a48f-45f0-937f-0aef6397f529}] [url = data:text/html;charset=UTF8,<html><head></head><body>pg2 iframe 1</body></html>]
[task 2019-10-29T22:44:34.257Z] 22:44:34 INFO - GECKO(9888) | ++DOCSHELL 00000194E2A54800 == 1 [pid = 3412] [id = {54628082-d661-44a1-97e9-efea57b07f6e}]
[task 2019-10-29T22:44:34.257Z] 22:44:34 INFO - GECKO(9888) | ++DOMWINDOW == 1 (00000194E8903020) [pid = 3412] [serial = 1] [outer = 0000000000000000]
[task 2019-10-29T22:44:34.257Z] 22:44:34 INFO - GECKO(9888) | ++DOMWINDOW == 2 (00000194E8968400) [pid = 3412] [serial = 2] [outer = 00000194E8903020]
[task 2019-10-29T22:44:34.287Z] 22:44:34 INFO - checking window state
[task 2019-10-29T22:44:34.326Z] 22:44:34 INFO - TEST-START | docshell/test/navigation/browser_test-content-chromeflags.js

Keywords: regression

Yeah, I'll take a look today.

Flags: needinfo?(continuation)

Sort of funnily enough, it sounds like this test used to have a similar or the same intermittent failure until that was fixed in bug 765192.

I rewrote BrowserUtils.waitForContentEvent(), and that caused an
intermittent failure in browser_bug343515.js. The use of
waitForContentEvent in the test is questionable, and the test as a
whole is old, so I freshened it up.

Instead of nShotsListener (and oneShotListener, which is a special
case of that) which waits for a hard coded number of load events to
fire to ensure that a page and its subframes are all loaded, I use
BrowserTestUtils.browserLoaded().

Instead of waitForPageshow, which runs a script in the content process
that waits for an event, it uses BrowserTestUtils.waitForEvent, which
does the same thing in a hopefully more resilient fashion.

The largest change in terms of number of characters changed is that I
rewrote the test so that it is written inside of a single add_task
async function, instead of being split into a chain of async
functions. I also used await to flatten a lot of .then() chained
things.

I fixed up some variable shadowing. There was some trickiness around
shadowed variable names being used as field names, so I introduced an
intermediate 'data' variable to hold the structure.

Finally, I call BrowserTestUtils.removeTab() instead of calling
removeTab() directly on the browser. I figured that was probably
better, though maybe it does not matter.

I ran browser_bug343515.js with this locally on OSX with --verify, both with and without Fission enabled, and it passed, so hopefully this fixes the issue. The original issue was caused by changing the implementation of BrowserUtils.waitForContentEvent(), and my patch makes this test not use that method any more, so hopefully it works.

Pushed by bzbarsky@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/b6e13e6c9984
Modernize browser_bug343515.js. r=bzbarsky
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla72
Assignee: nobody → continuation
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: