Intermittent ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildMozinfo TEST-UNEXPECTED-FAIL
Categories
(Core :: IPC, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure)
Filed by: archaeopteryx [at] coole-files.de https://treeherder.mozilla.org/logviewer.html#?job_id=137199989&repo=autoland https://queue.taskcluster.net/v1/task/KSKMJzX9S9eE0ezhreGQ7Q/runs/0/artifacts/public/logs/live_backing.log 10:50:05 INFO - ================================== FAILURES =================================== 10:50:05 INFO - _____________________ XPCShellTestsTests.testChildMozinfo _____________________ 10:50:05 INFO - self = <selftest.XPCShellTestsTests testMethod=testChildMozinfo> 10:50:05 INFO - def testChildMozinfo(self): 10:50:05 INFO - """ 10:50:05 INFO - Check that mozinfo.json is loaded in child process 10:50:05 INFO - """ 10:50:05 INFO - self.writeFile("test_mozinfo.js", LOAD_MOZINFO) 10:50:05 INFO - self.writeFile("test_child_mozinfo.js", CHILD_MOZINFO) 10:50:05 INFO - self.writeManifest(["test_child_mozinfo.js"]) 10:50:05 INFO - > self.assertTestResult(True) 10:50:05 INFO - ..\testing\xpcshell\selftest.py:1367: 10:50:05 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 10:50:05 INFO - ..\testing\xpcshell\selftest.py:527: in assertTestResult 10:50:05 INFO - """ % ("passed" if expected else "failed", self.log.getvalue())) 10:50:05 INFO - E AssertionError: Tests should have passed, log: 10:50:05 INFO - E ======== 10:50:05 INFO - E MOZ_NODE_PATH environment variable not set. Tests requiring http/2 will fail. 10:50:05 INFO - E Running tests sequentially. 10:50:05 INFO - E SUITE-START | Running 1 tests 10:50:05 INFO - E TEST-START | test_child_mozinfo.js 10:50:05 WARNING - E TEST-UNEXPECTED-FAIL | test_child_mozinfo.js | xpcshell return code: 1 10:50:05 INFO - E TEST-INFO took 1357ms 10:50:05 INFO - E >>>>>>> 10:50:05 INFO - E PID 5664 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2872 10:50:05 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1) 10:50:05 INFO - E (xpcshell/head.js) | test run_next_test 0 pending (2) 10:50:05 INFO - E (xpcshell/head.js) | test MAIN run_test finished (2) 10:50:05 INFO - E running event loop 10:50:05 INFO - E PID 5664 | [5664, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file z:/build/build/src/dom/media/CubebUtils.cpp, line 368 10:50:05 INFO - E test_child_mozinfo.js | Starting test_child_mozinfo 10:50:05 INFO - E (xpcshell/head.js) | test test_child_mozinfo pending (2) 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: Couldn't get the user appdata directory, crash dumps will go in an unusual location: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2949 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: Couldn't get the user appdata directory. Crash events may not be produced.: file z:/build/build/src/toolkit/crashreporter/nsExceptionHandler.cpp, line 2872 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/extensions/spellcheck/src/mozPersonalDictionary.cpp, line 219 10:50:05 INFO - E PID 5664 | Unable to read VR Path Registry from Z:\\task_1508148783\\AppData\\Local\\openvr\\openvrpaths.vrpath 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_UNEXPECTED) failed with result 0x80004005: file z:/build/build/src/extensions/cookie/nsPermissionManager.cpp, line 982 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 211 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 125 10:50:05 INFO - E (xpcshell/head.js) | test run in child pending (3) 10:50:05 INFO - E (xpcshell/head.js) | test run_next_test 1 pending (4) 10:50:05 INFO - E (xpcshell/head.js) | test test_child_mozinfo finished (4) 10:50:05 INFO - E (xpcshell/head.js) | test run_next_test 0 finished (3) 10:50:05 INFO - E (xpcshell/head.js) | test run_next_test 1 finished (2) 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004002: file z:/build/build/src/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 182 10:50:05 INFO - E CHILD-TEST-STARTED 10:50:05 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1) 10:50:05 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 3] "object" != "undefined" 10:50:05 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 4] "string" != "undefined" 10:50:05 INFO - E (xpcshell/head.js) | test MAIN run_test finished (1) 10:50:05 INFO - E exiting test 10:50:05 INFO - E PID 5664 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties 10:50:05 INFO - E PID 5664 | Unable to read VR Path Registry from Z:\\task_1508148783\\AppData\\Local\\openvr\\openvrpaths.vrpath 10:50:05 INFO - E PID 5664 | [Child 5708, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file z:/build/build/src/dom/media/CubebUtils.cpp, line 368 10:50:05 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 356}]" 10:50:05 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 356}]" 10:50:05 INFO - E CHILD-TEST-COMPLETED 10:50:05 INFO - E (xpcshell/head.js) | test finished (1) 10:50:05 INFO - E exiting test 10:50:05 INFO - E PID 5664 | [Parent 5664, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | [Child 5708, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | [Parent 5664, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | [Parent 5664, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | [Child 5708, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 10:50:05 INFO - E PID 5664 | ###!!! [Child][MessageChannel::SendAndWait] Error: (msgtype=0x430006,name=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost 10:50:05 INFO - E PID 5664 | [Child 5708, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file z:/build/build/src/xpcom/threads/nsThread.cpp, line 795 10:50:05 INFO - E PID 5664 | [Parent 5664, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 10:50:05 INFO - E PID 5664 | [Parent 5664, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file z:/build/build/src/xpcom/threads/nsThread.cpp, line 795 10:50:05 INFO - E PID 5664 | nsStringStats 10:50:05 INFO - E PID 5664 | => mAllocCount: 10717 10:50:05 INFO - E PID 5664 | => mReallocCount: 129 10:50:05 INFO - E PID 5664 | => mFreeCount: 10716 -- LEAKED 1 !!! 10:50:05 INFO - E PID 5664 | => mShareCount: 4595 10:50:05 INFO - E PID 5664 | => mAdoptCount: 231 10:50:05 INFO - E PID 5664 | => mAdoptFreeCount: 231 10:50:05 INFO - E PID 5664 | => Process ID: 5708, Thread ID: 4368 10:50:05 INFO - E PID 5664 | Assertion failure: work_queue_.empty(), at z:/build/build/src/ipc/chromium/src/base/message_loop.cc:501 10:50:05 INFO - E PID 5664 | #01: MessageLoop::~MessageLoop (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\message_loop.cc:278) 10:50:05 INFO - E PID 5664 | #02: base::Thread::ThreadMain (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\thread.cc:198) 10:50:05 INFO - E PID 5664 | #03: `anonymous namespace'::ThreadFunc (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\platform_thread_win.cc:29) 10:50:05 INFO - E PID 5664 | #04: KERNEL32.DLL + 0x13d2 10:50:05 INFO - E PID 5664 | #05: ntdll.dll + 0x154e4 10:50:05 INFO - E <<<<<<< 10:50:05 INFO - E mozcrash Saved minidump as z:\build\public\build\df70851e-7a86-48de-870e-8356eb4bf493.dmp 10:50:05 INFO - E mozcrash Saved app info as z:\build\public\build\df70851e-7a86-48de-870e-8356eb4bf493.extra 10:50:05 INFO - E INFO | Result summary: 10:50:05 INFO - E INFO | Passed: 0 10:50:05 INFO - E INFO | Failed: 1 10:50:05 INFO - E INFO | Todo: 0 10:50:05 INFO - E INFO | Retried: 0 10:50:05 INFO - E SUITE-END | took 1s 10:50:05 INFO - E 10:50:05 INFO - E ======== 10:50:05 INFO - ---------------------------- Captured stdout call ----------------------------- 10:50:05 INFO - PROCESS-CRASH | test_child_mozinfo.js | application crashed [unknown top frame]
Comment 1•7 years ago
|
||
This test spawns a content process, and it looks like some part of Gecko has queued up work that doesn't get finished in time (the test is pretty small, it probably exits quickly). This is either a bug in whatever code is scheduling that work, or just a bug in the xpcshell environment where things sometimes don't work exactly the same as the browser.
Comment hidden (Intermittent Failures Robot) |
Comment 3•7 years ago
|
||
https://wiki.mozilla.org/Bugmasters#Intermittent_Test_Failure_Cleanup
Updated•6 years ago
|
Comment 4•6 years ago
|
||
Recent log failure: https://treeherder.mozilla.org/logviewer.html#?job_id=201776583&repo=autoland&lineNumber=98773
Comment hidden (Intermittent Failures Robot) |
Comment 6•6 years ago
|
||
Over the last 7 days there are 31 crashes on this bug. These happen on windows2012-32 and windows2012-64. Here is the most recent log: https://treeherder.mozilla.org/logviewer.html#?job_id=202936709&repo=autoland&lineNumber=48831 ============================= test session starts ============================= 19:38:00 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:00 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:00 INFO - collecting ... collected 55 items 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskRunNextTest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkip PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkipAll PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskStackTrace PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestFailureInside PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestMultiple PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestRejected PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestSingle PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestFailing PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestSimple PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejection PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejectionJSM PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAssertStack <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAsyncCleanup PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChild PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildHang PASSED 19:38:00 WARNING - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildMozinfo TEST-UNEXPECTED-FAIL 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildPass PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseExplicit PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseInManifest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseNotExplicit PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportForeignObject PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportNonSyntaxError PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportRefError PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportSyntaxError PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowForeignObject PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowString PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testHangingTimeout <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testKnownFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testLogCorrectFileName PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMissingHeadFile PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMozinfo PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTask PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskMultiple PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestAddTask PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestEmptyTest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTask PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPass PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPassFail PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testRandomExecution PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testReturnNonzero PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkip PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTask PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTest PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSyntaxError PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejection PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejectionJSM PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnexpectedPass PASSED 19:38:00 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnicodeInAssertMethods PASSED 19:38:00 INFO - ================================== FAILURES =================================== 19:38:00 INFO - _____________________ XPCShellTestsTests.testChildMozinfo _____________________ 19:38:00 INFO - self = <selftest.XPCShellTestsTests testMethod=testChildMozinfo> 19:38:00 INFO - def testChildMozinfo(self): 19:38:00 INFO - """ 19:38:00 INFO - Check that mozinfo.json is loaded in child process 19:38:00 INFO - """ 19:38:00 INFO - self.writeFile("test_mozinfo.js", LOAD_MOZINFO) 19:38:00 INFO - self.writeFile("test_child_mozinfo.js", CHILD_MOZINFO) 19:38:00 INFO - self.writeManifest(["test_child_mozinfo.js"]) 19:38:00 INFO - > self.assertTestResult(True) 19:38:00 INFO - ..\testing\xpcshell\selftest.py:1366: 19:38:00 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 19:38:00 INFO - ..\testing\xpcshell\selftest.py:527: in assertTestResult 19:38:00 INFO - """ % ("passed" if expected else "failed", self.log.getvalue())) 19:38:00 INFO - E AssertionError: Tests should have passed, log: 19:38:00 INFO - E ======== 19:38:00 INFO - E MOZ_NODE_PATH environment variable not set. Tests requiring http/2 will fail. 19:38:00 INFO - E Running tests sequentially. 19:38:00 INFO - E SUITE-START | Running 1 tests 19:38:00 INFO - E TEST-START | test_child_mozinfo.js 19:38:00 WARNING - E TEST-UNEXPECTED-TIMEOUT | test_child_mozinfo.js | Test timed out 19:38:00 INFO - E TEST-INFO took 15001ms 19:38:00 INFO - E >>>>>>> 19:38:00 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1) 19:38:00 INFO - E (xpcshell/head.js) | test run_next_test 0 pending (2) 19:38:00 INFO - E (xpcshell/head.js) | test MAIN run_test finished (2) 19:38:00 INFO - E running event loop 19:38:00 INFO - E test_child_mozinfo.js | Starting test_child_mozinfo 19:38:00 INFO - E (xpcshell/head.js) | test test_child_mozinfo pending (2) 19:38:00 INFO - E (xpcshell/head.js) | test run in child pending (3) 19:38:00 INFO - E (xpcshell/head.js) | test run_next_test 1 pending (4) 19:38:00 INFO - E (xpcshell/head.js) | test test_child_mozinfo finished (4) 19:38:00 INFO - E (xpcshell/head.js) | test run_next_test 0 finished (3) 19:38:00 INFO - E (xpcshell/head.js) | test run_next_test 1 finished (2) 19:38:00 INFO - E CHILD-TEST-STARTED 19:38:00 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1) 19:38:00 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 3] "object" != "undefined" 19:38:00 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 4] "string" != "undefined" 19:38:00 INFO - E (xpcshell/head.js) | test MAIN run_test finished (1) 19:38:00 INFO - E exiting test 19:38:00 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 345}]" 19:38:00 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 345}]" 19:38:00 INFO - E CHILD-TEST-COMPLETED 19:38:00 INFO - E (xpcshell/head.js) | test finished (1) 19:38:00 INFO - E exiting test 19:38:00 INFO - E PID 6104 | [Parent 6104, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 19:38:00 INFO - E PID 6104 | [Child 4136, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 19:38:00 INFO - E <<<<<<< 19:38:00 INFO - E mozcrash kill_pid(): wait failed (-1) terminating pid 6104: error 5 19:38:00 INFO - E xpcshell return code: None 19:38:00 INFO - E test_child_mozinfo.js | Process still running after test! 19:38:00 INFO - E INFO | Result summary: 19:38:00 INFO - E INFO | Passed: 0 19:38:00 INFO - E INFO | Failed: 1 19:38:00 INFO - E INFO | Todo: 0 19:38:00 INFO - E INFO | Retried: 0 19:38:00 INFO - E SUITE-END | took 15s 19:38:00 INFO - E 19:38:00 INFO - E ======== 19:38:00 INFO - =============== 1 failed, 52 passed, 2 skipped in 26.95 seconds =============== 19:38:00 INFO - Setting retcode to 1 from z:\build\build\src\testing\xpcshell\selftest.py 19:38:12 INFO - z:\build\build\src\tools\lint\test\test_flake8.py 19:38:12 INFO - ============================= test session starts ============================= 19:38:12 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:12 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:12 INFO - collecting ... collected 7 items 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_single_file PASSED 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_custom_config PASSED 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_fix PASSED 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_fix_uses_config PASSED 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_custom_config_from_parent_path xfail 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_excluded_file xfail 19:38:12 INFO - ..\tools\lint\test\test_flake8.py::test_lint_uses_custom_extensions PASSED 19:38:12 INFO - ==================== 5 passed, 2 xfailed in 29.81 seconds ===================== 19:38:20 INFO - z:\build\build\src\config\tests\unit-mozunit.py 19:38:20 INFO - ============================= test session starts ============================= 19:38:20 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:20 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:20 INFO - collecting ... collected 1 item 19:38:20 INFO - ..\config\tests\unit-mozunit.py::TestMozUnit::test_mocked_open PASSED 19:38:20 INFO - ========================== 1 passed in 0.03 seconds =========================== 19:38:20 INFO - z:\build\build\src\build\compare-mozconfig\compare-mozconfigs.py 19:38:20 INFO - ============================= test session starts ============================= 19:38:20 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:20 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:20 INFO - collecting ... collected 1 item 19:38:20 INFO - ..\build\compare-mozconfig\compare-mozconfigs.py::TestCompareMozconfigs::test_compare_mozconfigs PASSED 19:38:20 INFO - ========================== 1 passed in 0.05 seconds =========================== 19:38:20 INFO - z:\build\build\src\config\tests\test_mozbuild_reading.py 19:38:20 INFO - ============================= test session starts ============================= 19:38:20 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:20 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:20 INFO - collecting ... collected 3 items 19:38:20 INFO - ..\config\tests\test_mozbuild_reading.py::TestMozbuildReading::test_filesystem_traversal_no_config PASSED 19:38:20 INFO - ..\config\tests\test_mozbuild_reading.py::TestMozbuildReading::test_filesystem_traversal_reading <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED 19:38:20 INFO - ..\config\tests\test_mozbuild_reading.py::TestMozbuildReading::test_orphan_file_patterns SKIPPED 19:38:20 INFO - ==================== 1 passed, 2 skipped in 357.07 seconds ==================== 19:38:20 INFO - z:\build\build\src\config\tests\unit-nsinstall.py 19:38:20 INFO - ============================= test session starts ============================= 19:38:20 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:38:20 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:38:20 INFO - collecting ... collected 9 items 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_D PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_basic PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_basic_recursive PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_d PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_dir_exists PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_multiple PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_non_ascii PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_non_ascii_subprocess PASSED 19:38:20 INFO - ..\config\tests\unit-nsinstall.py::TestNsinstall::test_nsinstall_t PASSED 19:38:20 INFO - ========================== 9 passed in 2.36 seconds =========================== 19:40:03 INFO - z:\build\build\src\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py 19:40:03 INFO - ============================= test session starts ============================= 19:40:03 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:40:03 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:40:03 INFO - collecting ... collected 55 items 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_absolute_path PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_atypical_name PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_default PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_guess_cxx PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_guess_cxx_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_mismatched_compiler PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_mismatched_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_mixed_compilers PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_no_supported_compiler PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_overridden_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_unsupported_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxToolchainTest::test_unsupported_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxSimpleCrossToolchainTest::test_cross_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxSimpleCrossToolchainTest::test_cross_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxX86_64CrossToolchainTest::test_cross_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxX86_64CrossToolchainTest::test_cross_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXToolchainTest::test_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXToolchainTest::test_forced_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXToolchainTest::test_forced_unsupported_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXToolchainTest::test_not_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXToolchainTest::test_unsupported_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_cannot_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_clang_cl PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_msvc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_overridden_unsupported_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_overridden_unsupported_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsToolchainTest::test_unsupported_msvc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_cannot_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_clang_cl PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_msvc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_overridden_unsupported_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_overridden_unsupported_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::Windows64ToolchainTest::test_unsupported_msvc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cannot_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_atypical_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_clang PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_gcc_misc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_ppc_ppc64 PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_sparc_sparc64 PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_cross_x86_x64 PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_guess_cross_cxx PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_overridden_cross_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::LinuxCrossCompileToolchainTest::test_overridden_unsupported_cross_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXCrossToolchainTest::test_cannot_osx_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OSXCrossToolchainTest::test_osx_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsCrossToolchainTest::test_clang_cl_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::WindowsCrossToolchainTest::test_wsl_cross PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::OpenBSDToolchainTest::test_gcc PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py::RustTest::test_rust_target PASSED 19:40:03 INFO - ========================= 55 passed in 401.17 seconds ========================= 19:40:03 INFO - z:\build\build\src\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py 19:40:03 INFO - ============================= test session starts ============================= 19:40:03 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox\_virtualenvs\src-5kxztrTV-2.7\Scripts\python.exe 19:40:03 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini 19:40:03 INFO - collecting ... collected 5 items 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py::TestCompilerPreprocessor::test_condition PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py::TestCompilerPreprocessor::test_expansion PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py::TestFakeCompiler::test_fake_compiler PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py::TestFakeCompiler::test_multiple_definitions PASSED 19:40:03 INFO - ..\python\mozbuild\mozbuild\test\configure\test_toolchain_helpers.py::TestCompilerResult::test_compiler_result PASSED 19:40:03 INFO - ========================== 5 passed in 0.05 seconds =========================== 19:40:03 INFO - Return code from mach python-test: 1 19:40:04 INFO - z:/build/build/src/testing/testsuite-targets.mk:263: recipe for target 'check' failed 19:40:04 INFO - mozmake.EXE: *** [check] Error 1 19:40:04 INFO - z:/build/build/src/mozmake.EXE recurse_check 19:40:04 INFO - mozmake.EXE[1]: Entering directory 'z:/build/build/src/obj-firefox' 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/build/win32' 19:40:04 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/build/win32/autobinscope.py ../../dist/bin/firefox.exe ../../dist/crashreporter-symbols/ 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/config' 19:40:04 INFO - z:/build/build/src/mozmake.EXE -C tests/src-simple check-jar 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/ipc/ipdl/test/ipdl' 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/memory/replace/logalloc/replay' 19:40:04 INFO - grep "^1 " z:/build/build/src/memory/replace/logalloc/replay/replay.log > expected_output.log 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/toolkit/xre/test/win' 19:40:04 INFO - mozmake.EXE[3]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:04 INFO - if test -d ../../../dist/xpi-stage/test_jar_mn; then rm -rf ../../../dist/xpi-stage/test_jar_mn; fi; 19:40:04 INFO - Running TestXREMakeCommandLineWin tests 19:40:04 INFO - z:/build/build/src/mozmake.EXE realchrome MOZ_JAR_MAKER_FILE_FORMAT=jar 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 0 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 1 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 2 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 3 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 4 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 5 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 6 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 7 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 8 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 9 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 10 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 11 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 12 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 13 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 14 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 15 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 16 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 17 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 18 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 19 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 20 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 21 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 22 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 23 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 24 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | check 25 19:40:04 INFO - TEST-PASS | XRE MakeCommandLine | all checks passed 19:40:04 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/toolkit/xre/test/win' 19:40:04 INFO - MALLOC_LOG=1 ./../../../../dist/bin/logalloc-replay.exe < z:/build/build/src/memory/replace/logalloc/replay/replay.log | sed -n '/jemalloc_stats/,$p' | z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/memory/replace/logalloc/replay/logalloc_munge.py | diff -w - expected_output.log 19:40:04 INFO - mozmake.EXE[4]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:04 INFO - mkdir -p '../../../dist/xpi-stage/test_jar_mn/chrome/' 19:40:04 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe -m mozbuild.action.jar_maker -d ../../../dist/xpi-stage/test_jar_mn -t z:/build/build/src -f jar --relativesrcdir=config/tests/src-simple -c z:/build/build/src/config/tests/src-simple/l10n -DACCESSIBILITY=1 -DBROWSER_CHROME_URL=chrome://browser/content/browser.xul -DBROWSER_CHROME_URL_QUOTED='"chrome://browser/content/browser.xul"' -DBUILD_CTYPES=1 -DCROSS_COMPILE='' -DEARLY_BETA_OR_EARLIER=1 -DENABLE_INTL_API=1 -DENABLE_SYSTEM_EXTENSION_DIRS=1 -DENABLE_TESTS=1 -DENABLE_WASM_CRANELIFT=1 -DEXPOSE_INTL_API=1 -DFIREFOX_VERSION=64.0a1 -DFORCE_PR_LOG=1 -DGTEST_HAS_RTTI=0 -DHAVE_64BIT_BUILD=1 -DHAVE_CPUID_H=1 -DHAVE_FORCEINLINE=1 -DHAVE_INTTYPES_H=1 -DHAVE_IO_H=1 -DHAVE_ISATTY=1 -DHAVE_LOCALECONV=1 -DHAVE_MALLOC_H=1 -DHAVE_SEH_EXCEPTIONS=1 -DHAVE_STDINT_H=1 -DHAVE_SYS_TYPES_H=1 -DHAVE_UINT64_T=1 -DJS_64BIT=1 -DJS_BUILD_BINAST=1 -DJS_CODEGEN_X64=1 -DJS_DEFAULT_JITREPORT_GRANULARITY=3 -DJS_PUNBOX64=1 -DMALLOC_H='<malloc.h>' -DMALLOC_USABLE_SIZE_CONST_PTR=const -DMOZILLA_UAVERSION='"64.0"' -DMOZILLA_VERSION='"64.0a1"' -DMOZILLA_VERSION_U=64.0a1 -DMOZ_ALLOW_LEGACY_EXTENSIONS=1 -DMOZ_APP_UA_NAME='""' -DMOZ_APP_UA_VERSION='"64.0a1"' -DMOZ_AV1=1 -DMOZ_BLOCK_PROFILE_DOWNGRADE=1 -DMOZ_BUILD_APP=browser -DMOZ_BUILD_WEBRENDER=1 -DMOZ_BUNDLED_FONTS=1 -DMOZ_CLANG_PLUGIN=1 -DMOZ_CONTENT_SANDBOX=1 -DMOZ_CRASHREPORTER=1 -DMOZ_DATA_REPORTING=1 -DMOZ_DEDICATED_PROFILES=1 -DMOZ_DISTRIBUTION_ID='"org.mozilla"' -DMOZ_DLL_PREFIX='""' -DMOZ_DLL_SUFFIX='".dll"' -DMOZ_ENABLE_SIGNMAR=1 -DMOZ_ENABLE_SKIA=1 -DMOZ_FEEDS=1 -DMOZ_FFVPX=1 -DMOZ_FMP4=1 -DMOZ_GECKO_PROFILER=1 -DMOZ_GMP_SANDBOX=1 -DMOZ_INSTRUMENT_EVENT_LOOP=1 -DMOZ_LAUNCHER_PROCESS=1 -DMOZ_LIBAV_FFT=1 -DMOZ_LOGGING=1 -DMOZ_MACBUNDLE_ID=org.mozilla.nightly -DMOZ_MAINTENANCE_SERVICE=1 -DMOZ_MEMORY=1 -DMOZ_PEERCONNECTION=1 -DMOZ_PHOENIX=1 -DMOZ_PLACES=1 -DMOZ_PROFILING=1 -DMOZ_RAW=1 -DMOZ_REPLACE_MALLOC=1 -DMOZ_RUST_SIMD=1 -DMOZ_SAMPLE_TYPE_FLOAT32=1 -DMOZ_SANDBOX=1 -DMOZ_SCTP=1 -DMOZ_SERVICES_HEALTHREPORT=1 -DMOZ_SRTP=1 -DMOZ_STATIC_JS=1 -DMOZ_TREE_CAIRO=1 -DMOZ_TREE_PIXMAN=1 -DMOZ_UPDATER=1 -DMOZ_UPDATE_CHANNEL=default -DMOZ_USER_DIR='"Mozilla"' -DMOZ_VORBIS=1 -DMOZ_VPX_NO_MEM_REPORTING=1 -DMOZ_VTUNE=1 -DMOZ_WEBM_ENCODER=1 -DMOZ_WEBRTC=1 -DMOZ_WEBRTC_ASSERT_ALWAYS=1 -DMOZ_WEBRTC_SIGNALING=1 -DMOZ_WEBSPEECH=1 -DMOZ_WEBSPEECH_TEST_BACKEND=1 -DMOZ_WMF=1 -DMOZ_XUL=1 -DMSVC_HAS_DIA_SDK=1 -DNIGHTLY_BUILD=1 -DNOMINMAX=1 -DNO_NSPR_10_SUPPORT=1 -DNS_ENABLE_TSF=1 -DNS_PRINTING=1 -DNS_PRINT_PREVIEW=1 -DSTATIC_JS_API=1 -DSTDC_HEADERS=1 -DTARGET_XPCOM_ABI='"x86_64-msvc"' -DUSE_SKIA=1 -DUSE_SKIA_GPU=1 -DU_STATIC_IMPLEMENTATION=1 -DU_USING_ICU_NAMESPACE=0 -DVPX_X86_ASM=1 -DWIN32=1 -DWIN32_LEAN_AND_MEAN=1 -DWINVER=0x601 -DXP_WIN=1 -DXP_WIN32=1 -DX_DISPLAY_MISSING=1 -D_AMD64_=1 -D_CRT_NONSTDC_NO_WARNINGS=1 -D_CRT_SECURE_NO_WARNINGS=1 -D_USE_MATH_DEFINES=1 -D_WIN32_IE=0x0800 -D_WIN32_WINNT=0x601 -D_WINDOWS=1 -DAB_CD=en-US -DAB_CD=ab-X-stuff z:/build/build/src/config/tests/src-simple/jar.mn 19:40:04 INFO - #1 mapped: 1048576; allocated: 0; waste: 0; dirty: 0; bookkeep: 4096; binunused: 0 19:40:04 INFO - #12 mapped: 2097152; allocated: 10336; waste: 0; dirty: 0; bookkeep: 13376; binunused: 66400 19:40:04 INFO - mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/js/src' 19:40:04 INFO - (cd z:/build/build/src && z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/config/check_js_msg_encoding.py); 19:40:05 INFO - rm -f test_output.log 19:40:05 INFO - MALLOC_LOG=test_output.log ./../../../../dist/bin/logalloc-replay.exe < z:/build/build/src/memory/replace/logalloc/replay/replay.log 19:40:05 INFO - #1 mapped: 1048576; allocated: 0; waste: 0; dirty: 0; bookkeep: 4096; binunused: 0 19:40:05 INFO - #12 mapped: 2097152; allocated: 10336; waste: 0; dirty: 0; bookkeep: 13376; binunused: 66400 19:40:05 INFO - sed -n '/jemalloc_stats/,$p' test_output.log | z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/memory/replace/logalloc/replay/logalloc_munge.py | diff -w - expected_output.log 19:40:05 INFO - MALLOC_LOG=1 MALLOC_LOG_MINIMAL=1 ./../../../../dist/bin/logalloc-replay.exe < z:/build/build/src/memory/replace/logalloc/replay/replay.log | sed -n '/jemalloc_stats/,$p' | z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/memory/replace/logalloc/replay/logalloc_munge.py | diff -w - z:/build/build/src/memory/replace/logalloc/replay/expected_output_minimal.log 19:40:05 INFO - #1 mapped: 1048576; allocated: 0; waste: 0; dirty: 0; bookkeep: 4096; binunused: 0 19:40:05 INFO - #12 mapped: 2097152; allocated: 10336; waste: 0; dirty: 0; bookkeep: 13376; binunused: 66400 19:40:05 INFO - TEST-PASS | autobinscope.py | ../../dist/bin/firefox.exe succeeded 19:40:05 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/build/win32/autobinscope.py ../../dist/bin/plugin-container.exe ../../dist/crashreporter-symbols/ 19:40:05 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/memory/replace/logalloc/replay' 19:40:05 INFO - processing z:/build/build/src/config/tests/src-simple/jar.mn 19:40:05 INFO - .mozmake.EXE[4]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:05 INFO - Comparing manifests... 19:40:05 INFO - Archive: ../../../dist/xpi-stage/test_jar_mn/chrome/test.jar 19:40:05 INFO - extracting: ../../../dist/xpi-stage/test_jar_mn/chrome/test/one/file.xml 19:40:05 INFO - extracting: ../../../dist/xpi-stage/test_jar_mn/chrome/test/one/preproc 19:40:05 INFO - extracting: ../../../dist/xpi-stage/test_jar_mn/chrome/test/one/some.css 19:40:05 INFO - extracting: ../../../dist/xpi-stage/test_jar_mn/chrome/test/two/otherfile.xml 19:40:05 INFO - extracting: ../../../dist/xpi-stage/test_jar_mn/chrome/test/three/l10nfile.txt 19:40:05 INFO - Comparing packages... 19:40:05 INFO - mozmake.EXE[3]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:05 INFO - z:/build/build/src/mozmake.EXE -C tests/src-simple check-flat 19:40:05 INFO - mozmake.EXE[3]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:05 INFO - if test -d ../../../dist/xpi-stage/test_jar_mn; then rm -rf ../../../dist/xpi-stage/test_jar_mn; fi; 19:40:05 INFO - .z:/build/build/src/mozmake.EXE realchrome MOZ_JAR_MAKER_FILE_FORMAT=flat 19:40:05 INFO - mozmake.EXE[4]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:05 INFO - mkdir -p '../../../dist/xpi-stage/test_jar_mn/chrome/' 19:40:05 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe -m mozbuild.action.jar_maker -d ../../../dist/xpi-stage/test_jar_mn -t z:/build/build/src -f flat --relativesrcdir=config/tests/src-simple -c z:/build/build/src/config/tests/src-simple/l10n -DACCESSIBILITY=1 -DBROWSER_CHROME_URL=chrome://browser/content/browser.xul -DBROWSER_CHROME_URL_QUOTED='"chrome://browser/content/browser.xul"' -DBUILD_CTYPES=1 -DCROSS_COMPILE='' -DEARLY_BETA_OR_EARLIER=1 -DENABLE_INTL_API=1 -DENABLE_SYSTEM_EXTENSION_DIRS=1 -DENABLE_TESTS=1 -DENABLE_WASM_CRANELIFT=1 -DEXPOSE_INTL_API=1 -DFIREFOX_VERSION=64.0a1 -DFORCE_PR_LOG=1 -DGTEST_HAS_RTTI=0 -DHAVE_64BIT_BUILD=1 -DHAVE_CPUID_H=1 -DHAVE_FORCEINLINE=1 -DHAVE_INTTYPES_H=1 -DHAVE_IO_H=1 -DHAVE_ISATTY=1 -DHAVE_LOCALECONV=1 -DHAVE_MALLOC_H=1 -DHAVE_SEH_EXCEPTIONS=1 -DHAVE_STDINT_H=1 -DHAVE_SYS_TYPES_H=1 -DHAVE_UINT64_T=1 -DJS_64BIT=1 -DJS_BUILD_BINAST=1 -DJS_CODEGEN_X64=1 -DJS_DEFAULT_JITREPORT_GRANULARITY=3 -DJS_PUNBOX64=1 -DMALLOC_H='<malloc.h>' -DMALLOC_USABLE_SIZE_CONST_PTR=const -DMOZILLA_UAVERSION='"64.0"' -DMOZILLA_VERSION='"64.0a1"' -DMOZILLA_VERSION_U=64.0a1 -DMOZ_ALLOW_LEGACY_EXTENSIONS=1 -DMOZ_APP_UA_NAME='""' -DMOZ_APP_UA_VERSION='"64.0a1"' -DMOZ_AV1=1 -DMOZ_BLOCK_PROFILE_DOWNGRADE=1 -DMOZ_BUILD_APP=browser -DMOZ_BUILD_WEBRENDER=1 -DMOZ_BUNDLED_FONTS=1 -DMOZ_CLANG_PLUGIN=1 -DMOZ_CONTENT_SANDBOX=1 -DMOZ_CRASHREPORTER=1 -DMOZ_DATA_REPORTING=1 -DMOZ_DEDICATED_PROFILES=1 -DMOZ_DISTRIBUTION_ID='"org.mozilla"' -DMOZ_DLL_PREFIX='""' -DMOZ_DLL_SUFFIX='".dll"' -DMOZ_ENABLE_SIGNMAR=1 -DMOZ_ENABLE_SKIA=1 -DMOZ_FEEDS=1 -DMOZ_FFVPX=1 -DMOZ_FMP4=1 -DMOZ_GECKO_PROFILER=1 -DMOZ_GMP_SANDBOX=1 -DMOZ_INSTRUMENT_EVENT_LOOP=1 -DMOZ_LAUNCHER_PROCESS=1 -DMOZ_LIBAV_FFT=1 -DMOZ_LOGGING=1 -DMOZ_MACBUNDLE_ID=org.mozilla.nightly -DMOZ_MAINTENANCE_SERVICE=1 -DMOZ_MEMORY=1 -DMOZ_PEERCONNECTION=1 -DMOZ_PHOENIX=1 -DMOZ_PLACES=1 -DMOZ_PROFILING=1 -DMOZ_RAW=1 -DMOZ_REPLACE_MALLOC=1 -DMOZ_RUST_SIMD=1 -DMOZ_SAMPLE_TYPE_FLOAT32=1 -DMOZ_SANDBOX=1 -DMOZ_SCTP=1 -DMOZ_SERVICES_HEALTHREPORT=1 -DMOZ_SRTP=1 -DMOZ_STATIC_JS=1 -DMOZ_TREE_CAIRO=1 -DMOZ_TREE_PIXMAN=1 -DMOZ_UPDATER=1 -DMOZ_UPDATE_CHANNEL=default -DMOZ_USER_DIR='"Mozilla"' -DMOZ_VORBIS=1 -DMOZ_VPX_NO_MEM_REPORTING=1 -DMOZ_VTUNE=1 -DMOZ_WEBM_ENCODER=1 -DMOZ_WEBRTC=1 -DMOZ_WEBRTC_ASSERT_ALWAYS=1 -DMOZ_WEBRTC_SIGNALING=1 -DMOZ_WEBSPEECH=1 -DMOZ_WEBSPEECH_TEST_BACKEND=1 -DMOZ_WMF=1 -DMOZ_XUL=1 -DMSVC_HAS_DIA_SDK=1 -DNIGHTLY_BUILD=1 -DNOMINMAX=1 -DNO_NSPR_10_SUPPORT=1 -DNS_ENABLE_TSF=1 -DNS_PRINTING=1 -DNS_PRINT_PREVIEW=1 -DSTATIC_JS_API=1 -DSTDC_HEADERS=1 -DTARGET_XPCOM_ABI='"x86_64-msvc"' -DUSE_SKIA=1 -DUSE_SKIA_GPU=1 -DU_STATIC_IMPLEMENTATION=1 -DU_USING_ICU_NAMESPACE=0 -DVPX_X86_ASM=1 -DWIN32=1 -DWIN32_LEAN_AND_MEAN=1 -DWINVER=0x601 -DXP_WIN=1 -DXP_WIN32=1 -DX_DISPLAY_MISSING=1 -D_AMD64_=1 -D_CRT_NONSTDC_NO_WARNINGS=1 -D_CRT_SECURE_NO_WARNINGS=1 -D_USE_MATH_DEFINES=1 -D_WIN32_IE=0x0800 -D_WIN32_WINNT=0x601 -D_WINDOWS=1 -DAB_CD=en-US -DAB_CD=ab-X-stuff z:/build/build/src/config/tests/src-simple/jar.mn 19:40:05 INFO - TEST-PASS | autobinscope.py | ../../dist/bin/plugin-container.exe succeeded 19:40:05 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/build/win32/autobinscope.py ../../dist/bin/mozglue.dll ../../dist/crashreporter-symbols/ 19:40:06 INFO - .processing z:/build/build/src/config/tests/src-simple/jar.mn 19:40:06 INFO - mozmake.EXE[4]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - Comparing manifests... 19:40:06 INFO - .Comparing packages... 19:40:06 INFO - TEST-PASS | autobinscope.py | ../../dist/bin/mozglue.dll succeeded 19:40:06 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/build/win32/autobinscope.py ../../dist/bin/xul.dll ../../dist/crashreporter-symbols/ 19:40:06 INFO - mozmake.EXE[3]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - z:/build/build/src/mozmake.EXE -C tests/src-simple check-flat USE_EXTENSION_MANIFEST=1 19:40:06 INFO - mozmake.EXE[3]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - if test -d ../../../dist/xpi-stage/test_jar_mn; then rm -rf ../../../dist/xpi-stage/test_jar_mn; fi; 19:40:06 INFO - z:/build/build/src/mozmake.EXE realchrome MOZ_JAR_MAKER_FILE_FORMAT=flat 19:40:06 INFO - mozmake.EXE[4]: Entering directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - mkdir -p '../../../dist/xpi-stage/test_jar_mn/chrome/' 19:40:06 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe -m mozbuild.action.jar_maker -d ../../../dist/xpi-stage/test_jar_mn -t z:/build/build/src -f flat -e --relativesrcdir=config/tests/src-simple -c z:/build/build/src/config/tests/src-simple/l10n -DACCESSIBILITY=1 -DBROWSER_CHROME_URL=chrome://browser/content/browser.xul -DBROWSER_CHROME_URL_QUOTED='"chrome://browser/content/browser.xul"' -DBUILD_CTYPES=1 -DCROSS_COMPILE='' -DEARLY_BETA_OR_EARLIER=1 -DENABLE_INTL_API=1 -DENABLE_SYSTEM_EXTENSION_DIRS=1 -DENABLE_TESTS=1 -DENABLE_WASM_CRANELIFT=1 -DEXPOSE_INTL_API=1 -DFIREFOX_VERSION=64.0a1 -DFORCE_PR_LOG=1 -DGTEST_HAS_RTTI=0 -DHAVE_64BIT_BUILD=1 -DHAVE_CPUID_H=1 -DHAVE_FORCEINLINE=1 -DHAVE_INTTYPES_H=1 -DHAVE_IO_H=1 -DHAVE_ISATTY=1 -DHAVE_LOCALECONV=1 -DHAVE_MALLOC_H=1 -DHAVE_SEH_EXCEPTIONS=1 -DHAVE_STDINT_H=1 -DHAVE_SYS_TYPES_H=1 -DHAVE_UINT64_T=1 -DJS_64BIT=1 -DJS_BUILD_BINAST=1 -DJS_CODEGEN_X64=1 -DJS_DEFAULT_JITREPORT_GRANULARITY=3 -DJS_PUNBOX64=1 -DMALLOC_H='<malloc.h>' -DMALLOC_USABLE_SIZE_CONST_PTR=const -DMOZILLA_UAVERSION='"64.0"' -DMOZILLA_VERSION='"64.0a1"' -DMOZILLA_VERSION_U=64.0a1 -DMOZ_ALLOW_LEGACY_EXTENSIONS=1 -DMOZ_APP_UA_NAME='""' -DMOZ_APP_UA_VERSION='"64.0a1"' -DMOZ_AV1=1 -DMOZ_BLOCK_PROFILE_DOWNGRADE=1 -DMOZ_BUILD_APP=browser -DMOZ_BUILD_WEBRENDER=1 -DMOZ_BUNDLED_FONTS=1 -DMOZ_CLANG_PLUGIN=1 -DMOZ_CONTENT_SANDBOX=1 -DMOZ_CRASHREPORTER=1 -DMOZ_DATA_REPORTING=1 -DMOZ_DEDICATED_PROFILES=1 -DMOZ_DISTRIBUTION_ID='"org.mozilla"' -DMOZ_DLL_PREFIX='""' -DMOZ_DLL_SUFFIX='".dll"' -DMOZ_ENABLE_SIGNMAR=1 -DMOZ_ENABLE_SKIA=1 -DMOZ_FEEDS=1 -DMOZ_FFVPX=1 -DMOZ_FMP4=1 -DMOZ_GECKO_PROFILER=1 -DMOZ_GMP_SANDBOX=1 -DMOZ_INSTRUMENT_EVENT_LOOP=1 -DMOZ_LAUNCHER_PROCESS=1 -DMOZ_LIBAV_FFT=1 -DMOZ_LOGGING=1 -DMOZ_MACBUNDLE_ID=org.mozilla.nightly -DMOZ_MAINTENANCE_SERVICE=1 -DMOZ_MEMORY=1 -DMOZ_PEERCONNECTION=1 -DMOZ_PHOENIX=1 -DMOZ_PLACES=1 -DMOZ_PROFILING=1 -DMOZ_RAW=1 -DMOZ_REPLACE_MALLOC=1 -DMOZ_RUST_SIMD=1 -DMOZ_SAMPLE_TYPE_FLOAT32=1 -DMOZ_SANDBOX=1 -DMOZ_SCTP=1 -DMOZ_SERVICES_HEALTHREPORT=1 -DMOZ_SRTP=1 -DMOZ_STATIC_JS=1 -DMOZ_TREE_CAIRO=1 -DMOZ_TREE_PIXMAN=1 -DMOZ_UPDATER=1 -DMOZ_UPDATE_CHANNEL=default -DMOZ_USER_DIR='"Mozilla"' -DMOZ_VORBIS=1 -DMOZ_VPX_NO_MEM_REPORTING=1 -DMOZ_VTUNE=1 -DMOZ_WEBM_ENCODER=1 -DMOZ_WEBRTC=1 -DMOZ_WEBRTC_ASSERT_ALWAYS=1 -DMOZ_WEBRTC_SIGNALING=1 -DMOZ_WEBSPEECH=1 -DMOZ_WEBSPEECH_TEST_BACKEND=1 -DMOZ_WMF=1 -DMOZ_XUL=1 -DMSVC_HAS_DIA_SDK=1 -DNIGHTLY_BUILD=1 -DNOMINMAX=1 -DNO_NSPR_10_SUPPORT=1 -DNS_ENABLE_TSF=1 -DNS_PRINTING=1 -DNS_PRINT_PREVIEW=1 -DSTATIC_JS_API=1 -DSTDC_HEADERS=1 -DTARGET_XPCOM_ABI='"x86_64-msvc"' -DUSE_SKIA=1 -DUSE_SKIA_GPU=1 -DU_STATIC_IMPLEMENTATION=1 -DU_USING_ICU_NAMESPACE=0 -DVPX_X86_ASM=1 -DWIN32=1 -DWIN32_LEAN_AND_MEAN=1 -DWINVER=0x601 -DXP_WIN=1 -DXP_WIN32=1 -DX_DISPLAY_MISSING=1 -D_AMD64_=1 -D_CRT_NONSTDC_NO_WARNINGS=1 -D_CRT_SECURE_NO_WARNINGS=1 -D_USE_MATH_DEFINES=1 -D_WIN32_IE=0x0800 -D_WIN32_WINNT=0x601 -D_WINDOWS=1 -DAB_CD=en-US -DAB_CD=ab-X-stuff z:/build/build/src/config/tests/src-simple/jar.mn 19:40:06 INFO - .processing z:/build/build/src/config/tests/src-simple/jar.mn 19:40:06 INFO - .mozmake.EXE[4]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - Comparing manifests... 19:40:06 INFO - Comparing packages... 19:40:06 INFO - mozmake.EXE[3]: Leaving directory 'z:/build/build/src/obj-firefox/config/tests/src-simple' 19:40:06 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/config' 19:40:08 INFO - ..........TEST-PASS | autobinscope.py | ../../dist/bin/xul.dll succeeded 19:40:08 INFO - z:/build/build/src/obj-firefox/_virtualenvs/init/Scripts/python.exe z:/build/build/src/build/win32/autobinscope.py ../../dist/bin/nss3.dll ../../dist/crashreporter-symbols/ 19:40:08 INFO - ..TEST-PASS | autobinscope.py | ../../dist/bin/nss3.dll succeeded 19:40:08 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/build/win32' 19:40:16 INFO - ...............................................TEST-PASS | check_js_msg_encoding.py | z:\build\build\src\dom/bindings/Errors.msg | ok 19:40:16 INFO - TEST-PASS | check_js_msg_encoding.py | z:\build\build\src\js/src/ctypes/ctypes.msg | ok 19:40:16 INFO - TEST-PASS | check_js_msg_encoding.py | z:\build\build\src\js/src/js.msg | ok 19:40:16 INFO - TEST-PASS | check_js_msg_encoding.py | z:\build\build\src\js/src/jsshell.msg | ok 19:40:16 INFO - TEST-PASS | check_js_msg_encoding.py | z:\build\build\src\js/xpconnect/src/jsshell.msg | ok 19:40:16 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/js/src' 19:40:16 INFO - .mozmake.EXE[2]: Entering directory 'z:/build/build/src/obj-firefox/js/src/build' 19:40:16 INFO - mozmake.EXE[2]: Nothing to be done for 'check'. 19:40:16 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/js/src/build' 19:40:24 INFO - ...................................................... 19:40:24 INFO - ---------------------------------------------------------------------- 19:40:24 INFO - Ran 120 tests in 19.350s 19:40:24 INFO - OK 19:40:24 INFO - mozmake.EXE[2]: Leaving directory 'z:/build/build/src/obj-firefox/ipc/ipdl/test/ipdl' 19:40:24 INFO - mozmake.EXE[1]: Leaving directory 'z:/build/build/src/obj-firefox' 19:40:24 INFO - 402 compiler warnings present. 19:40:24 ERROR - Return code: 2 19:40:24 INFO - TinderboxPrint: check<br/>47/<em class="testfail">2</em>/0 19:40:24 WARNING - setting return code to 2 19:40:24 ERROR - 'mach build check' did not run successfully. Please check log for errors. 19:40:24 INFO - [mozharness: 2018-10-02 19:40:24.610000Z] Finished check-test step (success) 19:40:24 INFO - [mozharness: 2018-10-02 19:40:24.610000Z] Skipping valgrind-test step. 19:40:24 INFO - [mozharness: 2018-10-02 19:40:24.610000Z] Skipping multi-l10n step. 19:40:24 INFO - [mozharness: 2018-10-02 19:40:24.610000Z] Skipping package-source step. 19:40:24 INFO - Running post-run listener: _summarize 19:40:24 ERROR - # TBPL FAILURE # 19:40:24 INFO - [mozharness: 2018-10-02 19:40:24.611000Z] FxDesktopBuild summary: 19:40:24 ERROR - # TBPL FAILURE # 19:40:24 INFO - Running post-run listener: copy_logs_to_upload_dir 19:40:24 INFO - Copying logs to upload dir... 19:40:24 INFO - mkdir: z:\build\build\upload\logs 19:40:24 INFO - Copying logs to upload dir... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 INFO - Using _rmtree_windows ... 19:40:24 WARNING - returning nonzero exit status 2 [taskcluster 2018-10-02T19:40:24.684Z] Exit Code: 2 [taskcluster 2018-10-02T19:40:24.684Z] User Time: 15.625ms [taskcluster 2018-10-02T19:40:24.684Z] Kernel Time: 0s [taskcluster 2018-10-02T19:40:24.684Z] Wall Time: 57m5.0037552s [taskcluster 2018-10-02T19:40:24.684Z] Result: FAILED [taskcluster 2018-10-02T19:40:24.684Z] === Task Finished === [taskcluster 2018-10-02T19:40:24.684Z] Task Duration: 1h5m6.9693737s [taskcluster 2018-10-02T19:40:25.370Z] Uploading artifact public/build/buildhub.json from file public\build\buildhub.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:25.783Z] Uploading artifact public/build/host/bin/mar.exe from file public\build\host\bin\mar.exe with content encoding "gzip", mime type "application/x-msdownload" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:26.219Z] Uploading artifact public/build/host/bin/mbsdiff.exe from file public\build\host\bin\mbsdiff.exe with content encoding "gzip", mime type "application/x-msdownload" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:26.791Z] Uploading artifact public/build/install/sea/target.installer.exe from file public\build\install\sea\target.installer.exe with content encoding "gzip", mime type "application/x-msdownload" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:29.388Z] Uploading artifact public/build/mozharness.zip from file public\build\mozharness.zip with content encoding "", mime type "application/x-zip-compressed" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:29.837Z] Uploading artifact public/build/sccache.log from file public\build\sccache.log with content encoding "gzip", mime type "text/plain" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:30.335Z] Uploading artifact public/build/setup.exe from file public\build\setup.exe with content encoding "gzip", mime type "application/x-msdownload" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:30.777Z] Uploading artifact public/build/target.awsy.tests.tar.gz from file public\build\target.awsy.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:31.187Z] Uploading artifact public/build/target.checksums from file public\build\target.checksums with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:31.608Z] Uploading artifact public/build/target.common.tests.tar.gz from file public\build\target.common.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:32.423Z] Uploading artifact public/build/target.cppunittest.tests.tar.gz from file public\build\target.cppunittest.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:33.148Z] Uploading artifact public/build/target.crashreporter-symbols-full.zip from file public\build\target.crashreporter-symbols-full.zip with content encoding "", mime type "application/x-zip-compressed" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:43.235Z] Uploading artifact public/build/target.crashreporter-symbols.zip from file public\build\target.crashreporter-symbols.zip with content encoding "", mime type "application/x-zip-compressed" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:44.295Z] Uploading artifact public/build/target.generated-files.tar.gz from file public\build\target.generated-files.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:44.850Z] Uploading artifact public/build/target.gtest.tests.zip from file public\build\target.gtest.tests.zip with content encoding "", mime type "application/x-zip-compressed" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:46.109Z] Uploading artifact public/build/target.json from file public\build\target.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:46.467Z] Uploading artifact public/build/target.langpack.xpi from file public\build\target.langpack.xpi with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:46.969Z] Uploading artifact public/build/target.mochitest.tests.tar.gz from file public\build\target.mochitest.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:48.666Z] Uploading artifact public/build/target.mozinfo.json from file public\build\target.mozinfo.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:49.032Z] Uploading artifact public/build/target.raptor.tests.tar.gz from file public\build\target.raptor.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:49.748Z] Uploading artifact public/build/target.reftest.tests.tar.gz from file public\build\target.reftest.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:51.196Z] Uploading artifact public/build/target.talos.tests.tar.gz from file public\build\target.talos.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:52.200Z] Uploading artifact public/build/target.test_packages.json from file public\build\target.test_packages.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:52.691Z] Uploading artifact public/build/target.txt from file public\build\target.txt with content encoding "gzip", mime type "text/plain; charset=utf-8" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:53.037Z] Uploading artifact public/build/target.updater-dep.tests.tar.gz from file public\build\target.updater-dep.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:53.429Z] Uploading artifact public/build/target.web-platform.tests.tar.gz from file public\build\target.web-platform.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:55.055Z] Uploading artifact public/build/target.xpcshell.tests.tar.gz from file public\build\target.xpcshell.tests.tar.gz with content encoding "", mime type "application/x-gzip" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:55.685Z] Uploading artifact public/build/target.zip from file public\build\target.zip with content encoding "", mime type "application/x-zip-compressed" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:57.382Z] Uploading artifact public/build/target_info.txt from file public\build\target_info.txt with content encoding "gzip", mime type "text/plain; charset=utf-8" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:57.758Z] Uploading artifact public/build/toolchains.json from file public\build\toolchains.json with content encoding "gzip", mime type "application/octet-stream" and expiry 2019-10-02T18:34:51.014Z [taskcluster 2018-10-02T19:40:58.415Z] Uploading redirect artifact public/logs/live.log to URL https://queue.taskcluster.net/v1/task/JlxxukdVSeCoXj_6GWJp2A/runs/0/artifacts/public/logs/live_backing.log with mime type "text/plain; charset=utf-8" and expiry 2019-10-02T18:34:51.014Z [taskcluster:error] exit status 2
Comment 7•6 years ago
|
||
Judging by the graph something made this start happening again (or a similar bug that manifests in the same way, anyway) on September 26th: https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2018-09-04&endday=2018-10-04&tree=all&bug=1408980 I'm going to file this in Core: IPC unless proven otherwise--these tests are not part of the build system and the failure seems to be something in Gecko related to IPC.
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 10•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Comment 11•5 years ago
|
||
Recent log:
https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=227878616&repo=autoland&lineNumber=42071
INFO - z:\build\build\src\testing\xpcshell\selftest.py
11:19:29 INFO - ============================= test session starts =============================
11:19:29 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox_virtualenvs\obj-firefox-sNC2NmI7-2.7\Scripts\python.exe
11:19:29 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini
11:19:29 INFO - collecting ... collected 55 items
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskRunNextTest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkip PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkipAll PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskStackTrace PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestFailureInside PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestMultiple PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestRejected PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestSingle PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestFailing PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestSimple PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejection PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejectionJSM PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAssertStack <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAsyncCleanup PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChild PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildHang PASSED
11:19:29 WARNING - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildMozinfo TEST-UNEXPECTED-FAIL
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildPass PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseExplicit PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseInManifest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseNotExplicit PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportForeignObject PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportNonSyntaxError PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportRefError PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportSyntaxError PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowForeignObject PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowString PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testHangingTimeout <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testKnownFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testLogCorrectFileName PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMissingHeadFile PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMozinfo PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTask PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskMultiple PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestAddTask PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestEmptyTest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTask PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPass PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPassFail PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testRandomExecution PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testReturnNonzero PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkip PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTask PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTest PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSyntaxError PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejection PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejectionJSM PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnexpectedPass PASSED
11:19:29 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnicodeInAssertMethods PASSED
11:19:29 INFO - ================================== FAILURES ===================================
11:19:29 INFO - _____________________ XPCShellTestsTests.testChildMozinfo _____________________
11:19:29 INFO - self = <selftest.XPCShellTestsTests testMethod=testChildMozinfo>
11:19:29 INFO - def testChildMozinfo(self):
11:19:29 INFO - """
11:19:29 INFO - Check that mozinfo.json is loaded in child process
11:19:29 INFO - """
11:19:29 INFO - self.writeFile("test_mozinfo.js", LOAD_MOZINFO)
11:19:29 INFO - self.writeFile("test_child_mozinfo.js", CHILD_MOZINFO)
11:19:29 INFO - self.writeManifest(["test_child_mozinfo.js"])
11:19:29 INFO - > self.assertTestResult(True)
11:19:29 INFO - ..\testing\xpcshell\selftest.py:1366:
11:19:29 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
11:19:29 INFO - ..\testing\xpcshell\selftest.py:527: in assertTestResult
11:19:29 INFO - """ % ("passed" if expected else "failed", self.log.getvalue()))
11:19:29 INFO - E AssertionError: Tests should have passed, log:
11:19:29 INFO - E ========
11:19:29 INFO - E runxpcshelltests.py | using symbolizer at z:\build\build\src\obj-firefox\dist\bin\llvm-symbolizer.exe
11:19:29 INFO - E MOZ_NODE_PATH environment variable not set. Tests requiring http/2 will fail.
11:19:29 INFO - E Running tests sequentially.
11:19:29 INFO - E SUITE-START | Running 1 tests
11:19:29 INFO - E TEST-START | test_child_mozinfo.js
11:19:29 WARNING - E TEST-UNEXPECTED-FAIL | test_child_mozinfo.js | xpcshell return code: -2147483645
11:19:29 INFO - E TEST-INFO took 3375ms
11:19:29 INFO - E >>>>>>>
11:19:29 INFO - E PID 1276 | Unable to load \untrusted-startup-test-dll.dll; LoadLibraryW failed: 126Couldn't convert chrome URL: chrome://branding/locale/brand.properties
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 81
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 81
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 81
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 81
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 81
11:19:29 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1)
11:19:29 INFO - E (xpcshell/head.js) | test run_next_test 0 pending (2)
11:19:29 INFO - E (xpcshell/head.js) | test MAIN run_test finished (2)
11:19:29 INFO - E running event loop
11:19:29 INFO - E PID 1276 | [1276, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file z:/build/build/src/dom/media/CubebUtils.cpp, line 358
11:19:29 INFO - E test_child_mozinfo.js | Starting test_child_mozinfo
11:19:29 INFO - E (xpcshell/head.js) | test test_child_mozinfo pending (2)
11:19:29 INFO - E PID 1276 | [Parent 1276, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/extensions/spellcheck/src/mozPersonalDictionary.cpp, line 208
11:19:29 INFO - E PID 1276 | [Parent 1276, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_UNEXPECTED) failed with result 0x80004005: file z:/build/build/src/extensions/cookie/nsPermissionManager.cpp, line 1060
11:19:29 INFO - E PID 1276 | [Parent 1276, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 208
11:19:29 INFO - E PID 1276 | [Parent 1276, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 125
11:19:29 INFO - E (xpcshell/head.js) | test run in child pending (3)
11:19:29 INFO - E (xpcshell/head.js) | test run_next_test 1 pending (4)
11:19:29 INFO - E (xpcshell/head.js) | test test_child_mozinfo finished (4)
11:19:29 INFO - E (xpcshell/head.js) | test run_next_test 0 finished (3)
11:19:29 INFO - E (xpcshell/head.js) | test run_next_test 1 finished (2)
11:19:29 INFO - E PID 1276 | [Child 3264, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 744
11:19:29 INFO - E PID 1276 | [Parent 1276, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, kKnownEsrVersion) failed with result 0x80004002: file z:/build/build/src/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 662
11:19:29 INFO - E CHILD-TEST-STARTED
11:19:29 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1)
11:19:29 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 3] "object" != "undefined"
11:19:29 INFO - E TEST-PASS | test_child_mozinfo.js | run_test - [run_test : 4] "string" != "undefined"
11:19:29 INFO - E (xpcshell/head.js) | test MAIN run_test finished (1)
11:19:29 INFO - E exiting test
11:19:29 INFO - E PID 1276 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
11:19:29 INFO - E PID 1276 | [Child 3264, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file z:/build/build/src/dom/media/CubebUtils.cpp, line 358
11:19:29 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 349}]"
11:19:29 INFO - E "CONSOLE_MESSAGE: (warn) [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "z:/build/build/src/testing/xpcshell/head.js" line: 349}]"
11:19:29 INFO - E CHILD-TEST-COMPLETED
11:19:29 INFO - E (xpcshell/head.js) | test finished (1)
11:19:29 INFO - E exiting test
11:19:29 INFO - E PID 1276 | [Parent 1276, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Child 3264, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Child 3264, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Parent 1276, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Parent 1276, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Parent 1276, Gecko_IOThread] WARNING: pipe err
11:19:29 INFO - E PID 1276 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
11:19:29 INFO - E PID 1276 | or: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | [Parent 1276, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 341
11:19:29 INFO - E PID 1276 | nsStringStats
11:19:29 INFO - E PID 1276 | => mAllocCount: 3982
11:19:29 INFO - E PID 1276 | => mReallocCount: 0
11:19:29 INFO - E PID 1276 | => mFreeCount: 3982
11:19:29 INFO - E PID 1276 | => mShareCount: 2446
11:19:29 INFO - E PID 1276 | => mAdoptCount: 121
11:19:29 INFO - E PID 1276 | => mAdoptFreeCount: 121
11:19:29 INFO - E PID 1276 | => Process ID: 3264, Thread ID: 5012
11:19:29 INFO - E PID 1276 | Assertion failure: work_queue_.empty(), at z:/build/build/src/ipc/chromium/src/base/message_loop.cc:490
11:19:29 INFO - E PID 1276 | #01: base::Thread::ThreadMain (z:\build\build\src\ipc\chromium\src\base\thread.cc:209)
11:19:29 INFO - E PID 1276 | #02: `anonymous namespace'::ThreadFunc (z:\build\build\src\ipc\chromium\src\base\platform_thread_win.cc:31)
11:19:29 INFO - E PID 1276 | #03: _asan_default_suppressions__dll[z:\build\build\src\obj-firefox\dist\bin\clang_rt.asan_dynamic-x86_64.dll +0x3e889]
11:19:29 INFO - E PID 1276 | #04: BaseThreadInitThunk[C:\Windows\system32\KERNEL32.DLL +0x13d2]
11:19:29 INFO - E PID 1276 | #05: patched_BaseThreadInitThunk (z:\build\build\src\mozglue\build\WindowsDllBlocklist.cpp:734)
11:19:29 INFO - E PID 1276 | #06: RtlUserThreadStart[C:\Windows\SYSTEM32\ntdll.dll +0x154e4]
11:19:29 INFO - E <<<<<<<
11:19:29 INFO - E INFO | Result summary:
11:19:29 INFO - E INFO | Passed: 0
11:19:29 INFO - E INFO | Failed: 1
11:19:29 INFO - E INFO | Todo: 0
11:19:29 INFO - E INFO | Retried: 0
11:19:29 INFO - E SUITE-END | took 3s
11:19:29 INFO - E
11:19:29 INFO - E ========
11:19:29 INFO - =============== 1 failed, 52 passed, 2 skipped in 59.21 seconds ===============
11:19:29 INFO - Setting retcode to 1 from z:\build\build\src\testing\xpcshell\selftest.py
11:20:58 INFO - z:\build\build\src\python\mozbuild\mozbuild\test\configure\test_toolchain_configure.py
Comment 12•5 years ago
|
||
There's an error message in that log about untrusted-startup-test-dll.dll, which was mentioned in bug 1525378.
Comment hidden (Intermittent Failures Robot) |
Comment 14•5 years ago
|
||
Comment 15•5 years ago
|
||
This is still happening.
Recent failure: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=234692160&repo=autoland&lineNumber=40989
02:08:07 INFO - ..\config\tests\unit-mozunit.py::TestMozUnit::test_mocked_open PASSED
02:08:07 INFO - ========================== 1 passed in 0.02 seconds ===========================
02:08:31 INFO - z:\build\build\src\testing\xpcshell\selftest.py
02:08:31 INFO - ============================= test session starts =============================
02:08:31 INFO - platform win32 -- Python 2.7.15, pytest-3.6.2, py-1.5.4, pluggy-0.6.0 -- z:\build\build\src\obj-firefox_virtualenvs\obj-firefox-sNC2NmI7-2.7\Scripts\python.exe
02:08:31 INFO - rootdir: z:\build\build\src, inifile: z:\build\build\src\config\mozunit\mozunit\pytest.ini
02:08:31 INFO - collecting ... collected 55 items
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskRunNextTest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkip PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskSkipAll PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskStackTrace PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestFailureInside PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestMultiple PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestRejected PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTaskTestSingle PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestFailing PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestSimple PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejection PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAddTestUncaughtRejectionJSM PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAssertStack <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testAsyncCleanup PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChild PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildHang PASSED
02:08:31 WARNING - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildMozinfo TEST-UNEXPECTED-FAIL
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testChildPass PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseExplicit PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseInManifest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoPrintWhenVerboseNotExplicit PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportForeignObject PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportNonSyntaxError PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportRefError PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoReportSyntaxError PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowForeignObject PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testDoThrowString PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testHangingTimeout <- c:\mozilla-build\python\Lib\unittest\case.py SKIPPED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testKnownFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testLogCorrectFileName PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMissingHeadFile PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testMozinfo PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTask PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTaskMultiple PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestAddTask PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestAddTestFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNoRunTestEmptyTest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTask PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testNotSkipForAddTest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPass PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testPassFail PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testRandomExecution PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testReturnNonzero PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkip PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTask PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSkipForAddTest PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testSyntaxError PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejection PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUncaughtRejectionJSM PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnexpectedPass PASSED
02:08:31 INFO - ..\testing\xpcshell\selftest.py::XPCShellTestsTests::testUnicodeInAssertMethods PASSED
02:08:31 INFO - ================================== FAILURES ===================================
02:08:31 INFO - _____________________ XPCShellTestsTests.testChildMozinfo _____________________
02:08:31 INFO - self = <selftest.XPCShellTestsTests testMethod=testChildMozinfo>
02:08:31 INFO - def testChildMozinfo(self):
02:08:31 INFO - """
02:08:31 INFO - Check that mozinfo.json is loaded in child process
02:08:31 INFO - """
02:08:31 INFO - self.writeFile("test_mozinfo.js", LOAD_MOZINFO)
02:08:31 INFO - self.writeFile("test_child_mozinfo.js", CHILD_MOZINFO)
02:08:31 INFO - self.writeManifest(["test_child_mozinfo.js"])
02:08:31 INFO - > self.assertTestResult(True)
02:08:31 INFO - ..\testing\xpcshell\selftest.py:1366:
02:08:31 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _
02:08:31 INFO - ..\testing\xpcshell\selftest.py:527: in assertTestResult
02:08:31 INFO - """ % ("passed" if expected else "failed", self.log.getvalue()))
02:08:31 INFO - E AssertionError: Tests should have passed, log:
02:08:31 INFO - E ========
02:08:31 INFO - E runxpcshelltests.py | using symbolizer at z:\build\build\src\obj-firefox\dist\bin\llvm-symbolizer.exe
02:08:31 INFO - E MOZ_NODE_PATH environment variable not set. Tests requiring http/2 will fail.
02:08:31 INFO - E Running tests sequentially.
02:08:31 INFO - E SUITE-START | Running 1 tests
02:08:31 INFO - E profile dir is c:\users\task_1552956819\appdata\local\temp\xpcshell\xpcshellprofile
02:08:31 INFO - E TEST-START | test_child_mozinfo.js
02:08:31 WARNING - E TEST-UNEXPECTED-FAIL | test_child_mozinfo.js | xpcshell return code: 1
02:08:31 INFO - E TEST-INFO took 4158ms
Comment hidden (Intermittent Failures Robot) |
Comment 17•5 years ago
|
||
Comment 18•5 years ago
|
||
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 21•5 years ago
|
||
Updated•5 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 25•5 years ago
|
||
Comment 26•5 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=264276800&repo=mozilla-central&lineNumber=47834
Comment hidden (Intermittent Failures Robot) |
Comment 28•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Description
•