Closed Bug 1034414 Opened 11 years ago Closed 10 years ago

Intermittent B2G debug mochitest 9 test_eventTimeStamp.html | Test timed out | Shutdown | application timed out after 450.0 seconds with no output | ABORT: ActorDestroy by IPC channel failure at CompositorChild: file ipc/CompositorChild.cpp, line 169

Categories

(Core :: DOM: Events, defect)

Product:
Core
Component:
DOM: Events
Platform:
x86_64
Linux
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

()

Status:
RESOLVED WORKSFORME

People

(Reporter: nigelb, Unassigned)

References

(
URL
)

Details

(Keywords: intermittent-failure)

b2g_emulator_vm mozilla-inbound debug test mochitest-debug-9 on 2014-07-03 18:27:49 PDT for push 1fd5a864e81d slave: tst-linux64-spot-959 https://tbpl.mozilla.org/php/getParsedLog.php?id=43091896&tree=Mozilla-Inbound 18:42:34 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:42:35 INFO - ###################################### forms.js loaded 18:42:36 INFO - ############################### browserElementPanning.js loaded 18:42:37 INFO - ######################## BrowserElementChildPreload.js loaded 18:42:58 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:43:05 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(startupCache) failed: file ../../../gecko/dom/xbl/nsXBLDocumentInfo.cpp, line 238 18:43:05 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(startupCache) failed: file ../../../gecko/dom/xbl/nsXBLDocumentInfo.cpp, line 306 18:43:06 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(nsContentUtils::GetCurrentJSContext()) failed: file ../../../gecko/docshell/base/nsDocShell.cpp, line 8685 18:43:08 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(globalObject && globalObject->GetGlobalJSObject()) failed: file ../../../../../gecko/content/html/document/src/nsHTMLContentSink.cpp, line 741 18:43:09 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:12 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:15 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:18 INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 18:43:18 INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 18:43:19 INFO - 0 INFO Running tests 1167-1312/2186 18:43:19 INFO - 1 INFO SimpleTest START 18:43:19 INFO - 2 INFO TEST-START | /tests/dom/events/test/test_eventTimeStamp.html 18:43:19 INFO - [Child 737] WARNING: TabChild::SetFocus not supported in TabChild: file ../../../gecko/dom/ipc/TabChild.cpp, line 1137 18:43:19 INFO - [Parent 662] WARNING: No docshells for remote frames!: file ../../../../gecko/content/base/src/nsFrameLoader.cpp, line 631 18:43:20 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:21 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:21 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:21 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:22 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:43:22 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:23 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:23 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:24 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(ParseTypeAttribute(type, &version)) failed: file ../../../../gecko/content/base/src/nsScriptLoader.cpp, line 606 18:43:24 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(ParseTypeAttribute(type, &version)) failed: file ../../../../gecko/content/base/src/nsScriptLoader.cpp, line 606 18:43:25 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:25 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:25 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:43:26 INFO - [Child 737] WARNING: Unable to printf the requested string due to error.: file ../../../gecko/ipc/chromium/src/base/string_util.cc, line 427 18:43:27 INFO - [Child 737] WARNING: Unable to printf the requested string due to error.: file ../../../gecko/ipc/chromium/src/base/string_util.cc, line 427 18:44:02 INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 18:44:02 INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 18:50:19 INFO - 3 INFO TEST-INFO | dumping last 2 message(s) 18:50:19 INFO - 4 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test 18:50:19 INFO - 5 INFO TEST-PASS | /tests/dom/events/test/test_eventTimeStamp.html | Event timestamp (4191.684246000001) is in expected range: (3445.376854, 4242.0536010000005) 18:50:19 INFO - 6 INFO TEST-KNOWN-FAIL | /tests/dom/events/test/test_eventTimeStamp.html | Event timestamp in dedicated worker (0) is in expected range: (4434.798823, 5913.723226) 18:50:19 INFO - 7 INFO TEST-UNEXPECTED-FAIL | /tests/dom/events/test/test_eventTimeStamp.html | Test timed out. 18:50:21 INFO - 8 INFO TEST-INFO | MEMORY STAT vsize after test: 102514688 18:50:21 INFO - 9 INFO TEST-INFO | MEMORY STAT vsizeMaxContiguous not supported in this build configuration. 18:50:21 INFO - 10 INFO TEST-INFO | MEMORY STAT residentFast after test: 51306496 18:50:21 INFO - 11 INFO TEST-INFO | MEMORY STAT heapAllocated after test: 15011148 18:50:21 INFO - 12 INFO TEST-END | /tests/dom/events/test/test_eventTimeStamp.html | finished in 422122ms 18:50:22 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:22 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:50:22 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:23 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:23 INFO - 13 INFO TEST-START | /tests/dom/events/test/test_eventctors.html 18:50:23 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:24 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:50:24 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:24 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:27 INFO - [Child 737] WARNING: NS_ENSURE_TRUE(view) failed: file ../../../gecko/dom/events/UIEvent.cpp, line 162 18:50:29 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:30 INFO - 14 INFO TEST-INFO | MEMORY STAT vsize after test: 102682624 18:50:30 INFO - 15 INFO TEST-INFO | MEMORY STAT residentFast after test: 53575680 18:50:30 INFO - 16 INFO TEST-INFO | MEMORY STAT heapAllocated after test: 16425384 18:50:30 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:31 INFO - 17 INFO TEST-END | /tests/dom/events/test/test_eventctors.html | finished in 8047ms 18:50:33 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:34 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:50:34 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:35 INFO - 18 INFO TEST-START | /tests/dom/events/test/test_focus_disabled.html 18:50:35 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:36 INFO - [Child 737] WARNING: Failed to retarget HTML data delivery to the parser thread.: file ../../../gecko/parser/html/nsHtml5StreamParser.cpp, line 947 18:50:36 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:37 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:38 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:38 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:39 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:39 INFO - [Child 737] WARNING: Transparent content with displayports can be expensive.: file ../../../gecko/layout/base/nsDisplayList.cpp, line 1371 18:50:41 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:50:41 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:50:44 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:50:44 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:50:47 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781 18:50:47 INFO - [Child 737] WARNING: nsWindow::GetNativeData not implemented for this type: file ../../../gecko/widget/xpwidgets/PuppetWidget.cpp, line 781
Hi Ben, Can you have a look at the SharedWorker part of the following test and tell me if I'm doing something stupid? http://dxr.mozilla.org/mozilla-central/source/dom/events/test/test_eventTimeStamp.html Looking at the logs above there are the following two warnings before it times out: INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 INFO - [Parent 662] WARNING: A control runnable was posted to a worker that is already shutting down!: file ../../../gecko/dom/workers/WorkerPrivate.cpp, line 2268 It seems to always fail on the SharedWorker part so perhaps I'm using it incorrectly?
Flags: needinfo?(bent.mozilla)
I don't see anything obviously wrong, looks like this will just require some debugging. I'd start by adding logging statements to see where the expected flow is interrupted.
Flags: needinfo?(bent.mozilla)
Inactive; closing (see bug 1180138).
Status: NEW → RESOLVED
Closed: 10 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.