Closed Bug 1599665 Opened 6 years ago Closed 5 years ago

Intermittent check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseExplicit TEST-UNEXPECTED-FAIL

Categories

(Testing :: XPCShell Harness, defect, P5)

Product:
Testing
Component:
XPCShell Harness
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> /builds/worker/workspace/build/src/testing/xpcshell/selftest.py
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> ============================= test session starts ==============================
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> platform linux2 -- Python 2.7.9, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- /builds/worker/workspace/build/src/obj-firefox/_virtualenvs/obj-firefox-8yIyzR8r-2.7/bin/python
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> rootdir: /builds/worker/workspace/build/src, inifile: /builds/worker/workspace/build/src/config/mozunit/mozunit/pytest.ini
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> collecting ... collected 56 items
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check>
[task 2019-11-27T00:45:01.277Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskRunNextTest PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskSkip PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskSkipAll PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskStackTrace PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskTestFailureInside PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskTestMultiple PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskTestRejected PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTaskTestSingle PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTestFailing PASSED
[task 2019-11-27T00:45:01.278Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTestSimple PASSED
[task 2019-11-27T00:45:01.279Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTestUncaughtRejection PASSED
[task 2019-11-27T00:45:01.279Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAddTestUncaughtRejectionJSM PASSED
[task 2019-11-27T00:45:01.279Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAssertStack <- ../../../../../usr/lib/python2.7/unittest/case.py SKIPPED
[task 2019-11-27T00:45:01.279Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testAsyncCleanup PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testChild PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testChildFail PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testChildHang PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testChildMozinfo PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testChildPass PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testCrashLogging PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseExplicit TEST-UNEXPECTED-FAIL
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseInManifest PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseNotExplicit PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoReportForeignObject PASSED
[task 2019-11-27T00:45:01.280Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoReportNonSyntaxError PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoReportRefError PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoReportSyntaxError PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoThrowForeignObject PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testDoThrowString PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testFail PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testHangingTimeout <- ../../../../../usr/lib/python2.7/unittest/case.py SKIPPED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testKnownFail PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testLogCorrectFileName PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testMissingHeadFile PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testMozinfo PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTask PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTaskFail PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTaskMultiple PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTest PASSED
[task 2019-11-27T00:45:01.281Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTestAddTask PASSED
[task 2019-11-27T00:45:01.282Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestAddTestFail PASSED
[task 2019-11-27T00:45:01.282Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNoRunTestEmptyTest PASSED
[task 2019-11-27T00:45:01.282Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNotSkipForAddTask PASSED
[task 2019-11-27T00:45:01.282Z] 00:45:01 INFO - check> ../testing/xpcshell/selftest.py::XPCShellTestsTests::testNotSkipForAddTest PASSED

[task 2019-11-27T00:45:01.287Z] 00:45:01     INFO -  check> E   test_verbose.js | current directory: '/tmp/tmpmxExKI'
[task 2019-11-27T00:45:01.287Z] 00:45:01     INFO -  check> E   test_verbose.js | environment: ['XPCOM_DEBUG_BREAK=stack-and-abort', 'XPCSHELL_TEST_PROFILE_DIR=/tmp/xpcshell/xpcshellprofile', 'MOZ_DEVELOPER_REPO_DIR=/builds/worker/workspace/build/src', 'MOZ_CRASHREPORTER=1', 'MOZ_WEBRENDER=0', 'MOZ_DISABLE_CONTENT_SANDBOX=1', 'LD_LIBRARY_PATH=/builds/worker/workspace/build/src/obj-firefox/dist/bin:/builds/worker/fetches/gcc/lib64:/builds/worker/fetches/gcc/lib32:/builds/worker/fetches/gcc/lib', 'MOZNODE_EXEC_PORT=40233', 'MOZ_DISABLE_NONLOCAL_CONNECTIONS=1', 'XPCSHELL_TEST_TEMP_DIR=/tmp/xpc-other-Cdz9RC', 'MOZHTTP2_PORT=38588']
[task 2019-11-27T00:45:01.288Z] 00:45:01     INFO -  check> E   test_verbose.js | as shell command: (cd /tmp/tmpmxExKI; XPCOM_DEBUG_BREAK=stack-and-abort XPCSHELL_TEST_PROFILE_DIR=/tmp/xpcshell/xpcshellprofile MOZ_DEVELOPER_REPO_DIR=/builds/worker/workspace/build/src MOZ_CRASHREPORTER=1 MOZ_WEBRENDER=0 MOZ_DISABLE_CONTENT_SANDBOX=1 LD_LIBRARY_PATH=/builds/worker/workspace/build/src/obj-firefox/dist/bin:/builds/worker/fetches/gcc/lib64:/builds/worker/fetches/gcc/lib32:/builds/worker/fetches/gcc/lib MOZNODE_EXEC_PORT=40233 MOZ_DISABLE_NONLOCAL_CONNECTIONS=1 XPCSHELL_TEST_TEMP_DIR=/tmp/xpc-other-Cdz9RC MOZHTTP2_PORT=38588 /builds/worker/workspace/build/src/obj-firefox/dist/bin/xpcshell -g /builds/worker/workspace/build/src/obj-firefox/dist/bin -a /builds/worker/workspace/build/src/obj-firefox/dist/bin -r /builds/worker/workspace/build/src/obj-firefox/dist/bin/components/httpd.manifest -m -s -e 'const _HEAD_JS_PATH = "/builds/worker/workspace/build/src/testing/xpcshell/head.js";' -e 'const _MOZINFO_JS_PATH = "/tmp/xpcshell/xpcshellprofile/mozinfo.json";' -e 'const _PREFS_FILE = "/tmp/user.js";' -e 'const _TESTING_MODULES_DIR = "/builds/worker/workspace/build/src/obj-firefox/_tests/modules/";' -f /builds/worker/workspace/build/src/testing/xpcshell/head.js -e 'const _HEAD_FILES = [];' -e 'const _JSDEBUGGER_PORT = 0;' -e 'const _TEST_FILE = ["/tmp/tmpmxExKI/test_verbose.js"];' -e 'const _TEST_NAME = "test_verbose.js";' -e '_execute_test(); quit(0);')
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   "a message from info"
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   (xpcshell/head.js) | test MAIN run_test finished (1)
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   exiting test
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   PID 5550 | ExceptionHandler::GenerateDump cloned child 5568
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   PID 5550 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   PID 5550 | ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2019-11-27T00:45:01.289Z] 00:45:01     INFO -  check> E   TEST-PASS | test_verbose.js | took 113ms
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   PROCESS-CRASH | test_verbose.js | application crashed [None]
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   Crash dump filename: /tmp/xpc-other-Cdz9RC/78b4fd51-09cf-b308-ea39-fd0457cf5432.dmp
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   MINIDUMP_STACKWALK not set, can't process dump.
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   INFO | Result summary:
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   INFO | Passed: 1
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   INFO | Failed: 1
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   INFO | Todo: 0
[task 2019-11-27T00:45:01.290Z] 00:45:01     INFO -  check> E   INFO | Retried: 0
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E   SUITE-END | took 0s
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E   Node moz-http2 server shutting down ...
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E   Process stderr
[task 2019-11-27T00:45:01.291Z] 00:45:01  WARNING -  check> E   (node:5542) ExperimentalWarning: The http2 module is an experimental API.
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E
[task 2019-11-27T00:45:01.291Z] 00:45:01     INFO -  check> E   ========

xpcshell shutdown crash?

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

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