Closed Bug 1410002 Opened 8 years ago Closed 8 years ago

Intermittent test_child_assertions.js | xpcshell return code: 1

Categories

(Firefox Build System :: General, defect, P5)

Product:
Firefox Build System
Component:
General
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: archaeopteryx [at] coole-files.de https://treeherder.mozilla.org/logviewer.html#?job_id=138118437&repo=autoland https://queue.taskcluster.net/v1/task/L3oJZ_5bT_SwCL6Umg2iDQ/runs/0/artifacts/public/logs/live_backing.log 08:37:50 INFO - ================================== FAILURES =================================== 08:37:50 INFO - ________________________ XPCShellTestsTests.testChild _________________________ 08:37:50 INFO - self = <selftest.XPCShellTestsTests testMethod=testChild> 08:37:50 INFO - def testChild(self): 08:37:50 INFO - """ 08:37:50 INFO - Checks that calling do_load_child_test_harness without run_test_in_child 08:37:50 INFO - results in a usable test state. This test has a spurious failure when 08:37:50 INFO - run using |mach python-test|. See bug 1103226. 08:37:50 INFO - """ 08:37:50 INFO - self.writeFile("test_child_assertions.js", CHILD_HARNESS_SIMPLE) 08:37:50 INFO - self.writeManifest(["test_child_assertions.js"]) 08:37:50 INFO - > self.assertTestResult(True) 08:37:50 INFO - ..\testing\xpcshell\selftest.py:672: 08:37:50 INFO - _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 08:37:50 INFO - ..\testing\xpcshell\selftest.py:527: in assertTestResult 08:37:50 INFO - """ % ("passed" if expected else "failed", self.log.getvalue())) 08:37:50 INFO - E AssertionError: Tests should have passed, log: 08:37:50 INFO - E ======== 08:37:50 INFO - E MOZ_NODE_PATH environment variable not set. Tests requiring http/2 will fail. 08:37:50 INFO - E Running tests sequentially. 08:37:50 INFO - E SUITE-START | Running 1 tests 08:37:50 INFO - E TEST-START | test_child_assertions.js 08:37:50 WARNING - E TEST-UNEXPECTED-FAIL | test_child_assertions.js | xpcshell return code: 1 08:37:50 INFO - E TEST-INFO took 4677ms 08:37:50 INFO - E >>>>>>> 08:37:50 INFO - E PID 5248 | [5248, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 508 08:37:50 INFO - E PID 5248 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties 08:37:50 INFO - E PID 5248 | [5248, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 08:37:50 INFO - E PID 5248 | [5248, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 08:37:50 INFO - E PID 5248 | [5248, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 08:37:50 INFO - E PID 5248 | [5248, Main Thread] WARNING: Failed to get directory to cache.: file z:/build/build/src/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp, line 112 08:37:50 INFO - E PID 5248 | [5248, 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 08:37:50 INFO - E (xpcshell/head.js) | test MAIN run_test pending (1) 08:37:50 INFO - E (xpcshell/head.js) | test run_next_test 0 pending (2) 08:37:50 INFO - E (xpcshell/head.js) | test MAIN run_test finished (2) 08:37:50 INFO - E running event loop 08:37:50 INFO - E PID 5248 | [5248, 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 08:37:50 INFO - E test_child_assertions.js | Starting test_child_assert 08:37:50 INFO - E (xpcshell/head.js) | test test_child_assert pending (2) 08:37:50 INFO - E PID 5248 | [Parent 5248, 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 08:37:50 INFO - E PID 5248 | [Parent 5248, 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 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/extensions/spellcheck/src/mozPersonalDictionary.cpp, line 219 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 508 08:37:50 INFO - E PID 5248 | [GPU 2700, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file z:/build/build/src/modules/libpref/Preferences.cpp, line 5137 08:37:50 INFO - E PID 5248 | [GPU 2700, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file z:/build/build/src/obj-firefox/dist/include\\mozilla/Preferences.h, line 96 08:37:50 INFO - E PID 5248 | [GPU 2700, Main Thread] WARNING: Failed to load WMF DLLs: file z:/build/build/src/dom/media/platforms/wmf/WMFUtils.cpp, line 194 08:37:50 INFO - E PID 5248 | [GPU 2700, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file z:/build/build/src/modules/libpref/Preferences.cpp, line 4964 08:37:50 INFO - E PID 5248 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties 08:37:50 INFO - E PID 5248 | [Child 5236, 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 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_UNEXPECTED) failed with result 0x80004005: file z:/build/build/src/extensions/cookie/nsPermissionManager.cpp, line 1014 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 211 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: 'NS_FAILED(rv)', file z:/build/build/src/dom/media/gmp/GMPServiceParent.cpp, line 125 08:37:50 INFO - E (xpcshell/head.js) | test test child assertion pending (3) 08:37:50 INFO - E (xpcshell/head.js) | test run_next_test 1 pending (4) 08:37:50 INFO - E (xpcshell/head.js) | test test_child_assert finished (4) 08:37:50 INFO - E (xpcshell/head.js) | test run_next_test 0 finished (3) 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004002: file z:/build/build/src/toolkit/components/resistfingerprinting/nsRFPService.cpp, line 182 08:37:50 INFO - E (xpcshell/head.js) | test run_next_test 1 finished (2) 08:37:50 INFO - E TEST-PASS | test_child_assertions.js | undefined assertion name - true == true 08:37:50 INFO - E (xpcshell/head.js) | test finished (1) 08:37:50 INFO - E exiting test 08:37:50 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}]" 08:37:50 INFO - E PID 5248 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties 08:37:50 INFO - E PID 5248 | [Parent 5248, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Child 5236, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [GPU 2700, Main Thread] WARNING: Failed to get GetProcAddress of MFShutdown from Mfplat.dll: file z:/build/build/src/dom/media/platforms/wmf/WMFUtils.cpp, line 262 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Parent 5248, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Child 5236, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Parent 5248, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 08:37:50 INFO - E PID 5248 | [GPU 2700, Chrome_ChildThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file z:/build/build/src/xpcom/threads/nsThread.cpp, line 795 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file z:/build/build/src/xpcom/threads/nsThread.cpp, line 795 08:37:50 INFO - E PID 5248 | nsStringStats 08:37:50 INFO - E PID 5248 | => mAllocCount: 1923 08:37:50 INFO - E PID 5248 | => mReallocCount: 33 08:37:50 INFO - E PID 5248 | => mFreeCount: 1923 08:37:50 INFO - E PID 5248 | => mShareCount: 57 08:37:50 INFO - E PID 5248 | => mAdoptCount: 0 08:37:50 INFO - E PID 5248 | => mAdoptFreeCount: 0 08:37:50 INFO - E PID 5248 | => Process ID: 2700, Thread ID: 1496 08:37:50 INFO - E PID 5248 | [Parent 5248, Gecko_IOThread] WARNING: pipe error: 109: file z:/build/build/src/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 346 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file z:/build/build/src/xpcom/threads/nsThread.cpp, line 795 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | [Parent 5248, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | [Child 5236, Main Thread] WARNING: '!gThread', file z:/build/build/src/xpcom/threads/nsTimerImpl.cpp, line 399 08:37:50 INFO - E PID 5248 | nsStringStats 08:37:50 INFO - E PID 5248 | => mAllocCount: 10689 08:37:50 INFO - E PID 5248 | => mReallocCount: 129 08:37:50 INFO - E PID 5248 | => mFreeCount: 10688 -- LEAKED 1 !!! 08:37:50 INFO - E PID 5248 | => mShareCount: 4334 08:37:50 INFO - E PID 5248 | => mAdoptCount: 225 08:37:50 INFO - E PID 5248 | => mAdoptFreeCount: 225 08:37:50 INFO - E PID 5248 | => Process ID: 5236, Thread ID: 4200 08:37:50 INFO - E PID 5248 | Assertion failure: work_queue_.empty(), at z:/build/build/src/ipc/chromium/src/base/message_loop.cc:501 08:37:50 INFO - E PID 5248 | #01: MessageLoop::DeletePendingTasks (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\message_loop.cc:501) 08:37:50 INFO - E PID 5248 | #02: MessageLoop::~MessageLoop (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\message_loop.cc:278) 08:37:50 INFO - E PID 5248 | #03: base::Thread::ThreadMain (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\thread.cc:198) 08:37:50 INFO - E PID 5248 | #04: `anonymous namespace'::ThreadFunc (z:\\build\\build\\src\\ipc\\chromium\\src\\base\\platform_thread_win.cc:29) 08:37:50 INFO - E PID 5248 | #05: BaseThreadInitThunk[C:\\Windows\\SYSTEM32\\KERNEL32.DLL +0x17c04] 08:37:50 INFO - E PID 5248 | #06: patched_BaseThreadInitThunk (z:\\build\\build\\src\\mozglue\\build\\WindowsDllBlocklist.cpp:825) 08:37:50 INFO - E PID 5248 | #07: RtlInitializeExceptionChain[C:\\Windows\\SYSTEM32\\ntdll.dll +0x5ab8f] 08:37:50 INFO - E PID 5248 | #08: RtlInitializeExceptionChain[C:\\Windows\\SYSTEM32\\ntdll.dll +0x5ab5a] 08:37:50 INFO - E <<<<<<< 08:37:50 INFO - E mozcrash Copy/paste: z:\build\build\tools\breakpad\win32\minidump_stackwalk.exe c:\users\task_1508396510\appdata\local\temp\xpc-other-k8wejb\5d7392df-67bc-487f-86b8-1c3271a330a8.dmp c:\users\task_1508396510\appdata\local\temp\tmpvbfnzy 08:37:50 INFO - E mozcrash Saved minidump as z:\build\public\build\5d7392df-67bc-487f-86b8-1c3271a330a8.dmp 08:37:50 INFO - E mozcrash Saved app info as z:\build\public\build\5d7392df-67bc-487f-86b8-1c3271a330a8.extra 08:37:50 INFO - E INFO | Result summary: 08:37:50 INFO - E INFO | Passed: 0 08:37:50 INFO - E INFO | Failed: 1 08:37:50 INFO - E INFO | Todo: 0 08:37:50 INFO - E INFO | Retried: 0 08:37:50 INFO - E SUITE-END | took 4s 08:37:50 INFO - E 08:37:50 INFO - E ======== 08:37:50 INFO - ---------------------------- Captured stdout call ----------------------------- 08:37:50 INFO - PROCESS-CRASH | test_child_assertions.js | application crashed [@ xul.dll + 0x51f89d] 08:37:50 INFO - Crash dump filename: c:\users\task_1508396510\appdata\local\temp\xpc-other-k8wejb\5d7392df-67bc-487f-86b8-1c3271a330a8.dmp 08:37:50 INFO - Operating system: Windows NT 08:37:50 INFO - 6.3.9600 08:37:50 INFO - CPU: x86 08:37:50 INFO - GenuineIntel family 6 model 63 stepping 2 08:37:50 INFO - 16 CPUs 08:37:50 INFO - Crash reason: EXCEPTION_BREAKPOINT 08:37:50 INFO - Crash address: 0x68c7f89d 08:37:50 INFO - Thread 3 (crashed) 08:37:50 INFO - 0 xul.dll + 0x51f89d 08:37:50 INFO - eip = 0x68c7f89d esp = 0x0779f9c8 ebp = 0x0779f9d4 ebx = 0x0779faa4 08:37:50 INFO - esi = 0x0779fa5c edi = 0xffffffff eax = 0x00000000 ecx = 0x6f2806ef 08:37:50 INFO - edx = 0xfeb3f000 efl = 0x00000202 08:37:50 INFO - Found by: given as instruction pointer in context 08:37:50 INFO - 1 xul.dll + 0x5254ba 08:37:50 INFO - eip = 0x68c854bb esp = 0x0779f9dc ebp = 0x0779fa2c 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 2 xul.dll + 0x525383 08:37:50 INFO - eip = 0x68c85384 esp = 0x0779fa34 ebp = 0x0779fb18 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 3 xul.dll + 0x514bf8 08:37:50 INFO - eip = 0x68c74bf9 esp = 0x0779fb20 ebp = 0x0779fb20 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 4 kernel32.dll + 0x17c03 08:37:50 INFO - eip = 0x77497c04 esp = 0x0779fb28 ebp = 0x0779fb34 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 5 mozglue.dll + 0x1e96 08:37:50 INFO - eip = 0x71e61e97 esp = 0x0779fb3c ebp = 0x0779fb88 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 6 ntdll.dll + 0x5ab8e 08:37:50 INFO - eip = 0x778fab8f esp = 0x0779fb90 ebp = 0x0779fbd0 08:37:50 INFO - Found by: previous frame's frame pointer 08:37:50 INFO - 7 ntdll.dll + 0x5ab59 08:37:50 INFO - eip = 0x778fab5a esp = 0x0779fbd8 ebp = 0x0779fbe0 08:37:50 INFO - Found by: previous frame's frame pointer
This sounds extremely similar to bug 1355196.
https://wiki.mozilla.org/Bugmasters#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 8 years ago
Resolution: --- → INCOMPLETE
Product: Core → Firefox Build System
You need to log in before you can comment on or make changes to this bug.