Open Bug 1586686 Opened 4 months ago Updated 1 month ago

Intermittent docshell/test/navigation/test_triggeringprincipal_iframe_iframe_window_open.html | Test timed out.

Categories

(Core :: DOM: Security, defect, P5)

defect

Tracking

()

Fission Milestone M4.1

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 2 open bugs)

Details

(Keywords: intermittent-failure, leave-open, regression, Whiteboard: [stockwell disabled][domsecurity-intermittent])

Attachments

(1 file)

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


[task 2019-10-07T09:37:45.380Z] 09:37:45 INFO - Buffered messages logged at 09:32:43
[task 2019-10-07T09:37:45.380Z] 09:37:45 INFO - Error: Unable to restore focus, expect failures and timeouts.
[task 2019-10-07T09:37:45.380Z] 09:37:45 INFO - Buffered messages finished
[task 2019-10-07T09:37:45.381Z] 09:37:45 INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/test_triggeringprincipal_iframe_iframe_window_open.html | Test timed out.
[task 2019-10-07T09:37:45.381Z] 09:37:45 INFO - SimpleTest.ok@SimpleTest/SimpleTest.js:277:18
[task 2019-10-07T09:37:45.381Z] 09:37:45 INFO - reportError@SimpleTest/TestRunner.js:121:22
[task 2019-10-07T09:37:45.382Z] 09:37:45 INFO - TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:18
[task 2019-10-07T09:37:45.382Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.382Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.383Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.383Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.383Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.383Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.384Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.384Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.384Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.385Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.385Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.385Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.385Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.386Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.387Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.387Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.387Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - setTimeout handlerTestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - setTimeout handler
TestRunner._checkForHangs@SimpleTest/TestRunner.js:170:15
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - TestRunner.runTests/<@SimpleTest/TestRunner.js:388:20
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - promise callbackTestRunner.runTests@SimpleTest/TestRunner.js:375:50
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - RunSet.runtests@SimpleTest/setup.js:201:14
[task 2019-10-07T09:37:45.388Z] 09:37:45 INFO - RunSet.runall@SimpleTest/setup.js:180:12
[task 2019-10-07T09:37:45.389Z] 09:37:45 INFO - hookupTests@SimpleTest/setup.js:273:12
[task 2019-10-07T09:37:45.389Z] 09:37:45 INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:48:13
[task 2019-10-07T09:37:45.389Z] 09:37:45 INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:61:28
[task 2019-10-07T09:37:45.389Z] 09:37:45 INFO - EventHandlerNonNull
getTestManifest@http://mochi.test:8888/manifestLibrary.js:57:3
[task 2019-10-07T09:37:45.390Z] 09:37:45 INFO - hookup@SimpleTest/setup.js:253:20
[task 2019-10-07T09:37:45.390Z] 09:37:45 INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true:11:1
[task 2019-10-07T09:37:46.148Z] 09:37:46 INFO - GECKO(1156) | MEMORY STAT | vsize 2543MB | residentFast 153MB | heapAllocated 14MB
[task 2019-10-07T09:37:48.150Z] 09:37:48 INFO - TEST-OK | docshell/test/navigation/test_triggeringprincipal_iframe_iframe_window_open.html | took 307241ms

entering test: docshell/test/navigation/test_triggeringprincipal_iframe_iframe_window_open.html

Whiteboard: [domsecurity-intermittent]

There's a few instances of "Unable to restore focus, expect failures and timeouts." in the log before the timeout. I don't know if that's normal.

The test contains this line, so maybe document channel changes affected it?
var channel = SpecialPowers.wrap(frameA.contentWindow).docShell.currentDocumentChannel;
I don't see any cross-origin navigation in the test, though.

Andrew, are you ok with disabling this?

Flags: needinfo?(continuation)

Sure. kmag's r+ is sufficient.

Flags: needinfo?(continuation)
Pushed by csabou@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/cba7cf4a9fa5
= Disable test_triggeringprincipal_iframe_iframe_window_open.html on Linux64-fis-debug-webrender for frequent failures r=kmag
Keywords: leave-open
Whiteboard: [domsecurity-intermittent][stockwell disable-recommended] → [domsecurity-intermittent][stockwell disabled]
Fission Milestone: --- → M4.1

Ethan says this test fails intermittently only with Fission + Linux + debug + WebRender:

https://searchfox.org/mozilla-central/rev/524bed6dfbc5ae21c62632d83b7573448b29e0ac/docshell/test/navigation/mochitest.ini#96

Comment 11 suggests this test failure might be related to DocumentChannel.

Two weeks ago, this test failure was the #50 most frequent failure of the week: 38 failures in 4850 pushes (0.008 failures/push).

Flags: needinfo?(matt.woodrow)

Comment 11 suggests this test failure might be related to DocumentChannel.

Two weeks ago, this test failure was the #50 most frequent failure of the week: 38 failures in 4850 pushes (0.008 failures/push).

@ Matt, do you want to look at this intermittent test failure for DocumentChannel? Or just leave the bug alone unless the test starts failing more frequently? Last week had only 1 failures in 4207 pushes.

(In reply to Andrew McCreight [:mccr8] from comment #11)

The test contains this line, so maybe document channel changes affected it?
var channel = SpecialPowers.wrap(frameA.contentWindow).docShell.currentDocumentChannel;
I don't see any cross-origin navigation in the test, though.

currentDocumentChannel is an existing property on docshell (the current channel used for loading the document), which I guess now is a literal DocumentChannel(Child) usually.

(In reply to Chris Peterson [:cpeterson] from comment #20)

Comment 11 suggests this test failure might be related to DocumentChannel.

Two weeks ago, this test failure was the #50 most frequent failure of the week: 38 failures in 4850 pushes (0.008 failures/push).

@ Matt, do you want to look at this intermittent test failure for DocumentChannel? Or just leave the bug alone unless the test starts failing more frequently? Last week had only 1 failures in 4207 pushes.

Looks like we've already disabled the configuration that failed the most.

It'd be nice for someone to investigate this at some point, but I don't think it's a high priority.

Flags: needinfo?(matt.woodrow)

Intermittent test failure needed for fission M4.1 - removing priority so this bug shows up in next triage meeting.

Priority: P5 → --
Whiteboard: [domsecurity-intermittent][stockwell disabled] → [stockwell disabled]
Whiteboard: [stockwell disabled] → [stockwell disabled][domsecurity-intermittent]
Priority: -- → P5
You need to log in before you can comment on or make changes to this bug.