Closed Bug 1740248 Opened 4 years ago Closed 4 years ago

Intermittent TV dom/ipc/tests/browser_wpi_isolate_high_value.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Categories

(Core :: DOM: Content Processes, defect, P5)

Product:
Core
Component:
DOM: Content Processes
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

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

References

Details

(Keywords: intermittent-failure)

Filed by: nfay [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=357494474&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/H8sZcjcDT4m2eeTQp_QTrg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/H8sZcjcDT4m2eeTQp_QTrg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

task 2021-11-09T11:12:44.994Z] 11:12:44     INFO - TEST-START | dom/ipc/tests/browser_wpi_isolate_high_value.js
[task 2021-11-09T11:12:47.651Z] 11:12:47     INFO - GECKO(3082) | 2021-11-09 11:12:47.650 firefox[3082:56492] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
[task 2021-11-09T11:13:01.393Z] 11:13:01     INFO - GECKO(3082) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x3A0078,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-11-09T11:13:13.676Z] 11:13:13     INFO - GECKO(3082) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x3A0078,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-11-09T11:14:19.538Z] 11:14:19     INFO - GECKO(3082) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x3A0078,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-11-09T11:14:32.172Z] 11:14:32     INFO - GECKO(3082) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x3A0078,name=PContent::Msg_DestroyBrowsingContextGroup) Closed channel: cannot send/recv
[task 2021-11-09T11:15:24.425Z] 11:15:24     INFO - GECKO(3082) | ###!!! [Child][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-11-09T11:15:24.967Z] 11:15:24     INFO - GECKO(3082) | console.warn: LoginRecipes: "getRecipes: falling back to a synchronous message for:" "https://example.com"
[task 2021-11-09T11:15:25.030Z] 11:15:25     INFO - GECKO(3082) | console.warn: LoginRecipes: "getRecipes: falling back to a synchronous message for:" "https://example.com"
[task 2021-11-09T11:15:25.147Z] 11:15:25     INFO - GECKO(3082) | JavaScript error: resource://gre/modules/LoginManagerParent.jsm, line 136: TypeError: can't access property "getRecipesForHost", gRecipeManager is null
[task 2021-11-09T11:15:25.628Z] 11:15:25     INFO -  JavaScript error: file:///opt/worker/tasks/task_163645399472904/build/tests/mochitest/document-builder.sjs, line 20: TypeError: can't access property "split", path is null
[task 2021-11-09T11:15:52.450Z] 11:15:52     INFO - TEST-INFO | started process screencapture
[task 2021-11-09T11:15:52.590Z] 11:15:52     INFO - TEST-INFO | screencapture: exit 0
[task 2021-11-09T11:15:52.590Z] 11:15:52     INFO - <snipped 534 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
[task 2021-11-09T11:15:52.591Z] 11:15:52     INFO - Buffered messages logged at 11:15:21
[task 2021-11-09T11:15:52.591Z] 11:15:52     INFO - TEST-PASS | dom/ipc/tests/browser_wpi_isolate_high_value.js | Frame basic_org[0][1] has expected originNoSuffix - 
<...>
task 2021-11-09T11:15:52.643Z] 11:15:52     INFO - TEST-PASS | dom/ipc/tests/browser_wpi_isolate_high_value.js | Frame org_after_isLoggedIn[0][0] has expected remote type - 
[task 2021-11-09T11:15:52.644Z] 11:15:52     INFO - TEST-PASS | dom/ipc/tests/browser_wpi_isolate_high_value.js | Frame org_after_isLoggedIn[0][0] has the expected number of children - 
[task 2021-11-09T11:15:52.644Z] 11:15:52     INFO - Leaving test bound test_isolate_high_value
[task 2021-11-09T11:15:52.645Z] 11:15:52     INFO - Buffered messages finished
[task 2021-11-09T11:15:52.645Z] 11:15:52     INFO - TEST-UNEXPECTED-FAIL | dom/ipc/tests/browser_wpi_isolate_high_value.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2021-11-09T11:15:52.645Z] 11:15:52     INFO - GECKO(3082) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2021-11-09T11:15:52.646Z] 11:15:52     INFO - GECKO(3082) | MEMORY STAT | vsize 7801MB | residentFast 266MB | heapAllocated 105MB
[task 2021-11-09T11:15:52.646Z] 11:15:52     INFO - TEST-OK | dom/ipc/tests/browser_wpi_isolate_high_value.js | took 187457ms
[task 2021-11-09T11:15:52.647Z] 11:15:52     INFO - checking window state
[task 2021-11-09T11:15:52.692Z] 11:15:52     INFO - GECKO(3082) | Completed ShutdownLeaks collections in process 3082
[task 2021-11-09T11:15:52.692Z] 11:15:52     INFO - TEST-START | Shutdown
[task 2021-11-09T11:15:52.693Z] 11:15:52     INFO - Browser Chrome Test Summary
[task 2021-11-09T11:15:52.694Z] 11:15:52     INFO - Passed:  547
[task 2021-11-09T11:15:52.694Z] 11:15:52     INFO - Failed:  1
[task 2021-11-09T11:15:52.695Z] 11:15:52     INFO - Todo:    0
[task 2021-11-09T11:15:52.695Z] 11:15:52     INFO - Mode:    e10s
[task 2021-11-09T11:15:52.695Z] 11:15:52     INFO - *** End BrowserChrome Test Results ***
<...>
[task 2021-11-09T11:15:53.266Z] 11:15:53     INFO -  Browser Chrome Test Summary
[task 2021-11-09T11:15:53.266Z] 11:15:53     INFO -  	Passed: 8752
[task 2021-11-09T11:15:53.266Z] 11:15:53     INFO -  	Failed: 1
[task 2021-11-09T11:15:53.266Z] 11:15:53     INFO -  	Todo: 0
[task 2021-11-09T11:15:53.267Z] 11:15:53     INFO -  	Mode: e10s
[task 2021-11-09T11:15:53.267Z] 11:15:53     INFO -  *** End BrowserChrome Test Results ***
[task 2021-11-09T11:15:53.267Z] 11:15:53     INFO - Buffered messages finished
[task 2021-11-09T11:15:53.267Z] 11:15:53     INFO - SUITE-END | took 221s
[task 2021-11-09T11:15:53.268Z] 11:15:53     INFO - SUITE-START | Running 1 tests
[task 2021-11-09T11:15:53.268Z] 11:15:53     INFO - :::
[task 2021-11-09T11:15:53.269Z] 11:15:53     INFO - ::: Test verification summary for:
[task 2021-11-09T11:15:53.269Z] 11:15:53     INFO - :::
[task 2021-11-09T11:15:53.269Z] 11:15:53     INFO - ::: dom/ipc/tests/browser_wpi_isolate_high_value.js
[task 2021-11-09T11:15:53.270Z] 11:15:53     INFO - :::
[task 2021-11-09T11:15:53.270Z] 11:15:53     INFO - ::: 1. Run each test 10 times in one browser. : Pass
[task 2021-11-09T11:15:53.270Z] 11:15:53     INFO - ::: 2. Run each test 5 times in a new browser each time. : Pass
[task 2021-11-09T11:15:53.271Z] 11:15:53     INFO - ::: 3. Run each test 10 times in one browser, in chaos mode. : FAIL
[task 2021-11-09T11:15:53.271Z] 11:15:53     INFO - ::: 4. Run each test 5 times in a new browser each time, in chaos mode. : not run / incomplete
[task 2021-11-09T11:15:53.271Z] 11:15:53     INFO - :::
[task 2021-11-09T11:15:53.272Z] 11:15:53     INFO - ::: Test verification FAILED!
[task 2021-11-09T11:15:53.272Z] 11:15:53     INFO - :::
[task 2021-11-09T11:15:53.272Z] 11:15:53     INFO - Buffered messages finished
[task 2021-11-09T11:15:53.273Z] 11:15:53     INFO - SUITE-END | took 0s
[task 2021-11-09T11:15:53.304Z] 11:15:53     INFO - Return code: 0
[task 2021-11-09T11:15:53.304Z] 11:15:53    ERROR - Got 1 unexpected statuses
[task 2021-11-09T11:15:53.304Z] 11:15:53     INFO - TinderboxPrint: mochitest-mochitest-browser-chrome<br/>100/<em class="testfail">1</em>/0
[task 2021-11-09T11:15:53.304Z] 11:15:53  WARNING - # TBPL WARNING #
[task 2021-11-09T11:15:53.305Z] 11:15:53  WARNING - setting return code to 1
[task 2021-11-09T11:15:53.305Z] 11:15:53  WARNING - TinderboxPrint: Per-test run of .../browser_wpi_isolate_high_value.js<br/>: WARNING
See Also: → 1737669
Flags: needinfo?(dlee)
Assignee: nobody → dlee
Status: NEW → ASSIGNED
Flags: needinfo?(dlee)

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.