Closed Bug 1666169 Opened 4 years ago Closed 4 years ago

Intermittent toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 152] false == true

Categories

(Toolkit :: General, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2020-09-21T00:20:08.246Z] 00:20:08     INFO -  TEST-START | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js
[task 2020-09-21T00:21:20.909Z] 00:21:20  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | xpcshell return code: 1
[task 2020-09-21T00:21:20.910Z] 00:21:20     INFO -  TEST-INFO took 72657ms
[task 2020-09-21T00:21:20.911Z] 00:21:20     INFO -  >>>>>>>
[task 2020-09-21T00:21:20.911Z] 00:21:20     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-09-21T00:21:20.912Z] 00:21:20     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2020-09-21T00:21:20.912Z] 00:21:20     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2020-09-21T00:21:20.913Z] 00:21:20     INFO -  running event loop
[task 2020-09-21T00:21:20.913Z] 00:21:20     INFO -  toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | Starting test_BHRObserver
[task 2020-09-21T00:21:20.913Z] 00:21:20     INFO -  (xpcshell/head.js) | test test_BHRObserver pending (2)
[task 2020-09-21T00:21:20.914Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 34] Should have BHRTelemetryService - [object Object] == true
[task 2020-09-21T00:21:20.914Z] 00:21:20     INFO -  (xpcshell/head.js) | test pending (3)
[task 2020-09-21T00:21:20.915Z] 00:21:20     INFO -  (xpcshell/head.js) | test pending (4)
[task 2020-09-21T00:21:20.915Z] 00:21:20     INFO -  (xpcshell/head.js) | test run in child pending (5)
[task 2020-09-21T00:21:20.915Z] 00:21:20     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (5)
[task 2020-09-21T00:21:20.916Z] 00:21:20     INFO -  CHILD-TEST-STARTED
[task 2020-09-21T00:21:20.916Z] 00:21:20     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-09-21T00:21:20.917Z] 00:21:20     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2020-09-21T00:21:20.917Z] 00:21:20     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2020-09-21T00:21:20.917Z] 00:21:20     INFO -  running event loop
[task 2020-09-21T00:21:20.918Z] 00:21:20     INFO -  "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "Z:/task_1600644436/build/tests/xpcshell/head.js" line: 380}]"
[task 2020-09-21T00:21:20.918Z] 00:21:20     INFO -  toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | Starting childCauseHang
[task 2020-09-21T00:21:20.918Z] 00:21:20     INFO -  (xpcshell/head.js) | test childCauseHang pending (2)
[task 2020-09-21T00:21:20.918Z] 00:21:20     INFO -  (xpcshell/head.js) | test pending (3)
[task 2020-09-21T00:21:20.919Z] 00:21:20     INFO -  (xpcshell/head.js) | test pending (4)
[task 2020-09-21T00:21:20.919Z] 00:21:20     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (4)
[task 2020-09-21T00:21:20.920Z] 00:21:20     INFO -  (xpcshell/head.js) | test finished (3)
[task 2020-09-21T00:21:20.920Z] 00:21:20     INFO -  (xpcshell/head.js) | test finished (4)
[task 2020-09-21T00:21:20.920Z] 00:21:20     INFO -  (xpcshell/head.js) | test finished (3)
[task 2020-09-21T00:21:20.921Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 89] 3 == 3
[task 2020-09-21T00:21:20.921Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 91] true == true
[task 2020-09-21T00:21:20.922Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 92] true == true
[task 2020-09-21T00:21:20.922Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 93] "string" == "string"
[task 2020-09-21T00:21:20.923Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 96] true == true
[task 2020-09-21T00:21:20.923Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 97] true == true
[task 2020-09-21T00:21:20.923Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.924Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.924Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.925Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.925Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.925Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.926Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.926Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 107] "string" == "string"
[task 2020-09-21T00:21:20.927Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 103] 2 == 2
[task 2020-09-21T00:21:20.927Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 104] "number" == "number"
[task 2020-09-21T00:21:20.927Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 105] "string" == "string"
[task 2020-09-21T00:21:20.928Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 103] 2 == 2
[task 2020-09-21T00:21:20.928Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 104] "number" == "number"
[task 2020-09-21T00:21:20.929Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 105] "string" == "string"
[task 2020-09-21T00:21:20.929Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 103] 2 == 2

[task 2020-09-21T00:21:20.956Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 152] true == true
[task 2020-09-21T00:21:20.956Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 153] "string" == "string"
[task 2020-09-21T00:21:20.956Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 150] 2 == 2
[task 2020-09-21T00:21:20.956Z] 00:21:20     INFO -  TEST-PASS | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 151] "number" == "number"
[task 2020-09-21T00:21:20.956Z] 00:21:20  WARNING -  TEST-UNEXPECTED-FAIL | toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js | test_BHRObserver - [test_BHRObserver : 152] false == true
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:test_BHRObserver/</<:152
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:test_BHRObserver/<:145
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:test_BHRObserver:137
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Z:\task_1600644436\build\tests\xpcshell\head.js:_do_main:248
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Z:\task_1600644436\build\tests\xpcshell\head.js:_execute_test:577
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  -e:null:1
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  exiting test
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Unexpected exception NS_ERROR_ABORT:
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  _abort_failed_test@Z:\task_1600644436\build\tests\xpcshell\head.js:833:20
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  do_report_result@Z:\task_1600644436\build\tests\xpcshell\head.js:934:5
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  Assert<@Z:\task_1600644436\build\tests\xpcshell\head.js:73:21
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  proto.report@resource://testing-common/Assert.jsm:233:10
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  proto.ok@resource://testing-common/Assert.jsm:259:10
[task 2020-09-21T00:21:20.957Z] 00:21:20     INFO -  test_BHRObserver/</<@Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:152:11
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  test_BHRObserver/<@Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:145:16
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  test_BHRObserver@Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:137:24
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  _do_main@Z:\task_1600644436\build\tests\xpcshell\head.js:248:6
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  _execute_test@Z:\task_1600644436\build\tests\xpcshell\head.js:577:5
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  @-e:1:1
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  exiting test
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "Z:/task_1600644436/build/tests/xpcshell/head.js" line: 380}]"
[task 2020-09-21T00:21:20.958Z] 00:21:20     INFO -  PID 7000 | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ContentParent: id=238630b1800","state":{"remoteTypePrefix":"web"},"filename":"z:/build/build/src/dom/ipc/ContentParent.cpp","lineNumber":3249,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:do_load_child_test_harness:1370","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_test_in_child/<:1397","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_test_in_child:1387","Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:test_BHRObserver:84","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_next_test/_run_next_test/<:1630","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_run_next_test:1630","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run:777","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_do_main:248","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_execute_test:577","-e:null:1"]}] Barrier: xpcom-will-shutdown
[task 2020-09-21T00:21:20.959Z] 00:21:20     INFO -  PID 7000 | FATAL ERROR: AsyncShutdown timeout in xpcom-will-shutdown Conditions: [{"name":"ContentParent: id=238630b1800","state":{"remoteTypePrefix":"web"},"filename":"z:/build/build/src/dom/ipc/ContentParent.cpp","lineNumber":3249,"stack":["resource://gre/modules/nsAsyncShutdown.jsm:addBlocker:162","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:do_load_child_test_harness:1370","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_test_in_child/<:1397","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_test_in_child:1387","Z:/task_1600644436/build/tests/xpcshell/tests/toolkit/components/backgroundhangmonitor/tests/test_BHRObserver.js:test_BHRObserver:84","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run_next_test/_run_next_test/<:1630","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_run_next_test:1630","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:run:777","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_do_main:248","Z:\\\\task_1600644436\\\\build\\\\tests\\\\xpcshell\\\\head.js:_execute_test:577","-e:null:1"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
[task 2020-09-21T00:21:20.959Z] 00:21:20     INFO -  PID 7000 | [Parent 7000, Main Thread] ###!!! ABORT: file z:/build/build/src/dom/ipc/ContentParent.cpp, line 3249
[task 2020-09-21T00:21:20.959Z] 00:21:20     INFO -  PID 7000 | [Parent 7000, Main Thread] ###!!! ABORT: file z:/build/build/src/dom/ipc/ContentParent.cpp, line 3249
[task 2020-09-21T00:21:20.959Z] 00:21:20     INFO -  PID 7000 | Exiting due to channel error.```
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.