Closed Bug 1395850 Opened 7 years ago Closed 5 years ago

Intermittent Shutdown loop WARNING: '!ipcActor->SendAccumulateChildHistograms(accumulationsToSend)'

Categories

(Core :: WebRTC: Audio/Video, defect, P3)

defect

Tracking

()

RESOLVED WORKSFORME

People

(Reporter: aryx, Unassigned)

Details

(Keywords: intermittent-failure)

https://treeherder.mozilla.org/logviewer.html#?job_id=127642580&repo=autoland This eventually exceeds the run time limit. 22:28:39 INFO - TEST-START | Shutdown 22:28:39 INFO - Passed: 36485 22:28:39 INFO - Failed: 0 22:28:39 INFO - Todo: 1516 22:28:39 INFO - Mode: e10s 22:28:39 INFO - Slowest: 13137ms - /tests/dom/media/tests/mochitest/test_peerConnection_sender_and_receiver_stats.html 22:28:39 INFO - SimpleTest FINISHED 22:28:39 INFO - TEST-INFO | Ran 1 Loops 22:28:39 INFO - SimpleTest FINISHED 22:28:39 INFO - GECKO(1765) | --DOCSHELL 0x12d180800 == 2 [pid = 1766] [id = {774b06db-81d5-1b4f-9371-5ef6c8b004b6}] 22:28:39 INFO - GECKO(1765) | ++DOMWINDOW == 11 (0x12b0d7800) [pid = 1766] [serial = 536] [outer = 0x12a308800] 22:28:39 INFO - GECKO(1765) | --DOCSHELL 0x12f166000 == 2 [pid = 1765] [id = {24ad9c68-7dbe-f94e-a1d6-a95036ac5ba1}] 22:28:39 INFO - GECKO(1765) | --DOCSHELL 0x126ca9000 == 1 [pid = 1765] [id = {09b2016d-7474-474c-91e5-3a190c108a29}] 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6E0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:39 INFO - GECKO(1765) | [Main Thread]: D/DataChannel Shutting down SCTP 22:28:39 INFO - GECKO(1765) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 738 22:28:39 INFO - GECKO(1765) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 22:28:39 INFO - GECKO(1765) | [Child 1766] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 797 22:28:40 INFO - GECKO(1765) | [Parent 1765] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 738 22:28:40 INFO - GECKO(1765) | [Parent 1765] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 797 22:28:41 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F3,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: '!ipcActor->SendAccumulateChildHistograms(accumulationsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 299 22:28:41 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F4,name=PContent::Msg_AccumulateChildKeyedHistograms) Closed channel: cannot send/recv 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: '!ipcActor->SendAccumulateChildKeyedHistograms(keyedAccumulationsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 303 22:28:41 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F8,name=PContent::Msg_RecordDiscardedData) Closed channel: cannot send/recv 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:41 INFO - GECKO(1765) | [Child 1766] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 318 22:28:43 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F3,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv 22:28:43 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:43 INFO - GECKO(1765) | [Child 1766] WARNING: '!ipcActor->SendAccumulateChildHistograms(accumulationsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 299 22:28:43 INFO - GECKO(1765) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F4,name=PContent::Msg_AccumulateChildKeyedHistograms) Closed channel: cannot send/recv 22:28:43 INFO - GECKO(1765) | [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 22:28:43 INFO - GECKO(1765) | [Child 1766] WARNING: '!ipcActor->SendAccumulateChildKeyedHistograms(keyedAccumulationsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 303
I'll call out that this is a media test. We saw some special issues from these before, e.g. from run-away threads / threads that run late in shutdown. First there are a few of these: > WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 https://dxr.mozilla.org/mozilla-central/rev/13d241d08912be31884f9d0d0e805b25343d6c0a/toolkit/components/telemetry/TelemetryScalar.cpp#2184 And somehow our TelemetrIPCAccumulator got into a state of continously trying to send data up - this is showing up repeatedly until timeout: > ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F4,name=PContent::Msg_AccumulateChildKeyedHistograms) Closed channel: cannot send/recv > [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 > [Child 1766] WARNING: '!ipcActor->SendAccumulateChildKeyedHistograms(keyedAccumulationsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 303 > ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F8,name=PContent::Msg_RecordDiscardedData) Closed channel: cannot send/recv > [Child 1766] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2347 > [Child 1766] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 318 https://treeherder.mozilla.org/logviewer.html#?job_id=127642580&repo=autoland&lineNumber=48941 https://dxr.mozilla.org/mozilla-central/rev/13d241d08912be31884f9d0d0e805b25343d6c0a/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp#295 So, what does this mean? Our code prints errors, but is our code actually the culprit? We always clear the childs buffers, whether we succeed in sending it to the parent or not: https://dxr.mozilla.org/mozilla-central/rev/13d241d08912be31884f9d0d0e805b25343d6c0a/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp#264 Is there any other potential for running into an infinite loop? Or is this another run-away thread/component just triggering it repeatedly? How could we find this out?
Chris, whats your take?
Flags: needinfo?(chutten)
Let's see... the loop is tightest on ipcActor->SendAccumulateChildKeyedHistograms(keyedAccumulationsToSend) ipcActor->SendRecordDiscardedData(discardedData) The second of those is attempted whenever there's data to send, so it doesn't mean much. My leading theory at the moment is that it is IPC itself that's contributing to this loop. If IPC is slow to write/read/send, it accumulates to keyed histograms (IPC_SYNC_MAIN_LATENCY_MS, IPC_READ_MAIN_THREAD_LATENCY_MS, IPC_WRITE_MAIN_THREAD_LATENCY_MS) This would ensure that there was always something in the buffers to attempt to send every 2s when the timer fires. Not a tight loop, but exactly what you see happening in the log.
Flags: needinfo?(chutten)
Priority: -- → P1
This is a media test that's having problems. :jesup, have you seen anything like this before?
Flags: needinfo?(rjesup)
Nico, i see you in the log for the test - do you have an idea?
Flags: needinfo?(na-g)
Any chance this bug, and Bug 1351655 are related? Both seem to be ipc/telemetry/shutdown related.
I don't know anything in this test that would cause it to fail more than others in the suite. It does wait for RTCP stats to arrive at both PeerConnection objects which takes ~5 seconds, though there are other tests that have similar waits.
Flags: needinfo?(na-g)
It looks like there was no further occurence of this, closing for now.
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
Reopening for https://treeherder.mozilla.org/logviewer.html#?job_id=132014481&repo=mozilla-inbound 09:58:34 INFO - TEST-OK | dom/media/tests/mochitest/test_selftest.html | took 1107ms 09:58:35 INFO - GECKO(663) | ++DOMWINDOW == 7 (0x11db6f000) [pid = 664] [serial = 543] [outer = 0x12801c000] 09:58:35 INFO - GECKO(663) | [Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:3043: CloseInt: Closing PeerConnectionImpl e865108937aebafa; ending call 09:58:35 INFO - GECKO(663) | [Main Thread]: I/jsep [1505840314867507 (id=2147484188 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_selftest.html)]: stable -> closed 09:58:35 INFO - GECKO(663) | [Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:3043: CloseInt: Closing PeerConnectionImpl 3512d6ab56975cab; ending call 09:58:35 INFO - GECKO(663) | [Main Thread]: I/jsep [1505840314874513 (id=2147484188 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_selftest.html)]: stable -> closed 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: stylo: Web Components not supported yet: file /builds/worker/workspace/build/src/dom/base/nsDocument.cpp, line 6391 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: stylo: Web Components not supported yet: file /builds/worker/workspace/build/src/dom/base/nsDocument.cpp, line 6391 09:58:35 INFO - TEST-START | Shutdown 09:58:35 INFO - Passed: 35554 09:58:35 INFO - Failed: 0 09:58:35 INFO - Todo: 1525 09:58:35 INFO - Mode: e10s 09:58:35 INFO - Slowest: 12636ms - /tests/dom/media/tests/mochitest/test_peerConnection_sender_and_receiver_stats.html 09:58:35 INFO - SimpleTest FINISHED 09:58:35 INFO - TEST-INFO | Ran 1 Loops 09:58:35 INFO - SimpleTest FINISHED 09:58:35 INFO - GECKO(663) | --DOCSHELL 0x11dc2d000 == 2 [pid = 664] [id = {d767eb0b-78f8-6d4a-9c59-eaf7d2598950}] 09:58:35 INFO - GECKO(663) | ++DOMWINDOW == 8 (0x11db5e800) [pid = 664] [serial = 544] [outer = 0x12801c000] 09:58:35 INFO - GECKO(663) | --DOCSHELL 0x1288ac000 == 2 [pid = 663] [id = {c6f20051-ac95-194d-b0c6-baf8b8cc4030}] 09:58:35 INFO - GECKO(663) | --DOCSHELL 0x11cf10000 == 1 [pid = 663] [id = {bf8f1dd0-fdb5-9a41-8a15-1d0a0e6336f4}] 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_FAILED internal_GetScalarByEnum for CHILD: file /builds/worker/workspace/build/src/toolkit/components/telemetry/TelemetryScalar.cpp, line 2184 09:58:35 INFO - GECKO(663) | --DOCSHELL 0x12811a000 == 0 [pid = 663] [id = {e8335208-c274-bb4e-97e7-6d3881ac9c85}] 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0007,name=PTCPSocket::Msg_Close) Closed channel: cannot send/recv 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:35 INFO - GECKO(663) | [Main Thread]: D/DataChannel Shutting down SCTP 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 738 09:58:35 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 797 09:58:36 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/workspace/build/src/widget/cocoa/nsAppShell.mm, line 738 09:58:36 INFO - GECKO(663) | [Parent 663, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 797 09:58:37 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400ED,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: '!ipcActor->SendAccumulateChildHistograms(histogramsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 299 09:58:37 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400EE,name=PContent::Msg_AccumulateChildKeyedHistograms) Closed channel: cannot send/recv 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: '!ipcActor->SendAccumulateChildKeyedHistograms(keyedHistogramsToSend)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 303 09:58:37 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400F2,name=PContent::Msg_RecordDiscardedData) Closed channel: cannot send/recv 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: MsgDropped in ContentChild: file /builds/worker/workspace/build/src/dom/ipc/ContentChild.cpp, line 2368 09:58:37 INFO - GECKO(663) | [Child 664, Main Thread] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/workspace/build/src/toolkit/components/telemetry/ipc/TelemetryIPCAccumulator.cpp, line 318 09:58:39 INFO - GECKO(663) | ###!!! [Child][MessageChannel] Error: (msgtype=0x2400ED,name=PContent::Msg_AccumulateChildHistograms) Closed channel: cannot send/recv
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Rehoming to webrtc/media. The test is intermittently not shutting down properly, resulting in a state where IPC is shut down and a child process is alive. Might not be media, might be IPC?
Component: Telemetry → WebRTC: Audio/Video
Product: Toolkit → Core
More to the point, the browser isn't shutting down after running the suite of tests, which implies a shutdown blocker is active. Unfortunately, the harness doesn't force a crash here, so we can't see what threads/etc are still running, or what we're waiting on. And I'm surprised if it is a shutdown blocker since we have shutdown timeouts - the lack of getting killled by that implies we never got to the point of priming the shutdown timeout; we hung up on something earlier.
Flags: needinfo?(rjesup)
Rank: 23
Priority: P1 → P3

No hits in over two years, calling this WORKSFORME.

Status: REOPENED → RESOLVED
Closed: 7 years ago5 years ago
Resolution: --- → WORKSFORME
You need to log in before you can comment on or make changes to this bug.