Closed Bug 1511542 Opened 9 months ago Closed 5 months ago

Intermittent GECKO(1060) | Assertion failure: NS_IsMainThread(), at /builds/worker/workspace/build/src/media/webrtc/signaling/src/media-conduit/VideoConduit.cpp:451

Categories

(Core :: WebRTC: Signaling, defect, P5)

defect

Tracking

()

RESOLVED FIXED
mozilla68
Tracking Status
firefox-esr60 --- unaffected
firefox66 --- wontfix
firefox67 --- wontfix
firefox68 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: bwc)

Details

(Keywords: assertion, intermittent-failure)

Attachments

(1 file)

Filed by: ccoroiu [at] mozilla.com

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

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

task 2018-12-01T00:11:00.685Z] 00:11:00     INFO - GECKO(1060) | Assertion failure: NS_IsMainThread(), at /builds/worker/workspace/build/src/media/webrtc/signaling/src/media-conduit/VideoConduit.cpp:451
[task 2018-12-01T00:11:00.687Z] 00:11:00     INFO - GECKO(1060) | #01: libxul.so + 0x10d6f4e
[task 2018-12-01T00:11:00.688Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.689Z] 00:11:00     INFO - GECKO(1060) | #02: libxul.so + 0x10d7115
[task 2018-12-01T00:11:00.690Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.695Z] 00:11:00     INFO - GECKO(1060) | #03: libxul.so + 0x10e5bd5
[task 2018-12-01T00:11:00.696Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.696Z] 00:11:00     INFO - GECKO(1060) | #04: libxul.so + 0x10e9813
[task 2018-12-01T00:11:00.697Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.699Z] 00:11:00     INFO - GECKO(1060) | #05: libxul.so + 0x6c10f4
[task 2018-12-01T00:11:00.699Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.702Z] 00:11:00     INFO - GECKO(1060) | #06: libxul.so + 0x5fff1f
[task 2018-12-01T00:11:00.704Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.706Z] 00:11:00     INFO - GECKO(1060) | #07: libxul.so + 0x6bb756
[task 2018-12-01T00:11:00.708Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.709Z] 00:11:00     INFO - GECKO(1060) | #08: libxul.so + 0x6bdf2e
[task 2018-12-01T00:11:00.710Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.712Z] 00:11:00     INFO - GECKO(1060) | #09: libxul.so + 0x7ce3ba
[task 2018-12-01T00:11:00.716Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.717Z] 00:11:00     INFO - GECKO(1060) | #10: libxul.so + 0x7cef03
[task 2018-12-01T00:11:00.721Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.723Z] 00:11:00     INFO - GECKO(1060) | #11: libxul.so + 0x6bb3e4
[task 2018-12-01T00:11:00.724Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.726Z] 00:11:00     INFO - GECKO(1060) | #12: libxul.so + 0x6bdf2e
[task 2018-12-01T00:11:00.727Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.728Z] 00:11:00     INFO - GECKO(1060) | #13: libxul.so + 0xc01f3d
[task 2018-12-01T00:11:00.730Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.733Z] 00:11:00     INFO - GECKO(1060) | #14: libxul.so + 0xbc03cd
[task 2018-12-01T00:11:00.735Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.738Z] 00:11:00     INFO - GECKO(1060) | #15: libxul.so + 0xbc032a
[task 2018-12-01T00:11:00.739Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.740Z] 00:11:00     INFO - GECKO(1060) | #16: libxul.so + 0x6b8d15
[task 2018-12-01T00:11:00.740Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.863Z] 00:11:00     INFO - GECKO(1060) | #17: _pt_root [nsprpub/pr/src/pthreads/ptthread.c:204]
[task 2018-12-01T00:11:00.864Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:00.870Z] 00:11:00     INFO - GECKO(1060) | #18: libpthread.so.0 + 0x6295
[task 2018-12-01T00:11:00.871Z] 00:11:00     INFO - 
[task 2018-12-01T00:11:01.001Z] 00:11:01     INFO - GECKO(1060) | [Parent 1060, Gecko_IOThread] WARNING: pipe error (76): Connection reset by peer: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 349
[task 2018-12-01T00:11:01.003Z] 00:11:01     INFO - GECKO(1060) | ###!!! [Parent][MessageChannel] Error: (msgtype=0x1E0083,name=PBrowser::Msg_Destroy) Channel error: cannot send/recv
[task 2018-12-01T00:11:01.025Z] 00:11:01     INFO - GECKO(1060) | ++DOCSHELL 0xdd891400 == 8 [pid = 1060] [id = {820e8d24-7dd1-4ac6-a402-cab1b1f4eb42}]
[task 2018-12-01T00:11:01.028Z] 00:11:01     INFO - GECKO(1060) | ++DOMWINDOW == 17 (0xde006840) [pid = 1060] [serial = 68] [outer = (nil)]
[task 2018-12-01T00:11:01.105Z] 00:11:01     INFO - GECKO(1060) | ++DOMWINDOW == 18 (0xdfd5e400) [pid = 1060] [serial = 69] [outer = 0xde006840]
[task 2018-12-01T00:11:01.107Z] 00:11:01     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/dom/base/nsContentUtils.cpp, line 8165
[task 2018-12-01T00:11:01.164Z] 00:11:01     INFO - GECKO(1060) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2018-12-01T00:11:01.384Z] 00:11:01     INFO - GECKO(1060) | ++DOMWINDOW == 19 (0xdd88c000) [pid = 1060] [serial = 70] [outer = 0xde006840]
[task 2018-12-01T00:11:01.388Z] 00:11:01     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/dom/base/nsContentUtils.cpp, line 8165
[task 2018-12-01T00:11:01.599Z] 00:11:01     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: '!mSelection', file /builds/worker/workspace/build/src/editor/libeditor/EditorBase.cpp, line 4813
[task 2018-12-01T00:11:01.601Z] 00:11:01     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: '!editActionData.CanHandle()', file /builds/worker/workspace/build/src/editor/libeditor/EditorBase.cpp, line 1250
[task 2018-12-01T00:11:01.670Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 870
[task 2018-12-01T00:11:01.956Z] 00:11:01     INFO - GECKO(1060) | --DOMWINDOW == 5 (0xf716bfc0) [pid = 1134] [serial = 4] [outer = (nil)] [url = moz-extension://591c3897-988a-4d11-8d8e-d9dac23bd4ec/_generated_background_page.html]
[task 2018-12-01T00:11:01.958Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.959Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.960Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.961Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.966Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.969Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.969Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.970Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.971Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.973Z] 00:11:01     INFO - GECKO(1060) | --DOMWINDOW == 4 (0xf716be80) [pid = 1134] [serial = 3] [outer = (nil)] [url = moz-extension://9e608b1b-e0bd-4858-8403-5af5fa8b5d45/_generated_background_page.html]
[task 2018-12-01T00:11:01.975Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.976Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.978Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.981Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.982Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.986Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.987Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.989Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.990Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.991Z] 00:11:01     INFO - GECKO(1060) | --DOMWINDOW == 3 (0xf716a940) [pid = 1134] [serial = 1] [outer = (nil)] [url = moz-extension://d6a7bde7-cc2b-4e90-a4db-6cd51dead086/_generated_background_page.html]
[task 2018-12-01T00:11:01.993Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.996Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.997Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.998Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:01.999Z] 00:11:01     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:02.000Z] 00:11:02     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:02.002Z] 00:11:02     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:02.003Z] 00:11:02     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:02.006Z] 00:11:02     INFO - GECKO(1060) | [Child 1134, Main Thread] WARNING: '!mMainThread', file /builds/worker/workspace/build/src/xpcom/threads/nsThreadManager.cpp, line 457
[task 2018-12-01T00:11:02.007Z] 00:11:02     INFO - GECKO(1060) | --DOCSHELL 0xe794e000 == 2 [pid = 1134] [id = {caeb1f53-a0f7-4d43-bf5e-189c82644035}]
[task 2018-12-01T00:11:02.008Z] 00:11:02     INFO - GECKO(1060) | --DOCSHELL 0xf7197400 == 1 [pid = 1134] [id = {41c0c8c1-f3ff-4e53-8764-462ae2a1fee6}]
[task 2018-12-01T00:11:02.009Z] 00:11:02     INFO - GECKO(1060) | --DOCSHELL 0xe799cc00 == 0 [pid = 1134] [id = {7e1dbfc4-1a95-458d-adb5-aeb41fd201d9}]
[task 2018-12-01T00:11:02.013Z] 00:11:02     INFO - GECKO(1060) | --DOMWINDOW == 2 (0xe79a2c00) [pid = 1134] [serial = 9] [outer = (nil)] [url = moz-extension://d6a7bde7-cc2b-4e90-a4db-6cd51dead086/_generated_background_page.html]
[task 2018-12-01T00:11:02.014Z] 00:11:02     INFO - GECKO(1060) | --DOMWINDOW == 1 (0xe79a3800) [pid = 1134] [serial = 10] [outer = (nil)] [url = moz-extension://9e608b1b-e0bd-4858-8403-5af5fa8b5d45/_generated_background_page.html]
[task 2018-12-01T00:11:02.015Z] 00:11:02     INFO - GECKO(1060) | --DOMWINDOW == 0 (0xe79a4400) [pid = 1134] [serial = 11] [outer = (nil)] [url = moz-extension://591c3897-988a-4d11-8d8e-d9dac23bd4ec/_generated_background_page.html]
[task 2018-12-01T00:11:02.036Z] 00:11:02     INFO - GECKO(1060) | nsStringStats
[task 2018-12-01T00:11:02.037Z] 00:11:02     INFO - GECKO(1060) |  => mAllocCount:          16084
[task 2018-12-01T00:11:02.038Z] 00:11:02     INFO - GECKO(1060) |  => mReallocCount:            0
[task 2018-12-01T00:11:02.039Z] 00:11:02     INFO - GECKO(1060) |  => mFreeCount:           16084
[task 2018-12-01T00:11:02.040Z] 00:11:02     INFO - GECKO(1060) |  => mShareCount:           8686
[task 2018-12-01T00:11:02.041Z] 00:11:02     INFO - GECKO(1060) |  => mAdoptCount:            490
[task 2018-12-01T00:11:02.042Z] 00:11:02     INFO - GECKO(1060) |  => mAdoptFreeCount:        514
[task 2018-12-01T00:11:02.042Z] 00:11:02     INFO - GECKO(1060) |  => Process ID: 1134, Thread ID: 4147410688
[task 2018-12-01T00:11:02.322Z] 00:11:02     INFO - GECKO(1060) | [Child 1199, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 870
[task 2018-12-01T00:11:02.475Z] 00:11:02     INFO - GECKO(1060) | nsStringStats
[task 2018-12-01T00:11:02.476Z] 00:11:02     INFO - GECKO(1060) |  => mAllocCount:           8145
[task 2018-12-01T00:11:02.477Z] 00:11:02     INFO - GECKO(1060) |  => mReallocCount:            0
[task 2018-12-01T00:11:02.479Z] 00:11:02     INFO - GECKO(1060) |  => mFreeCount:            8145
[task 2018-12-01T00:11:02.480Z] 00:11:02     INFO - GECKO(1060) |  => mShareCount:           5621
[task 2018-12-01T00:11:02.481Z] 00:11:02     INFO - GECKO(1060) |  => mAdoptCount:             75
[task 2018-12-01T00:11:02.482Z] 00:11:02     INFO - GECKO(1060) |  => mAdoptFreeCount:         75
[task 2018-12-01T00:11:02.483Z] 00:11:02     INFO - GECKO(1060) |  => Process ID: 1199, Thread ID: 4147091200
[task 2018-12-01T00:11:02.898Z] 00:11:02     INFO - GECKO(1060) | 1543623062891	Marionette	TRACE	Received observer notification xpcom-will-shutdown
[task 2018-12-01T00:11:02.900Z] 00:11:02     INFO - GECKO(1060) | 1543623062891	Marionette	INFO	Stopped listening on port 2828
[task 2018-12-01T00:11:02.901Z] 00:11:02     INFO - GECKO(1060) | 1543623062892	Marionette	DEBUG	Remote service is inactive
[task 2018-12-01T00:11:02.917Z] 00:11:02     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/workspace/build/src/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1284
[task 2018-12-01T00:11:02.942Z] 00:11:02     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp, line 870
[task 2018-12-01T00:11:03.059Z] 00:11:03     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 299
[task 2018-12-01T00:11:03.060Z] 00:11:03     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: '!gThread', file /builds/worker/workspace/build/src/xpcom/threads/nsTimerImpl.cpp, line 299
[task 2018-12-01T00:11:03.813Z] 00:11:03     INFO - GECKO(1060) | [Parent 1060, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/DOMEventTargetHelper.h, line 136
[task 2018-12-01T00:11:00.492Z] 00:11:00     INFO - TEST-OK | dom/media/tests/mochitest/test_peerConnection_verifyDescriptions.html | took 2261ms
[task 2018-12-01T00:11:00.574Z] 00:11:00     INFO - GECKO(1060) | [Child 1153, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1198
[task 2018-12-01T00:11:00.576Z] 00:11:00     INFO - GECKO(1060) | [Child 1153, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x80004005: file /builds/worker/workspace/build/src/docshell/shistory/nsSHistory.cpp, line 1198
[task 2018-12-01T00:11:00.585Z] 00:11:00     INFO - GECKO(1060) | ++DOMWINDOW == 8 (0xe244d000) [pid = 1153] [serial = 111] [outer = 0xe74706c0]
[task 2018-12-01T00:11:00.614Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Unnamed thread 0xe3e6cd00]: I/signaling [|WebrtcVideoSessionConduit] VideoStreamFactory.cpp:195: CreateEncoderStreams Input frame 320x240, RID  scaling to 320x240
[task 2018-12-01T00:11:00.650Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2313: CloseInt: Closing PeerConnectionImpl c4f49dd5ae0ce1d5; ending call
[task 2018-12-01T00:11:00.652Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Main Thread]: I/jsep [1543623058548755 (id=4294967404 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyDescriptio]: stable -> closed
[task 2018-12-01T00:11:00.660Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:2313: CloseInt: Closing PeerConnectionImpl 6854a32d8508ed60; ending call
[task 2018-12-01T00:11:00.662Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Main Thread]: I/jsep [1543623058563263 (id=4294967404 url=http://mochi.test:8888/tests/dom/media/tests/mochitest/test_peerConnection_verifyDescriptio]: stable -> closed
[task 2018-12-01T00:11:00.683Z] 00:11:00     INFO - GECKO(1060) | [Child 1153: Socket Thread]: E/signaling [Socket Thread|WebrtcVideoSessionConduit] VideoConduit.cpp:1909: DeliverPacket DeliverPacket Failed, 1
Flags: needinfo?(dminor)
Symbols in the backtrace would definitely help here, but I'm guessing that what is happening is the last remaining reference to the VideoConduit is held by this lambda [1] which runs on the sts thread. This causes the delete to happen on the sts thread rather than main.

Byron has some patches in progress that will remove this dispatch that as far as I know are planned to land early in Nightly 66.

That leaves the question of whether or not this is worth fixing for Firefox 65. It looks like the lambda was added by Bug 1337777 and the failing assertion has been there since Bug 864654, so this problem has been present for a while.

In the VideoConduit destructor, we call UnregisterConduit which accesses mConduits without a lock which could lead to problems. After the branch 64 update, we now have a similar dispatch in AudioConduit which does more work: it destroys the send and receive streams and deletes the channels.

Please let me know if you think it is worthwhile putting a fix together for this problem prior to Byron's changes landing.

[1] https://searchfox.org/mozilla-central/rev/fd62b95c187a40b328d9e7fd9d848833a6942b57/media/webrtc/signaling/src/media-conduit/VideoConduit.cpp#1944
Flags: needinfo?(dminor)

I think this might have been spotted over in bug 1527044:

https://treeherder.mozilla.org/#/jobs?repo=try&revision=6094de3c5fb627c78dcfac70565ca09d085d8b4f&selectedJob=228168525

It looks like this is a case of "last ref going away on not-main".

[task 2019-02-13T14:47:04.895Z] 14:47:04 INFO - PID 1507 | Assertion failure: NS_IsMainThread(), at /builds/worker/workspace/build/src/media/webrtc/signaling/src/media-conduit/VideoConduit.cpp:461
[task 2019-02-13T14:47:06.100Z] 14:47:06 INFO - Browser not responding, setting status to CRASH
[task 2019-02-13T14:47:06.102Z] 14:47:06 INFO - mozcrash Copy/paste: /builds/worker/workspace/build/linux64-minidump_stackwalk /tmp/tmpUOLXvZ.mozrunner/minidumps/7d1d68a5-d2b5-782d-52ed-fd3084bb487c.dmp /builds/worker/workspace/build/symbols
[task 2019-02-13T14:47:20.990Z] 14:47:20 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/7d1d68a5-d2b5-782d-52ed-fd3084bb487c.dmp
[task 2019-02-13T14:47:21.012Z] 14:47:21 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/7d1d68a5-d2b5-782d-52ed-fd3084bb487c.extra
[task 2019-02-13T14:47:21.157Z] 14:47:21 INFO - PROCESS-CRASH | /webrtc/RTCPeerConnection-getStats.https.html | application crashed [@ mozilla::WebrtcVideoConduit::~WebrtcVideoConduit()]
[task 2019-02-13T14:47:21.158Z] 14:47:21 INFO - Crash dump filename: /tmp/tmpUOLXvZ.mozrunner/minidumps/7d1d68a5-d2b5-782d-52ed-fd3084bb487c.dmp
[task 2019-02-13T14:47:21.158Z] 14:47:21 INFO - Operating system: Linux
[task 2019-02-13T14:47:21.159Z] 14:47:21 INFO - 0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64
[task 2019-02-13T14:47:21.159Z] 14:47:21 INFO - CPU: x86
[task 2019-02-13T14:47:21.160Z] 14:47:21 INFO - GenuineIntel family 6 model 62 stepping 4
[task 2019-02-13T14:47:21.160Z] 14:47:21 INFO - 4 CPUs
[task 2019-02-13T14:47:21.161Z] 14:47:21 INFO -
[task 2019-02-13T14:47:21.161Z] 14:47:21 INFO - GPU: UNKNOWN
[task 2019-02-13T14:47:21.162Z] 14:47:21 INFO -
[task 2019-02-13T14:47:21.162Z] 14:47:21 INFO - Crash reason: SIGSEGV /SEGV_MAPERR
[task 2019-02-13T14:47:21.163Z] 14:47:21 INFO - Crash address: 0x0
[task 2019-02-13T14:47:21.163Z] 14:47:21 INFO - Process uptime: not available
[task 2019-02-13T14:47:21.164Z] 14:47:21 INFO -
[task 2019-02-13T14:47:21.164Z] 14:47:21 INFO - Thread 7 (crashed)
[task 2019-02-13T14:47:21.164Z] 14:47:21 INFO - 0 libxul.so!mozilla::WebrtcVideoConduit::~WebrtcVideoConduit() [VideoConduit.cpp:c849fb69e2e79399567550e19030876d695cb762 : 461 + 0x0]
[task 2019-02-13T14:47:21.165Z] 14:47:21 INFO - eip = 0xedb2a2e8 esp = 0xe85655f0 ebp = 0xe8565628 ebx = 0xf542e000
[task 2019-02-13T14:47:21.165Z] 14:47:21 INFO - esi = 0x000001cd edi = 0xe4be2000 eax = 0xf2847849 ecx = 0x5668a51c
[task 2019-02-13T14:47:21.166Z] 14:47:21 INFO - edx = 0x00000000 efl = 0x00010282
[task 2019-02-13T14:47:21.166Z] 14:47:21 INFO - Found by: given as instruction pointer in context
[task 2019-02-13T14:47:21.167Z] 14:47:21 INFO - 1 libxul.so!<name omitted> [VideoConduit.cpp:c849fb69e2e79399567550e19030876d695cb762 : 460 + 0x8]
[task 2019-02-13T14:47:21.167Z] 14:47:21 INFO - eip = 0xedb2a4a1 esp = 0xe8565630 ebp = 0xe8565648 ebx = 0xf542e000
[task 2019-02-13T14:47:21.168Z] 14:47:21 INFO - esi = 0xe4be2000 edi = 0xe4be2000
[task 2019-02-13T14:47:21.168Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.169Z] 14:47:21 INFO - 2 libxul.so!mozilla::MediaSessionConduit::Release() [MediaConduitInterface.h:c849fb69e2e79399567550e19030876d695cb762 : 259 + 0x9]
[task 2019-02-13T14:47:21.169Z] 14:47:21 INFO - eip = 0xedb38e69 esp = 0xe8565650 ebp = 0xe8565678 ebx = 0xf542e000
[task 2019-02-13T14:47:21.169Z] 14:47:21 INFO - esi = 0x00000000 edi = 0xe4be2000
[task 2019-02-13T14:47:21.170Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.170Z] 14:47:21 INFO - 3 libxul.so!mozilla::detail::RunnableFunction<mozilla::WebrtcVideoConduit::ReceivedRTPPacket(void const*, int, unsigned int)::$_9::operator()()::{lambda()#1}>::~RunnableFunction() [RefPtr.h:c849fb69e2e79399567550e19030876d695cb762 : 45 + 0x8]
[task 2019-02-13T14:47:21.171Z] 14:47:21 INFO - eip = 0xedb3cb31 esp = 0xe8565680 ebp = 0xe8565698 ebx = 0xf542e000
[task 2019-02-13T14:47:21.171Z] 14:47:21 INFO - esi = 0xe05ec8a0 edi = 0xe05ec8a0
[task 2019-02-13T14:47:21.171Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.172Z] 14:47:21 INFO - 4 libxul.so!mozilla::Runnable::Release() [nsThreadUtils.cpp:c849fb69e2e79399567550e19030876d695cb762 : 49 + 0x8]
[task 2019-02-13T14:47:21.172Z] 14:47:21 INFO - eip = 0xed0e692e esp = 0xe85656a0 ebp = 0xe85656b8 ebx = 0xf542e000
[task 2019-02-13T14:47:21.173Z] 14:47:21 INFO - esi = 0x00000000 edi = 0xe05ec8a0
[task 2019-02-13T14:47:21.173Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.173Z] 14:47:21 INFO - 5 libxul.so!nsCOMPtr<nsIRunnable>::~nsCOMPtr() [nsCOMPtr.h:c849fb69e2e79399567550e19030876d695cb762 : 441 + 0x8]
[task 2019-02-13T14:47:21.174Z] 14:47:21 INFO - eip = 0xed016fb9 esp = 0xe85656c0 ebp = 0xe85656d8 ebx = 0xf542e000
[task 2019-02-13T14:47:21.174Z] 14:47:21 INFO - esi = 0xe8565748 edi = 0xf715ae80
[task 2019-02-13T14:47:21.175Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.175Z] 14:47:21 INFO - 6 libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:c849fb69e2e79399567550e19030876d695cb762 : 1211 + 0x14]
[task 2019-02-13T14:47:21.176Z] 14:47:21 INFO - eip = 0xed0e12b4 esp = 0xe85656e0 ebp = 0xe8565bc8 ebx = 0xf542e000
[task 2019-02-13T14:47:21.176Z] 14:47:21 INFO - esi = 0xe8565750 edi = 0xf715ae80
[task 2019-02-13T14:47:21.176Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.177Z] 14:47:21 INFO - 7 libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:c849fb69e2e79399567550e19030876d695cb762 : 474 + 0x11]
[task 2019-02-13T14:47:21.177Z] 14:47:21 INFO - eip = 0xed0e364e esp = 0xe8565bd0 ebp = 0xe8565bf8 ebx = 0xf542e000
[task 2019-02-13T14:47:21.178Z] 14:47:21 INFO - esi = 0xe8565beb edi = 0xf715c740
[task 2019-02-13T14:47:21.178Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.178Z] 14:47:21 INFO - 8 libxul.so!mozilla::net::nsSocketTransportService::Run() [nsSocketTransportService2.cpp:c849fb69e2e79399567550e19030876d695cb762 : 1012 + 0x10]
[task 2019-02-13T14:47:21.179Z] 14:47:21 INFO - eip = 0xed1ee070 esp = 0xe8565c00 ebp = 0xe8565d08 ebx = 0xf542e000
[task 2019-02-13T14:47:21.179Z] 14:47:21 INFO - esi = 0x00000001 edi = 0xf715c740
[task 2019-02-13T14:47:21.180Z] 14:47:21 INFO - Found by: call frame info
[task 2019-02-13T14:47:21.180Z] 14:47:21 INFO - 9 libxul.so!non-virtual thunk to mozilla::net::nsSocketTransportService::Run() [nsSocketTransportService2.cpp:c849fb69e2e79399567550e19030876d695cb762 : 0 + 0x5]
[task 2019-02-13T14:47:21.181Z] 14:47:21 INFO - eip = 0xed1eebb7 esp = 0xe8565d10 ebp = 0xe8565d18 ebx = 0xf542e000
[task 2019-02-13T14:47:21.181Z] 14:47:21 INFO - esi = 0xe8565d90 edi = 0xf715ae80
[task 2019-02-13T14:47:21.181Z] 14:47:21 INFO - Found by: call frame info

It would be really nice if we could make WebrtcVideoConduit less fragile, and allow it to be destroyed on non-main, but there's probably a lot of work there. I'm going to try a workaround.

Assignee: nobody → docfaraday
Pushed by bcampen@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/f43307f2bad9
Send RefPtr<WebrtcVideoConduit> back to main to be released in STS dispatches. r=dminor
Status: NEW → RESOLVED
Closed: 5 months ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla68
You need to log in before you can comment on or make changes to this bug.