1493312 - Intermittent GECKO(2896) | Assertion failure: mInputListener == aListener, at /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp:2854

Status: RESOLVED INCOMPLETE

(Core :: Audio/Video: MediaStreamGraph, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: cbrindusan [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=200846036&repo=autoland

https://queue.taskcluster.net/v1/task/UM9UT0OYQiOsAWJefVC8mw/runs/0/artifacts/public/logs/live_backing.log

[task 2018-09-21T21:35:49.002Z] 21:35:49     INFO - TEST-START | dom/media/tests/mochitest/test_peerConnection_audioSynchronizationSources.html
[task 2018-09-21T21:35:49.659Z] 21:35:49     INFO - GECKO(2896) | ++DOMWINDOW == 9 (0xe1c97400) [pid = 2983] [serial = 164] [outer = 0xe8a7c160]
[task 2018-09-21T21:35:50.450Z] 21:35:50     INFO - GECKO(2896) | ++DOCSHELL 0xe1c2c400 == 4 [pid = 2983] [id = {66328fb7-0a8e-40ee-a49a-3c924f068154}]
[task 2018-09-21T21:35:50.452Z] 21:35:50     INFO - GECKO(2896) | ++DOMWINDOW == 10 (0xe5b19040) [pid = 2983] [serial = 165] [outer = (nil)]
[task 2018-09-21T21:35:50.454Z] 21:35:50     INFO - GECKO(2896) | --DOCSHELL 0xe1c1e400 == 3 [pid = 2983] [id = {5324fcd2-7c60-4e2b-88a2-f50d14ba92f0}]
[task 2018-09-21T21:35:50.524Z] 21:35:50     INFO - GECKO(2896) | ++DOMWINDOW == 11 (0xe1c9a000) [pid = 2983] [serial = 166] [outer = 0xe5b19040]
[task 2018-09-21T21:35:50.627Z] 21:35:50     INFO - GECKO(2896) | TEST DEVICES: Got loopback audio: Monitor of Null Output
[task 2018-09-21T21:35:50.629Z] 21:35:50     INFO - GECKO(2896) | TEST DEVICES: Got loopback video: Dummy video device (0x0000)
[task 2018-09-21T21:35:51.362Z] 21:35:51     INFO - GECKO(2896) | Timecard created 1537565741.076870
[task 2018-09-21T21:35:51.364Z] 21:35:51     INFO - GECKO(2896) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2018-09-21T21:35:51.366Z] 21:35:51     INFO - GECKO(2896) | ======================================================================================================================
[task 2018-09-21T21:35:51.367Z] 21:35:51     INFO - GECKO(2896) |     0.000065 |    0.000065 | Constructor Completed          | PeerConnectionImpl.cpp:360   | PeerConnectionImpl
[task 2018-09-21T21:35:51.368Z] 21:35:51     INFO - GECKO(2896) |     0.011750 |    0.011685 | Initializing PC Ctx            | PeerConnectionImpl.cpp:651   | Initialize
[task 2018-09-21T21:35:51.374Z] 21:35:51     INFO - GECKO(2896) |     4.007946 |    3.996196 | Create Offer                   | PeerConnectionImpl.cpp:1496  | CreateOffer
[task 2018-09-21T21:35:51.382Z] 21:35:51     INFO - GECKO(2896) |     4.021394 |    0.013448 | Set Local Description          | PeerConnectionImpl.cpp:1584  | SetLocalDescription
[task 2018-09-21T21:35:51.387Z] 21:35:51     INFO - GECKO(2896) |     4.247427 |    0.226033 | Set Remote Description         | PeerConnectionImpl.cpp:1691  | SetRemoteDescription
[task 2018-09-21T21:35:51.391Z] 21:35:51     INFO - GECKO(2896) |     4.409457 |    0.162030 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3028  | IceGatheringStateChange
[task 2018-09-21T21:35:51.393Z] 21:35:51     INFO - GECKO(2896) |     4.581469 |    0.172012 | Ice gathering state: complete  | PeerConnectionImpl.cpp:3031  | IceGatheringStateChange
[task 2018-09-21T21:35:51.405Z] 21:35:51     INFO - GECKO(2896) |     4.882559 |    0.301090 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.414Z] 21:35:51     INFO - GECKO(2896) |     4.999268 |    0.116709 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.415Z] 21:35:51     INFO - GECKO(2896) |     5.040051 |    0.040783 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.418Z] 21:35:51     INFO - GECKO(2896) |     5.068705 |    0.028654 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.423Z] 21:35:51     INFO - GECKO(2896) |     5.093466 |    0.024761 | Ice state: checking            | PeerConnectionImpl.cpp:2980  | IceConnectionStateChange
[task 2018-09-21T21:35:51.425Z] 21:35:51     INFO - GECKO(2896) |     5.095249 |    0.001783 | Ice state: connected           | PeerConnectionImpl.cpp:2983  | IceConnectionStateChange
[task 2018-09-21T21:35:51.427Z] 21:35:51     INFO - GECKO(2896) |    10.277751 |    5.182502 | Destructor Invoked             | PeerConnectionImpl.cpp:374   | ~PeerConnectionImpl
[task 2018-09-21T21:35:51.428Z] 21:35:51     INFO - GECKO(2896) | [Child 2983: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:403: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for a4175b5546e347ba
[task 2018-09-21T21:35:51.430Z] 21:35:51     INFO - GECKO(2896) | Timecard created 1537565741.109514
[task 2018-09-21T21:35:51.433Z] 21:35:51     INFO - GECKO(2896) |  Timestamp   | Delta       | Event                          | File                         | Function
[task 2018-09-21T21:35:51.436Z] 21:35:51     INFO - GECKO(2896) | ======================================================================================================================
[task 2018-09-21T21:35:51.442Z] 21:35:51     INFO - GECKO(2896) |     0.000025 |    0.000025 | Constructor Completed          | PeerConnectionImpl.cpp:360   | PeerConnectionImpl
[task 2018-09-21T21:35:51.443Z] 21:35:51     INFO - GECKO(2896) |     0.001153 |    0.001128 | Initializing PC Ctx            | PeerConnectionImpl.cpp:651   | Initialize
[task 2018-09-21T21:35:51.445Z] 21:35:51     INFO - GECKO(2896) |     4.020817 |    4.019664 | Set Remote Description         | PeerConnectionImpl.cpp:1691  | SetRemoteDescription
[task 2018-09-21T21:35:51.446Z] 21:35:51     INFO - GECKO(2896) |     4.168770 |    0.147953 | Create Answer                  | PeerConnectionImpl.cpp:1537  | CreateAnswer
[task 2018-09-21T21:35:51.448Z] 21:35:51     INFO - GECKO(2896) |     4.182503 |    0.013733 | Set Local Description          | PeerConnectionImpl.cpp:1584  | SetLocalDescription
[task 2018-09-21T21:35:51.451Z] 21:35:51     INFO - GECKO(2896) |     4.548111 |    0.365608 | Ice gathering state: gathering | PeerConnectionImpl.cpp:3028  | IceGatheringStateChange
[task 2018-09-21T21:35:51.453Z] 21:35:51     INFO - GECKO(2896) |     4.549177 |    0.001066 | Ice gathering state: complete  | PeerConnectionImpl.cpp:3031  | IceGatheringStateChange
[task 2018-09-21T21:35:51.455Z] 21:35:51     INFO - GECKO(2896) |     4.632428 |    0.083251 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.457Z] 21:35:51     INFO - GECKO(2896) |     4.675819 |    0.043391 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.459Z] 21:35:51     INFO - GECKO(2896) |     4.713210 |    0.037391 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.461Z] 21:35:51     INFO - GECKO(2896) |     4.744346 |    0.031136 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.464Z] 21:35:51     INFO - GECKO(2896) |     4.769642 |    0.025296 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.466Z] 21:35:51     INFO - GECKO(2896) |     4.791397 |    0.021755 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.468Z] 21:35:51     INFO - GECKO(2896) |     4.809518 |    0.018121 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.471Z] 21:35:51     INFO - GECKO(2896) |     4.826725 |    0.017207 | Add Ice Candidate              | PeerConnectionImpl.cpp:1863  | AddIceCandidate
[task 2018-09-21T21:35:51.473Z] 21:35:51     INFO - GECKO(2896) |     5.056445 |    0.229720 | Ice state: checking            | PeerConnectionImpl.cpp:2980  | IceConnectionStateChange
[task 2018-09-21T21:35:51.475Z] 21:35:51     INFO - GECKO(2896) |     5.063794 |    0.007349 | Ice state: connected           | PeerConnectionImpl.cpp:2983  | IceConnectionStateChange
[task 2018-09-21T21:35:51.476Z] 21:35:51     INFO - GECKO(2896) |    10.245508 |    5.181714 | Destructor Invoked             | PeerConnectionImpl.cpp:374   | ~PeerConnectionImpl
[task 2018-09-21T21:35:51.478Z] 21:35:51     INFO - GECKO(2896) | [Child 2983: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:403: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for 4e5c9cd94b1d20f3
[task 2018-09-21T21:35:51.677Z] 21:35:51     INFO - GECKO(2896) | --DOMWINDOW == 10 (0xe1c0b800) [pid = 2983] [serial = 156] [outer = (nil)] [url = http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_audioCodecs.html]
[task 2018-09-21T21:35:52.118Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.118Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.118Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC1] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.135Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.135Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.136Z] 21:35:52     INFO - GECKO(2896) | --DOMWINDOW == 9 (0xe5b21160) [pid = 2983] [serial = 161] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:35:52.143Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC1] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.146Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.154Z] 21:35:52     INFO - GECKO(2896) | [Child 2983, AudioIPC0] WARNING: No audio tracks, but full-duplex audio is enabled!!!!!: file /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp, line 367
[task 2018-09-21T21:35:52.176Z] 21:35:52     INFO - GECKO(2896) | Assertion failure: mInputListener == aListener, at /builds/worker/workspace/build/src/dom/media/MediaStreamGraph.cpp:2854
[task 2018-09-21T21:36:44.031Z] 21:36:44     INFO - GECKO(2896) | #01: mozilla::SourceMediaStream::CloseAudioInput(mozilla::Maybe<void const*>&, mozilla::AudioDataListener*) [dom/media/MediaStreamGraph.cpp:2854]
[task 2018-09-21T21:36:44.032Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.033Z] 21:36:44     INFO - GECKO(2896) | #02: mozilla::MediaEngineWebRTCMicrophoneSource::Stop(RefPtr<mozilla::AllocationHandle const> const&) [mfbt/RefPtr.h:69]
[task 2018-09-21T21:36:44.034Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.036Z] 21:36:44     INFO - GECKO(2896) | #03: mozilla::MediaDevice::Stop() [dom/media/MediaManager.cpp:1159]
[task 2018-09-21T21:36:44.037Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.038Z] 21:36:44     INFO - GECKO(2896) | #04: mozilla::media::LambdaTask<mozilla::SourceListener::StopTrack(int)::$_44>::Run() [dom/media/MediaManager.cpp:4366]
[task 2018-09-21T21:36:44.039Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.041Z] 21:36:44     INFO - GECKO(2896) | #05: nsThread::ProcessNextEvent(bool, bool*) [mfbt/Atomics.h:576]
[task 2018-09-21T21:36:44.044Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.047Z] 21:36:44     INFO - GECKO(2896) | #06: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:519]
[task 2018-09-21T21:36:44.052Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.054Z] 21:36:44     INFO - GECKO(2896) | #07: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:335]
[task 2018-09-21T21:36:44.055Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.057Z] 21:36:44     INFO - GECKO(2896) | #08: MessageLoop::RunInternal() [ipc/chromium/src/base/message_loop.cc:326]
[task 2018-09-21T21:36:44.058Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.059Z] 21:36:44     INFO - GECKO(2896) | #09: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:598]
[task 2018-09-21T21:36:44.061Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.061Z] 21:36:44     INFO - GECKO(2896) | #10: base::Thread::ThreadMain() [ipc/chromium/src/base/thread.cc:184]
[task 2018-09-21T21:36:44.062Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.063Z] 21:36:44     INFO - GECKO(2896) | #11: ThreadFunc(void*) [ipc/chromium/src/base/platform_thread_posix.cc:45]
[task 2018-09-21T21:36:44.063Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.064Z] 21:36:44     INFO - GECKO(2896) | #12: libpthread.so.0 + 0x6295
[task 2018-09-21T21:36:44.068Z] 21:36:44     INFO - 
[task 2018-09-21T21:36:44.069Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 13 (0xdf47d040) [pid = 2896] [serial = 147] [outer = (nil)] [url = chrome://browser/content/webrtcIndicator.xul]
[task 2018-09-21T21:36:44.070Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xdf41b000 == 5 [pid = 2896] [id = {7e6232a8-3a3f-4451-8b68-d833ed0f64bc}]
[task 2018-09-21T21:36:44.071Z] 21:36:44     INFO - GECKO(2896) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x190084,name=PBrowser::Msg_Destroy) Channel error: cannot send/recv
[task 2018-09-21T21:36:44.071Z] 21:36:44     INFO - GECKO(2896) | ++DOCSHELL 0xde31cc00 == 6 [pid = 2896] [id = {bfec4e72-1702-451c-abc4-627727db4a09}]
[task 2018-09-21T21:36:44.072Z] 21:36:44     INFO - GECKO(2896) | ++DOMWINDOW == 14 (0xdf47d040) [pid = 2896] [serial = 151] [outer = (nil)]
[task 2018-09-21T21:36:44.073Z] 21:36:44     INFO - GECKO(2896) | ++DOMWINDOW == 15 (0xde31fc00) [pid = 2896] [serial = 152] [outer = 0xdf47d040]
[task 2018-09-21T21:36:44.080Z] 21:36:44     INFO - GECKO(2896) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2018-09-21T21:36:44.085Z] 21:36:44     INFO - GECKO(2896) | ++DOMWINDOW == 16 (0xe2bb8c00) [pid = 2896] [serial = 153] [outer = 0xdf47d040]
[task 2018-09-21T21:36:44.086Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 867
[task 2018-09-21T21:36:44.087Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 3 (0xf71cf280) [pid = 2958] [serial = 1] [outer = (nil)] [url = moz-extension://5ed9b02c-308a-4ade-a473-befa0f78bf3e/_generated_background_page.html]
[task 2018-09-21T21:36:44.088Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.089Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.090Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.091Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.092Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.093Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.094Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.095Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.096Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.098Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 2 (0xe02ca160) [pid = 2958] [serial = 4] [outer = (nil)] [url = moz-extension://20033ea3-ca04-4f36-aebf-5c93e0d1c5bd/_generated_background_page.html]
[task 2018-09-21T21:36:44.100Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.101Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.102Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.104Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.105Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.106Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.108Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.109Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.110Z] 21:36:44     INFO - GECKO(2896) | [Child 2958, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.112Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe028e400 == 1 [pid = 2958] [id = {317263c8-cdc4-44a1-9264-cb2684e5c148}]
[task 2018-09-21T21:36:44.113Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe0249c00 == 0 [pid = 2958] [id = {5cabb23f-5727-4652-82bc-8259bd789ce2}]
[task 2018-09-21T21:36:44.114Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 1 (0xe0291000) [pid = 2958] [serial = 6] [outer = (nil)] [url = moz-extension://20033ea3-ca04-4f36-aebf-5c93e0d1c5bd/_generated_background_page.html]
[task 2018-09-21T21:36:44.117Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 0 (0xe0286400) [pid = 2958] [serial = 3] [outer = (nil)] [url = moz-extension://5ed9b02c-308a-4ade-a473-befa0f78bf3e/_generated_background_page.html]
[task 2018-09-21T21:36:44.118Z] 21:36:44     INFO - GECKO(2896) | nsStringStats
[task 2018-09-21T21:36:44.119Z] 21:36:44     INFO - GECKO(2896) |  => mAllocCount:          13166
[task 2018-09-21T21:36:44.119Z] 21:36:44     INFO - GECKO(2896) |  => mReallocCount:            0
[task 2018-09-21T21:36:44.120Z] 21:36:44     INFO - GECKO(2896) |  => mFreeCount:           13166
[task 2018-09-21T21:36:44.121Z] 21:36:44     INFO - GECKO(2896) |  => mShareCount:           6163
[task 2018-09-21T21:36:44.122Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptCount:            570
[task 2018-09-21T21:36:44.123Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptFreeCount:        582
[task 2018-09-21T21:36:44.124Z] 21:36:44     INFO - GECKO(2896) |  => Process ID: 2958, Thread ID: 4147123968
[task 2018-09-21T21:36:44.125Z] 21:36:44     INFO - GECKO(2896) | [Child 3028, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 867
[task 2018-09-21T21:36:44.126Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 15 (0xe2e5d800) [pid = 2896] [serial = 148] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.127Z] 21:36:44     INFO - GECKO(2896) | nsStringStats
[task 2018-09-21T21:36:44.128Z] 21:36:44     INFO - GECKO(2896) |  => mAllocCount:           8122
[task 2018-09-21T21:36:44.129Z] 21:36:44     INFO - GECKO(2896) |  => mReallocCount:            0
[task 2018-09-21T21:36:44.129Z] 21:36:44     INFO - GECKO(2896) |  => mFreeCount:            8122
[task 2018-09-21T21:36:44.130Z] 21:36:44     INFO - GECKO(2896) |  => mShareCount:           4666
[task 2018-09-21T21:36:44.131Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptCount:            115
[task 2018-09-21T21:36:44.132Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptFreeCount:        115
[task 2018-09-21T21:36:44.133Z] 21:36:44     INFO - GECKO(2896) |  => Process ID: 3028, Thread ID: 4147390208
[task 2018-09-21T21:36:44.134Z] 21:36:44     INFO - GECKO(2896) | 1537565755470	Marionette	DEBUG	Received observer notification xpcom-will-shutdown
[task 2018-09-21T21:36:44.135Z] 21:36:44     INFO - GECKO(2896) | 1537565755471	Marionette	INFO	Stopped listening on port 2828
[task 2018-09-21T21:36:44.140Z] 21:36:44     INFO - GECKO(2896) | 1537565755473	Marionette	DEBUG	Remote service is inactive
[task 2018-09-21T21:36:44.141Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/workspace/build/src/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1422
[task 2018-09-21T21:36:44.142Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 867
[task 2018-09-21T21:36:44.142Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-21T21:36:44.143Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-21T21:36:44.144Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-21T21:36:44.144Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-21T21:36:44.144Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 399
[task 2018-09-21T21:36:44.145Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/DOMEventTargetHelper.h, line 146
[task 2018-09-21T21:36:44.145Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/DOMEventTargetHelper.h, line 146
[task 2018-09-21T21:36:44.146Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 14 (0xdfde54c0) [pid = 2896] [serial = 149] [outer = (nil)] [url = chrome://browser/content/webrtcIndicator.xul]
[task 2018-09-21T21:36:44.146Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 13 (0xe4586a60) [pid = 2896] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.148Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 12 (0xe2d40800) [pid = 2896] [serial = 12] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.148Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 11 (0xdf426400) [pid = 2896] [serial = 150] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.149Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 10 (0xe5d49160) [pid = 2896] [serial = 3] [outer = (nil)] [url = chrome://browser/content/browser.xul]
[task 2018-09-21T21:36:44.150Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe7241400 == 5 [pid = 2896] [id = {f177da09-9c98-4601-b52c-3c76168a915e}]
[task 2018-09-21T21:36:44.151Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xde31cc00 == 4 [pid = 2896] [id = {bfec4e72-1702-451c-abc4-627727db4a09}]
[task 2018-09-21T21:36:44.151Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 9 (0xdf47d040) [pid = 2896] [serial = 151] [outer = (nil)] [url = about:tabcrashed?e=tabcrashed&u=http%3A//mochi.test%3A8888/tests%3Fautorun%3D1%26closeWhenDone%3D1%26consoleLevel%3DINFO%26manifestFile%3Dtests.json%26dumpOutputDirectory%3D%252Ftmp%26cleanupCrashes%3Dtrue&c=UTF-8&f=regular&d=MochiTest%20%7C%20/tests]
[task 2018-09-21T21:36:44.152Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.152Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.154Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.154Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.156Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.157Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.157Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.158Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.158Z] 21:36:44     INFO - GECKO(2896) | [Parent 2896, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 564
[task 2018-09-21T21:36:44.158Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 8 (0xde31fc00) [pid = 2896] [serial = 152] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.158Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 7 (0xe748f160) [pid = 2896] [serial = 1] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html]
[task 2018-09-21T21:36:44.159Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe74b0800 == 3 [pid = 2896] [id = {112b5e8e-b5d5-4dde-8f1b-6d960c7d6ed0}]
[task 2018-09-21T21:36:44.159Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe4574400 == 2 [pid = 2896] [id = {3fcfbca5-298b-4f62-9ec2-959804ab3be8}]
[task 2018-09-21T21:36:44.159Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 6 (0xe376a280) [pid = 2896] [serial = 13] [outer = (nil)] [url = chrome://extensions/content/dummy.xul]
[task 2018-09-21T21:36:44.159Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe2bb4c00 == 1 [pid = 2896] [id = {08994d03-d81a-452d-9cc7-9f4a3e6bf8a2}]
[task 2018-09-21T21:36:44.160Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 5 (0xe2bbd800) [pid = 2896] [serial = 16] [outer = (nil)] [url = chrome://extensions/content/dummy.xul]
[task 2018-09-21T21:36:44.161Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 4 (0xe4586ca0) [pid = 2896] [serial = 7] [outer = (nil)] [url = chrome://extensions/content/dummy.xul]
[task 2018-09-21T21:36:44.161Z] 21:36:44     INFO - GECKO(2896) | --DOCSHELL 0xe55e5000 == 0 [pid = 2896] [id = {0fa87002-d387-48fb-a510-a4b65f9a5825}]
[task 2018-09-21T21:36:44.162Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 3 (0xe4451400) [pid = 2896] [serial = 9] [outer = (nil)] [url = chrome://extensions/content/dummy.xul]
[task 2018-09-21T21:36:44.163Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 2 (0xe2bb8c00) [pid = 2896] [serial = 153] [outer = (nil)] [url = about:tabcrashed?e=tabcrashed&u=http%3A//mochi.test%3A8888/tests%3Fautorun%3D1%26closeWhenDone%3D1%26consoleLevel%3DINFO%26manifestFile%3Dtests.json%26dumpOutputDirectory%3D%252Ftmp%26cleanupCrashes%3Dtrue&c=UTF-8&f=regular&d=MochiTest%20%7C%20/tests]
[task 2018-09-21T21:36:44.164Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 1 (0xe7242000) [pid = 2896] [serial = 4] [outer = (nil)] [url = about:blank]
[task 2018-09-21T21:36:44.164Z] 21:36:44     INFO - GECKO(2896) | --DOMWINDOW == 0 (0xe724e400) [pid = 2896] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html]
[task 2018-09-21T21:36:44.164Z] 21:36:44     INFO - GECKO(2896) | nsStringStats
[task 2018-09-21T21:36:44.164Z] 21:36:44     INFO - GECKO(2896) |  => mAllocCount:         324346
[task 2018-09-21T21:36:44.166Z] 21:36:44     INFO - GECKO(2896) |  => mReallocCount:            0
[task 2018-09-21T21:36:44.166Z] 21:36:44     INFO - GECKO(2896) |  => mFreeCount:          324346
[task 2018-09-21T21:36:44.167Z] 21:36:44     INFO - GECKO(2896) |  => mShareCount:         249112
[task 2018-09-21T21:36:44.168Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptCount:           8827
[task 2018-09-21T21:36:44.168Z] 21:36:44     INFO - GECKO(2896) |  => mAdoptFreeCount:       9405
[task 2018-09-21T21:36:44.169Z] 21:36:44     INFO - GECKO(2896) |  => Process ID: 2896, Thread ID: 4147074816
[task 2018-09-21T21:36:44.170Z] 21:36:44     INFO - TEST-INFO | Main app process: exit 0

Comment 1

[Intermittent Failures Robot]

1 failures in 2902 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-09-17&endday=2018-09-23&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 2759 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-10-15&endday=2018-10-21&tree=all

Comment 3

[Intermittent Failures Robot]

9 failures in 2584 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 4
* mozilla-beta: 2
* mozilla-inbound: 1
* mozilla-central: 2

Platform breakdown:
* linux64-qr: 1
* linux64-ccov: 2
* linux64: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-10-22&endday=2018-10-28&tree=all

Comment 4

[Intermittent Failures Robot]

5 failures in 2978 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 4
* autoland: 1

Platform breakdown:
* linux64: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-10-29&endday=2018-11-04&tree=all

Comment 5

[Intermittent Failures Robot]

2 failures in 3007 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* autoland: 1

Platform breakdown:
* linux64: 1
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-11-05&endday=2018-11-11&tree=all

Comment 6

[Intermittent Failures Robot]

5 failures in 2917 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 2
* autoland: 2
* mozilla-central: 1

Platform breakdown:
* linux64: 1
* linux64-ccov: 1
* linux64-qr: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-11-12&endday=2018-11-18&tree=all

Comment 7

[Intermittent Failures Robot]

5 failures in 2917 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* autoland: 2
* mozilla-inbound: 2

Platform breakdown:
* linux64-qr: 3
* linux64: 1
* linux64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-11-12&endday=2018-11-18&tree=all

Comment 8

[Intermittent Failures Robot]

3 failures in 2387 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 1
* autoland: 1
* mozilla-central: 1

Platform breakdown:
* linux64-qr: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-11-19&endday=2018-11-25&tree=all

Comment 9

[Intermittent Failures Robot]

2 failures in 2808 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1
* mozilla-central: 1

Platform breakdown:
* linux32: 1
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-11-26&endday=2018-12-02&tree=all

Comment 10

[Intermittent Failures Robot]

1 failures in 2485 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* linux64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-12-10&endday=2018-12-16&tree=all

Comment 11

[Intermittent Failures Robot]

5 failures in 2648 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 4
* autoland: 1

Platform breakdown:
* linux64: 3
* linux64-qr: 1
* linux64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-12-17&endday=2018-12-23&tree=all

Comment 12

[Intermittent Failures Robot]

1 failures in 1008 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-12-24&endday=2018-12-30&tree=all

Comment 13

[Intermittent Failures Robot]

8 failures in 1668 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-inbound: 3
* autoland: 3
* mozilla-central: 2

Platform breakdown:
* linux32: 4
* linux64: 1
* linux64-qr: 2
* linux64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2018-12-31&endday=2019-01-06&tree=all

Comment 14

[Intermittent Failures Robot]

1 failures in 2627 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2019-01-07&endday=2019-01-13&tree=all

Comment 15

[Intermittent Failures Robot]

1 failures in 2628 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-inbound: 1

Platform breakdown:

• linux64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1493312&startday=2019-01-28&endday=2019-02-03&tree=all

Comment 16

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup