Closed Bug 783913 Opened 11 years ago Closed 6 years ago

Intermittent timeout in test_add_put.html, test_add_twice_failure.html, test_advance.html, test_autoIncrement.html, shutdown timeout, child process still alive

Categories

(Core :: IPC, defect, P3)

Product:
Core
Component:
IPC
Platform:
x86
Windows 7
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE
Tracking Flags:
Tracking Status
b2g18 --- disabled
b2g18-v1.0.1 --- disabled

People

(Reporter: philor, Unassigned)

References

Details

(Keywords: intermittent-failure) 

https://tbpl.mozilla.org/php/getParsedLog.php?id=14512062&tree=Mozilla-Inbound
Rev3 WINNT 6.1 mozilla-inbound debug test mochitests-2/5 on 2012-08-19 12:46:42 PDT for push 6c1dfc8d5b4b
slave: talos-r3-w7-072

15698 INFO TEST-END | /tests/dom/indexedDB/ipc/test_ipc.html | finished in 373430ms
15699 INFO TEST-START | /tests/dom/indexedDB/test/test_add_put.html
++DOMWINDOW == 15 (1D0237E0) [serial = 2714] [outer = 0E0D0A40]
[Child 1600] WARNING: NS_ENSURE_TRUE(mDocShell) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/embedding/browser/webBrowser/nsWebBrowser.cpp, line 372
[Child 1600] WARNING: NS_ENSURE_TRUE(domWindow) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/embedding/browser/webBrowser/nsDocShellTreeOwner.cpp, line 85
--DOCSHELL 0869A7E0 == 2 [id = 13]
--DOMWINDOW == 9 (02E38698) [serial = 129] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_transaction_abort.html]
--DOMWINDOW == 8 (086A2318) [serial = 128] [outer = 084938E8] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_traffic_jam.html]
[Child 1600] WARNING: NS_ENSURE_TRUE(IsChromeProcess()) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/content/base/src/nsFrameMessageManager.cpp, line 601
--DOMWINDOW == 7 (02DEAE20) [serial = 21] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test?consoleLevel=INFO&autorun=1]
--DOMWINDOW == 6 (086A20F0) [serial = 134] [outer = 00000000] [url = about:blank]
--DOMWINDOW == 5 (030727D0) [serial = 133] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_unique_index_update.html]
--DOMWINDOW == 4 (086A1EC8) [serial = 132] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_transaction_ordering.html]
--DOMWINDOW == 3 (02E37558) [serial = 131] [outer = 084938E8] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_transaction_lifetimes_nested.html]
--DOMWINDOW == 2 (03071018) [serial = 130] [outer = 084938E8] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_transaction_lifetimes.html]
[Child 1600] WARNING: NS_ENSURE_TRUE(inBrowser) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/embedding/browser/webBrowser/nsDocShellTreeOwner.cpp, line 81
--DOMWINDOW == 1 (08493938) [serial = 27] [outer = 00000000] [url = about:blank]
--DOMWINDOW == 0 (083F67D0) [serial = 26] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test?consoleLevel=INFO&autorun=1]
--DOCSHELL 02ECE850 == 1 [id = 4]
[Child 1600] WARNING: NS_ENSURE_TRUE(IsChromeProcess()) failed: file e:/builds/moz2_slave/m-in-w32-dbg/build/content/base/src/nsFrameMessageManager.cpp, line 601
--DOCSHELL 02F13B78 == 0 [id = 6]
[Parent 2840] WARNING: 1 sort operation has occurred for the SQL statement '0xd99d800'.  See https://developer.mozilla.org/En/Storage/Warnings details.: file e:/builds/moz2_slave/m-in-w32-dbg/build/storage/src/mozStoragePrivateHelpers.cpp, line 110
15700 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_add_put.html | Test timed out.
args: ['C:\\talos-slave\\test\\build\\bin\\screenshot.exe', 'c:\\users\\cltbld\\appdata\\local\\temp\\mozilla-test-fail_ciqhqk']
(screenshot)
15701 INFO TEST-END | /tests/dom/indexedDB/test/test_add_put.html | finished in 325774ms
15702 INFO TEST-START | /tests/dom/indexedDB/test/test_add_twice_failure.html
++DOMWINDOW == 16 (1D02BD90) [serial = 2715] [outer = 0E0D0A40]
--DOMWINDOW == 15 (1D0237E0) [serial = 2714] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_add_put.html]
15703 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_add_twice_failure.html | Test timed out.
Not taking screenshot here: see the one that was previously logged
15704 INFO TEST-END | /tests/dom/indexedDB/test/test_add_twice_failure.html | finished in 330008ms
15705 INFO TEST-START | /tests/dom/indexedDB/test/test_advance.html
++DOMWINDOW == 16 (1D0237E0) [serial = 2716] [outer = 0E0D0A40]
--DOMWINDOW == 15 (1D02BD90) [serial = 2715] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_add_twice_failure.html]
[Parent 2840] WARNING: 1 sort operation has occurred for the SQL statement '0xd99d800'.  See https://developer.mozilla.org/En/Storage/Warnings details.: file e:/builds/moz2_slave/m-in-w32-dbg/build/storage/src/mozStoragePrivateHelpers.cpp, line 110
15706 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_advance.html | Test timed out.
Not taking screenshot here: see the one that was previously logged
15707 INFO TEST-END | /tests/dom/indexedDB/test/test_advance.html | finished in 330008ms
15708 INFO TEST-START | /tests/dom/indexedDB/test/test_autoIncrement.html
++DOMWINDOW == 16 (1D02BD90) [serial = 2717] [outer = 0E0D0A40]
--DOMWINDOW == 15 (1D0237E0) [serial = 2716] [outer = 00000000] [url = http://mochi.test:8888/tests/dom/indexedDB/test/test_advance.html]
[Parent 2840] WARNING: 1 sort operation has occurred for the SQL statement '0xd99d800'.  See https://developer.mozilla.org/En/Storage/Warnings details.: file e:/builds/moz2_slave/m-in-w32-dbg/build/storage/src/mozStoragePrivateHelpers.cpp, line 110
15709 ERROR TEST-UNEXPECTED-FAIL | /tests/dom/indexedDB/test/test_autoIncrement.html | Test timed out.
Not taking screenshot here: see the one that was previously logged
15710 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | 4 test timeouts, giving up.
15711 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | Skipping 73 remaining tests.
15712 ERROR TEST-UNEXPECTED-FAIL | (SimpleTest/TestRunner.js) | finished in a non-clean fashion (in /tests/dom/indexedDB/test/test_autoIncrement.html)
15713 INFO TEST-END | (SimpleTest/TestRunner.js) | finished in 330009ms
15714 INFO TEST-START | Shutdown
15715 INFO Passed: 207733
15716 INFO Failed: 7
15717 INFO Todo:   18588
15718 INFO SimpleTest FINISHED
15719 INFO TEST-INFO | Ran 0 Loops
15720 INFO SimpleTest FINISHED
++DOMWINDOW == 16 (1D0237E0) [serial = 2718] [outer = 0E0D0A40]
[Parent 2840] ###!!! ASSERTION: Oops!  You're asking for a weak reference to an object that doesn't support that.: 'factoryPtr', file e:/builds/moz2_slave/m-in-w32-dbg/build/obj-firefox/xpcom/build/nsWeakReference.cpp, line 77
(useless stack)
(shutdown noise)
TEST-UNEXPECTED-FAIL | Shutdown | application timed out after 330 seconds with no output
Not taking screenshot here: see the one that was previously logged
INFO | automation.py | Application ran for: 0:47:59.590000
INFO | automation.py | Reading PID log: c:\users\cltbld\appdata\local\temp\tmpj4gw1opidlog
==> process 2840 launched child process 1600
INFO | automation.py | Checking for orphan process with PID: 1600
TEST-UNEXPECTED-FAIL | automation.py | child process 1600 still alive after shutdown
Downloading symbols from: http://ftp.mozilla.org/pub/mozilla.org/firefox/tinderbox-builds/mozilla-inbound-win32-debug/1345403043/firefox-17.0a1.en-US.win32.crashreporter-symbols.zip
PROCESS-CRASH | Shutdown | application crashed (minidump found)
(useless stack)
Kyle/Ben, please may one of you take a look?
status-firefox18: --- → affected