Closed
Bug 1744612
Opened 3 years ago
Closed 3 years ago
Intermittent Main app process exited normally | application crashed [@ mozilla::NrSocketBase::fire_callback(int)]
Categories
(Core :: WebRTC: Audio/Video, defect)
Core
WebRTC: Audio/Video
Tracking
()
RESOLVED
DUPLICATE
of bug 1743540
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: crash, intermittent-failure)
Crash Data
Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=360284098&repo=mozilla-beta
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/cV64JRSsQjy7WurCo7tejQ/runs/0/artifacts/public/logs/live_backing.log
[task 2021-12-06T20:59:26.208Z] 20:59:26 INFO - TEST-START | dom/media/webrtc/tests/mochitests/test_peerConnection_stats_relayProtocol.html
[task 2021-12-06T20:59:26.256Z] 20:59:26 INFO - GECKO(10732) | Timecard created 1638824353.342000
[task 2021-12-06T20:59:26.269Z] 20:59:26 INFO - GECKO(10732) | Timestamp | Delta | Event | File | Function
[task 2021-12-06T20:59:26.289Z] 20:59:26 INFO - GECKO(10732) | ======================================================================================================================
[task 2021-12-06T20:59:26.347Z] 20:59:26 INFO - GECKO(10732) | 0.000000 | 0.000000 | Constructor Completed | PeerConnectionImpl.cpp:333 | PeerConnectionImpl
[task 2021-12-06T20:59:26.418Z] 20:59:26 INFO - GECKO(10732) | 0.001000 | 0.001000 | Initializing PC Ctx | PeerConnectionImpl.cpp:452 | Initialize
[task 2021-12-06T20:59:26.483Z] 20:59:26 INFO - GECKO(10732) | 0.522000 | 0.521000 | Set Remote Description | PeerConnectionImpl.cpp:1384 | SetRemoteDescription
[task 2021-12-06T20:59:26.547Z] 20:59:26 INFO - GECKO(10732) | 0.902000 | 0.380000 | Create Answer | PeerConnectionImpl.cpp:1246 | CreateAnswer
[task 2021-12-06T20:59:26.608Z] 20:59:26 INFO - GECKO(10732) | 0.919000 | 0.017000 | Set Local Description | PeerConnectionImpl.cpp:1284 | SetLocalDescription
[task 2021-12-06T20:59:26.675Z] 20:59:26 INFO - GECKO(10732) | 1.067000 | 0.148000 | Add Ice Candidate | PeerConnectionImpl.cpp:1532 | AddIceCandidate
[task 2021-12-06T20:59:26.737Z] 20:59:26 INFO - GECKO(10732) | 1.071000 | 0.004000 | Add Ice Candidate | PeerConnectionImpl.cpp:1532 | AddIceCandidate
[task 2021-12-06T20:59:26.797Z] 20:59:26 INFO - GECKO(10732) | 1.072000 | 0.001000 | Set Remote Description | PeerConnectionImpl.cpp:1384 | SetRemoteDescription
[task 2021-12-06T20:59:26.856Z] 20:59:26 INFO - GECKO(10732) | 1.094000 | 0.022000 | Create Answer | PeerConnectionImpl.cpp:1246 | CreateAnswer
[task 2021-12-06T20:59:26.908Z] 20:59:26 INFO - GECKO(10732) | 1.096000 | 0.002000 | Set Local Description | PeerConnectionImpl.cpp:1284 | SetLocalDescription
[task 2021-12-06T20:59:26.961Z] 20:59:26 INFO - GECKO(10732) | 1.154000 | 0.058000 | Ice gathering state: gathering | PeerConnectionImpl.cpp:2537 | IceGatheringStateChange
[task 2021-12-06T20:59:27.007Z] 20:59:27 INFO - GECKO(10732) | 1.545000 | 0.391000 | Add Ice Candidate | PeerConnectionImpl.cpp:1532 | AddIceCandidate
[task 2021-12-06T20:59:27.053Z] 20:59:27 INFO - GECKO(10732) | 1.640000 | 0.095000 | Add Ice Candidate | PeerConnectionImpl.cpp:1532 | AddIceCandidate
[task 2021-12-06T20:59:27.100Z] 20:59:27 INFO - GECKO(10732) | 1.709000 | 0.069000 | Add Ice Candidate | PeerConnectionImpl.cpp:1532 | AddIceCandidate
[task 2021-12-06T20:59:27.136Z] 20:59:27 INFO - GECKO(10732) | 2.066000 | 0.357000 | Ice state: checking | PeerConnectionImpl.cpp:2481 | IceConnectionStateChange
[task 2021-12-06T20:59:27.171Z] 20:59:27 INFO - GECKO(10732) | 4.287000 | 2.221000 | Ice gathering state: complete | PeerConnectionImpl.cpp:2540 | IceGatheringStateChange
[task 2021-12-06T20:59:27.205Z] 20:59:27 INFO - GECKO(10732) | 10.385000 | 6.098000 | Ice state: connected | PeerConnectionImpl.cpp:2484 | IceConnectionStateChange
[task 2021-12-06T20:59:27.234Z] 20:59:27 INFO - GECKO(10732) | 12.901000 | 2.516000 | Destructor Invoked | PeerConnectionImpl.cpp:342 | ~PeerConnectionImpl
[task 2021-12-06T20:59:27.280Z] 20:59:27 INFO - GECKO(10732) | [Child 10836: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:368: ~PeerConnectionImpl: PeerConnectionImpl destructor invoked for {4dae4320-257e-459f-943e-2f81828cdc60}
[task 2021-12-06T20:59:27.286Z] 20:59:27 INFO - GECKO(10732) | Timecard created 1638824353.341000
[task 2021-12-06T21:00:27.941Z] 21:00:27 INFO - GECKO(10732) | (turn/WARNING) TURN(relay(IP4:10.7.204.55:0/TLS|IP4:0.0.0.0:5349/TLS)) failed
[task 2021-12-06T21:00:27.943Z] 21:00:27 INFO - GECKO(10732) | (turn/INFO) TURN(relay(IP4:10.7.204.55:0/TLS|IP4:0.0.0.0:5349/TLS)): cancelling
[task 2021-12-06T21:00:27.945Z] 21:00:27 INFO - GECKO(10732) | (generic/ERR) NrTcpSocket::OnClose 0000021D4AC5D000 reason=2152398868 name=NS_ERROR_NET_RESET
[task 2021-12-06T21:00:27.946Z] 21:00:27 ERROR - GECKO(10732) | A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2021-12-06T21:00:27.948Z] 21:00:27 INFO - GECKO(10732) | 1638824427778 Marionette TRACE Received observer notification quit-application
[task 2021-12-06T21:00:27.949Z] 21:00:27 INFO - GECKO(10732) | 1638824427779 Marionette INFO Stopped listening on port 2828
[task 2021-12-06T21:00:27.951Z] 21:00:27 INFO - GECKO(10732) | 1638824427779 Marionette DEBUG Marionette stopped listening
[task 2021-12-06T21:00:27.953Z] 21:00:27 INFO - GECKO(10732) | [Parent 9240, IPC I/O Parent] WARNING: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_win.cc:167
[task 2021-12-06T21:00:28.160Z] 21:00:28 INFO - TEST-INFO | Main app process: exit 0
[task 2021-12-06T21:00:28.161Z] 21:00:28 INFO - runtests.py | Application ran for: 0:09:44.060788
[task 2021-12-06T21:00:28.163Z] 21:00:28 INFO - zombiecheck | Reading PID log: C:\Users\testdroid.YOGA-035.000\AppData\Local\Temp\tmpu90zynkmpidlog
[task 2021-12-06T21:00:28.166Z] 21:00:28 INFO - ==> process 9240 launched child process 9876 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.0.2071819291\158430836" -parentBuildID 20211206172851 -prefsHandle 2116 -prefMapHandle 2092 -prefsLen 1 -prefMapSize 255211 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 2172 2cbf1d49648 gpu)
[task 2021-12-06T21:00:28.169Z] 21:00:28 INFO - ==> process 9240 launched child process 5432 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.1.1579028501\2044221393" -childID 1 -isForBrowser -prefsHandle 2876 -prefMapHandle 2872 -prefsLen 1785 -prefMapSize 255211 -jsInitHandle 1400 -jsInitLen 279340 -parentBuildID 20211206172851 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 2860 2cbf562a348 tab)
[task 2021-12-06T21:00:28.172Z] 21:00:28 INFO - ==> process 9240 launched child process 10836 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.3.1578781599\1254114372" -childID 2 -isForBrowser -prefsHandle 3192 -prefMapHandle 3188 -prefsLen 1965 -prefMapSize 255211 -jsInitHandle 1400 -jsInitLen 279340 -parentBuildID 20211206172851 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 3204 2cbf6b40548 tab)
[task 2021-12-06T21:00:28.176Z] 21:00:28 INFO - ==> process 9240 launched child process 1080 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.5.373681351\1990056225" -childID 3 -isForBrowser -prefsHandle 3300 -prefMapHandle 3304 -prefsLen 2005 -prefMapSize 255211 -jsInitHandle 1400 -jsInitLen 279340 -parentBuildID 20211206172851 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 3284 2cbe3e67748 tab)
[task 2021-12-06T21:00:28.179Z] 21:00:28 INFO - ==> process 9240 launched child process 4640 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.7.209616946\287244139" -childID 4 -isForBrowser -prefsHandle 3396 -prefMapHandle 3728 -prefsLen 10308 -prefMapSize 255211 -jsInitHandle 1400 -jsInitLen 279340 -parentBuildID 20211206172851 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 592 2cbf83b4748 tab)
[task 2021-12-06T21:00:28.182Z] 21:00:28 INFO - ==> process 9240 launched child process 8148 ("C:\tasks\task_1638821988\build\application\firefox\firefox.exe" -contentproc --channel="9240.9.286433421\1036820781" -childID 5 -isForBrowser -prefsHandle 4448 -prefMapHandle 3712 -prefsLen 10638 -prefMapSize 255211 -jsInitHandle 1400 -jsInitLen 279340 -parentBuildID 20211206172851 -appDir "C:\tasks\task_1638821988\build\application\firefox\browser" - 9240 "\\.\pipe\gecko-crash-server-pipe.9240" 4460 2cbfa918d48 tab)
[task 2021-12-06T21:00:28.183Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 4640
[task 2021-12-06T21:00:28.185Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 9876
[task 2021-12-06T21:00:28.186Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 10836
[task 2021-12-06T21:00:28.188Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 8148
[task 2021-12-06T21:00:28.189Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 5432
[task 2021-12-06T21:00:28.190Z] 21:00:28 INFO - zombiecheck | Checking for orphan process with PID: 1080
[task 2021-12-06T21:00:28.192Z] 21:00:28 INFO - mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TayhVJfUS9S3hHZich9jtg/artifacts/public/build/target.crashreporter-symbols.zip
[task 2021-12-06T21:00:31.220Z] 21:00:31 INFO - mozcrash Copy/paste: C:/tasks/task_1638821988/fetches\minidump_stackwalk\minidump_stackwalk.exe --human C:\Users\testdroid.YOGA-035.000\AppData\Local\Temp\tmpl24mkpo0.mozrunner\minidumps\7369768d-8636-461e-abe6-6567ef904f0b.dmp C:\Users\testdroid.YOGA-035.000\AppData\Local\Temp\tmpx9ai0no4 --symbols-url=https://symbols.mozilla.org/
[task 2021-12-06T21:00:34.693Z] 21:00:34 INFO - mozcrash Saved minidump as C:\tasks\task_1638821988\build\blobber_upload_dir\7369768d-8636-461e-abe6-6567ef904f0b.dmp
[task 2021-12-06T21:00:34.695Z] 21:00:34 INFO - mozcrash Saved app info as C:\tasks\task_1638821988\build\blobber_upload_dir\7369768d-8636-461e-abe6-6567ef904f0b.extra
[task 2021-12-06T21:00:35.306Z] 21:00:35 INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::NrSocketBase::fire_callback(int)]
[task 2021-12-06T21:00:35.306Z] 21:00:35 INFO - Crash dump filename: C:\Users\testdroid.YOGA-035.000\AppData\Local\Temp\tmpl24mkpo0.mozrunner\minidumps\7369768d-8636-461e-abe6-6567ef904f0b.dmp
[task 2021-12-06T21:00:35.306Z] 21:00:35 INFO - Operating system: Windows NT
[task 2021-12-06T21:00:35.306Z] 21:00:35 INFO - 10.0.17134
[task 2021-12-06T21:00:35.306Z] 21:00:35 INFO - CPU: arm64
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO - 8 CPUs
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO -
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO - Crash reason: EXCEPTION_ACCESS_VIOLATION_READ
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO - Crash address: 0xe5e5e5e5e5e5e5e5
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO - Process uptime: 582 seconds
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO -
[task 2021-12-06T21:00:35.307Z] 21:00:35 INFO - Thread 3 Socket Thread (crashed)
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - 0 xul.dll!mozilla::NrSocketBase::fire_callback(int) [nr_socket_prsock.cpp:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 332 + 0x0]
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - x0 = 0xe5e5e5e5e5e5e5e5 x1 = 0x0000000000000000
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - x2 = 0x000000c48a63ebe8 x3 = 0x000000c48a63ee48
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - x4 = 0x0000000000000000 x5 = 0x000000c48a63eba8
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - x6 = 0x0000021d41000000 x7 = 0x0000000000000000
[task 2021-12-06T21:00:35.308Z] 21:00:35 INFO - x8 = 0x0000000000000000 x9 = 0x0000000000000006
[task 2021-12-06T21:00:35.309Z] 21:00:35 INFO - x10 = 0x0000000000000007 x11 = 0x0000000000000198
[task 2021-12-06T21:00:35.309Z] 21:00:35 INFO - x12 = 0x0000000000000000 x13 = 0x0000000000000000
[task 2021-12-06T21:00:35.309Z] 21:00:35 INFO - x14 = 0x00000000ffffffde x15 = 0x0000000000000114
[task 2021-12-06T21:00:35.309Z] 21:00:35 INFO - x16 = 0x00000275a4869bb0 x17 = 0x000000c48a632000
[task 2021-12-06T21:00:35.309Z] 21:00:35 INFO - x18 = 0x0000000000000000 x19 = 0x0000021d4ac5d000
[task 2021-12-06T21:00:35.310Z] 21:00:35 INFO - x20 = 0x0000000000000000 x21 = 0x0000000000000001
[task 2021-12-06T21:00:35.310Z] 21:00:35 INFO - x22 = 0x0000021d47f61fa0 x23 = 0x0000021d4116c708
[task 2021-12-06T21:00:35.310Z] 21:00:35 INFO - x24 = 0x0000000000000000 x25 = 0x0000000000000000
[task 2021-12-06T21:00:35.310Z] 21:00:35 INFO - x26 = 0x0000000000000000 x27 = 0x0000000000000000
[task 2021-12-06T21:00:35.310Z] 21:00:35 INFO - x28 = 0x00007ffcba360840 x29 = 0x000000c48a63ee80
task 2021-12-06T21:00:35.317Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.317Z] 21:00:35 INFO - 9 xul.dll!MessageLoop::RunHandler() [message_loop.cc:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 324 + 0xc]
[task 2021-12-06T21:00:35.317Z] 21:00:35 INFO - x29 = 0x000000c48a63fb10 x30 = 0x00007ffc92ee6cb8
[task 2021-12-06T21:00:35.317Z] 21:00:35 INFO - pc = 0x00007ffc92ee6d24 sp = 0x000000c48a63fac8
[task 2021-12-06T21:00:35.317Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.318Z] 21:00:35 INFO - 10 xul.dll!MessageLoop::Run() [message_loop.cc:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 306 + 0x0]
[task 2021-12-06T21:00:35.318Z] 21:00:35 INFO - x29 = 0x000000c48a63fcc8 x30 = 0x00007ffc92ee6800
[task 2021-12-06T21:00:35.318Z] 21:00:35 INFO - pc = 0x00007ffc92ee6cb8 sp = 0x000000c48a63fb20
[task 2021-12-06T21:00:35.318Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.318Z] 21:00:35 INFO - 11 xul.dll!static nsThread::ThreadFunc(void*) [nsThread.cpp:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 391 + 0x4]
[task 2021-12-06T21:00:35.319Z] 21:00:35 INFO - x29 = 0x000000c48a63fd40 x30 = 0x00007ffcba260910
[task 2021-12-06T21:00:35.319Z] 21:00:35 INFO - pc = 0x00007ffc92ee6800 sp = 0x000000c48a63fcd8
[task 2021-12-06T21:00:35.319Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.319Z] 21:00:35 INFO - 12 nss3.dll!_PR_NativeRunThread(void*) [pruthr.c:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 399 + 0x4]
[task 2021-12-06T21:00:35.319Z] 21:00:35 INFO - x29 = 0x000000c48a63fd50 x30 = 0x00007ffcba28b9a0
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - pc = 0x00007ffcba260910 sp = 0x000000c48a63fd50
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - 13 nss3.dll!pr_root(void*) [w95thred.c:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 139 + 0x4]
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - x29 = 0x000000c48a63fd60 x30 = 0x00007ffcc39e2ee0
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - pc = 0x00007ffcba28b9a0 sp = 0x000000c48a63fd60
[task 2021-12-06T21:00:35.320Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.321Z] 21:00:35 INFO - 14 ucrtbase.dll + 0x32edc
[task 2021-12-06T21:00:35.321Z] 21:00:35 INFO - x29 = 0x000000c48a63fd90 x30 = 0x00007ffcc4b45ba4
[task 2021-12-06T21:00:35.321Z] 21:00:35 INFO - pc = 0x00007ffcc39e2ee0 sp = 0x000000c48a63fd70
[task 2021-12-06T21:00:35.321Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.321Z] 21:00:35 INFO - 15 kernel32.dll + 0x15ba0
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - x29 = 0x000000c48a63fe18 x30 = 0x00007ffcb4934a20
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - pc = 0x00007ffcc4b45ba4 sp = 0x000000c48a63fda0
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - 16 mozglue.dll!patched_BaseThreadInitThunk(int, void*, void*) [WindowsDllBlocklist.cpp:8ac03729dc7e7ae0d0be37bf7707ae3720b85bea : 574 + 0x14]
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - x29 = 0x000000c48a63fe30 x30 = 0x00007ffcc67e2544
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - pc = 0x00007ffcb4934a20 sp = 0x000000c48a63fe28
[task 2021-12-06T21:00:35.322Z] 21:00:35 INFO - Found by: previous frame's frame pointer
[task 2021-12-06T21:00:35.323Z] 21:00:35 INFO - 17 ntdll.dll + 0x92540
[task 2021-12-06T21:00:35.323Z] 21:00:35 INFO - x29 = 0x0000000000000000 x30 = 0x0000000000000000
[task 2021-12-06T21:00:35.323Z] 21:00:35 INFO - pc = 0x00007ffcc67e2544 sp = 0x000000c48a63fe40
[task 2021-12-06T21:00:35.323Z] 21:00:35 INFO - Found by: previous frame's frame pointer
|
||
Updated•3 years ago
|
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → DUPLICATE
|
||
Updated•7 months ago
|
Group: core-security
You need to log in
before you can comment on or make changes to this bug.
Description
•