Intermittent TEST-UNEXPECTED-CRASH | /webrtc/RTCPeerConnection-setRemoteDescription-rollback.html | expected OK
Categories
(Core :: WebRTC, defect, P5)
Tracking
()
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
(Keywords: intermittent-failure, regression)
#[markdown(off)]
Filed by: rgurzau [at] mozilla.com
https://treeherder.mozilla.org/logviewer.html#?job_id=227394091&repo=autoland
[task 2019-02-09T12:08:06.118Z] 12:08:06 INFO - TEST-START | /webrtc/RTCPeerConnection-setRemoteDescription-rollback.html
[task 2019-02-09T12:08:06.118Z] 12:08:06 INFO - Clearing pref media.navigator.permission.disabled
[task 2019-02-09T12:08:06.126Z] 12:08:06 INFO - Clearing pref media.navigator.streams.fake
[task 2019-02-09T12:08:06.142Z] 12:08:06 INFO - Setting pref media.navigator.permission.disabled (true)
[task 2019-02-09T12:08:06.146Z] 12:08:06 INFO - Setting pref media.navigator.streams.fake (true)
[task 2019-02-09T12:08:06.155Z] 12:08:06 INFO - Closing window 105226698753
[task 2019-02-09T12:08:06.171Z] 12:08:06 INFO - PID 11825 | JavaScript error: , line 0: InvalidStateError: An attempt was made to use an object that is not, or is no longer, usable
[task 2019-02-09T12:14:06.456Z] 12:14:06 INFO - IOError on command, setting status to CRASH
[task 2019-02-09T12:14:06.456Z] 12:14:06 INFO - TEST-UNEXPECTED-CRASH | /webrtc/RTCPeerConnection-setRemoteDescription-rollback.html | expected OK
[task 2019-02-09T12:14:06.457Z] 12:14:06 INFO - TEST-INFO took 360342ms
[task 2019-02-09T12:15:17.502Z] 12:15:17 INFO - Browser exited with return code -15
[task 2019-02-09T12:15:17.503Z] 12:15:17 INFO - PROCESS LEAKS None
[task 2019-02-09T12:15:17.504Z] 12:15:17 INFO - Closing logging queue
[task 2019-02-09T12:15:17.505Z] 12:15:17 INFO - queue closed
[task 2019-02-09T12:15:17.522Z] 12:15:17 INFO - Setting up ssl
[task 2019-02-09T12:15:17.550Z] 12:15:17 INFO - certutil |
[task 2019-02-09T12:15:17.578Z] 12:15:17 INFO - certutil |
[task 2019-02-09T12:15:17.599Z] 12:15:17 INFO - certutil |
[task 2019-02-09T12:15:17.599Z] 12:15:17 INFO - Certificate Nickname Trust Attributes
[task 2019-02-09T12:15:17.600Z] 12:15:17 INFO - SSL,S/MIME,JAR/XPI
[task 2019-02-09T12:15:17.600Z] 12:15:17 INFO -
[task 2019-02-09T12:15:17.600Z] 12:15:17 INFO - web-platform-tests
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 4•5 years ago
|
||
I'm seeing an uptick of these crashes (two in a row) on this try run on Android with bug 1551316. I got this stack trace (exerpt):
[task 2019-07-13T15:08:39.498Z] 15:08:39 INFO - Crash reason: SIGSEGV /SEGV_MAPERR
[task 2019-07-13T15:08:39.498Z] 15:08:39 INFO - Crash address: 0x0
[task 2019-07-13T15:08:39.498Z] 15:08:39 INFO - Process uptime: not available
[task 2019-07-13T15:08:39.498Z] 15:08:39 INFO -
[task 2019-07-13T15:08:39.498Z] 15:08:39 INFO - Thread 11 (crashed)
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - 0 libmozglue.so!mozalloc_abort [mozalloc_abort.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 33 + 0x11]
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rax = 0x0000724d2c8bf8db rdx = 0x0000000000000001
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rcx = 0x0000724d2c94e4c8 rbx = 0x0000724d2d251560
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rsi = 0x0000724d2c8c1300 rdi = 0x0000724d2c20447a
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rbp = 0x0000724d2d251550 rsp = 0x0000724d2d251540
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r8 = 0x0000000000000000 r9 = 0x000000000000000a
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r10 = 0xfffffffffffff48a r11 = 0x0000000000000000
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r12 = 0x0000000000000000 r13 = 0x0000724d2d251a28
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r14 = 0x0000724d2d2515c8 r15 = 0x0000724d2a0c4517
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rip = 0x0000724d2c7fb3b6
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - Found by: given as instruction pointer in context
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - 1 libmozglue.so!abort [mozalloc_abort.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 79 + 0x8]
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rbx = 0x0000724d2d251560 rbp = 0x0000724d2d2515b0
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rsp = 0x0000724d2d251560 r12 = 0x0000000000000000
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d2515c8
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r15 = 0x0000724d2a0c4517 rip = 0x0000724d2c7fb3f9
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - 2 libxul.so!rtc::FatalMessage::~FatalMessage() [checks.cc:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 69 + 0x5]
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rbx = 0x0000724d485e2bf0 rbp = 0x0000724d2d2515f0
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rsp = 0x0000724d2d2515c0 r12 = 0x0000000000000000
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d2515c8
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r15 = 0x0000724d2a0c4517 rip = 0x0000724d289a31a3
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - 3 libxul.so!rtc::TaskQueue::Impl::Impl(char const*, rtc::TaskQueue*, rtc::TaskQueue::Priority) [task_queue_libevent.cc:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 287 + 0x49]
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rbx = 0x0000724d2d251608 rbp = 0x0000724d2d251740
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - rsp = 0x0000724d2d251600 r12 = 0x0000000000000000
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2c2ac7c8
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - r15 = 0x0000724d2a0c4517 rip = 0x0000724d289ac876
[task 2019-07-13T15:08:39.499Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - 4 libxul.so!rtc::RefCountedObject<rtc::TaskQueue::Impl>::RefCountedObject<char const*&, rtc::TaskQueue*, rtc::TaskQueue::Priority&>(char const*&, rtc::TaskQueue*&&, rtc::TaskQueue::Priority&) [refcountedobject.h:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 31 + 0x5]
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rbx = 0x0000724d2c2ac7a0 rbp = 0x0000724d2d251760
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rsp = 0x0000724d2d251750 r12 = 0x0000724d2d25177c
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d133180c0
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r15 = 0x0000724d2d251780 rip = 0x0000724d289ad3ac
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - 5 libxul.so!rtc::TaskQueue::TaskQueue(char const*, rtc::TaskQueue::Priority) [task_queue_libevent.cc:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 490 + 0x50]
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rbx = 0x0000724d2c2ac7a0 rbp = 0x0000724d2d2517b0
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rsp = 0x0000724d2d251770 r12 = 0x0000724d2d25177c
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d133180c0
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r15 = 0x0000724d2d251780 rip = 0x0000724d289ad364
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - 6 libxul.so!webrtc::voe::SharedData::SharedData() [shared_data.cc:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 28 + 0x15]
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rbx = 0x0000724d13318000 rbp = 0x0000724d2d2517d0
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rsp = 0x0000724d2d2517c0 r12 = 0x0000724d13313100
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d13318048
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r15 = 0x0000724d13219c00 rip = 0x0000724d289cd14c
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - 7 libxul.so!webrtc::VoiceEngineImpl::VoiceEngineImpl() [voice_engine_impl.h:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 30 + 0x5]
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rbx = 0x0000724d13318000 rbp = 0x0000724d2d251810
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rsp = 0x0000724d2d2517e0 r12 = 0x0000724d13313100
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d251a20
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r15 = 0x0000724d13219c00 rip = 0x0000724d289cfd43
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - 8 libxul.so!webrtc::GetVoiceEngine() [voice_engine_impl.cc:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 31 + 0x8]
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rbx = 0x0000724d13318000 rbp = 0x0000724d2d251830
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - rsp = 0x0000724d2d251820 r12 = 0x0000724d13313100
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d251a20
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - r15 = 0x0000724d13219c00 rip = 0x0000724d289cfd07
[task 2019-07-13T15:08:39.500Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - 9 libxul.so!mozilla::PeerConnectionMedia::AddTransceiver(mozilla::JsepTransceiver*, mozilla::dom::MediaStreamTrack&, mozilla::dom::MediaStreamTrack*, RefPtr<mozilla::TransceiverImpl>*) [PeerConnectionMedia.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 513 + 0x48]
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rbx = 0x0000724d16d5d400 rbp = 0x0000724d2d251a00
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rsp = 0x0000724d2d251840 r12 = 0x0000724d13313100
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d251a20
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r15 = 0x0000724d13219c00 rip = 0x0000724d26f90803
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - 10 libxul.so!mozilla::PeerConnectionImpl::CreateTransceiverImpl(mozilla::JsepTransceiver*, mozilla::dom::MediaStreamTrack*, mozilla::ErrorResult&) [PeerConnectionImpl.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 964 + 0x19]
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rbx = 0x0000724d1b2caa00 rbp = 0x0000724d2d251a60
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rsp = 0x0000724d2d251a10 r12 = 0x0000724d174e1800
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r13 = 0x0000724d2d251a28 r14 = 0x0000724d2d251a20
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r15 = 0x0000724d13219c00 rip = 0x0000724d26f904fd
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - 11 libxul.so!mozilla::PeerConnectionImpl::CreateTransceiverImpl(nsTSubstring<char16_t> const&, mozilla::dom::MediaStreamTrack*, mozilla::ErrorResult&) [PeerConnectionImpl.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 987 + 0x11]
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rbx = 0x0000724d13219c00 rbp = 0x0000724d2d251ab0
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rsp = 0x0000724d2d251a70 r12 = 0x0000724d174e1800
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r13 = 0x0000000000000001 r14 = 0x0000724d2d251ac8
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r15 = 0x0000724d1b2caa00 rip = 0x0000724d26f913bc
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - 12 libxul.so!mozilla::dom::PeerConnectionImpl_Binding::createTransceiverImpl(JSContext*, JS::Handle<JSObject*>, mozilla::PeerConnectionImpl*, JSJitMethodCallArgs const&) [PeerConnectionImplBinding.cpp: : 392 + 0xb]
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rbx = 0x0000724d2d251ac8 rbp = 0x0000724d2d251ba0
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - rsp = 0x0000724d2d251ac0 r12 = 0x0000724d1b2caa00
[task 2019-07-13T15:08:39.501Z] 15:08:39 INFO - r13 = 0x0000724d2272b000 r14 = 0x0000724d2d251be8
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - r15 = 0x0000724d2d251c00 rip = 0x0000724d275a895f
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - 13 libxul.so!bool mozilla::dom::binding_detail::GenericMethod<mozilla::dom::binding_detail::NormalThisPolicy, mozilla::dom::binding_detail::ThrowExceptions>(JSContext*, unsigned int, JS::Value*) [BindingUtils.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 3181 + 0x14]
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rbx = 0x0000724d275a8839 rbp = 0x0000724d2d251c40
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rsp = 0x0000724d2d251bb0 r12 = 0x0000000000000000
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - r13 = 0x00000000000001b6 r14 = 0x0000724d2bc51ae0
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - r15 = 0x0000724d2272b000 rip = 0x0000724d279c1154
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - 14 0x17869605760f
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rbx = 0x0000724d2d251c88 rbp = 0x0000724d2d251ca8
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rsp = 0x0000724d2d251c50 r12 = 0x0000000000000008
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - r13 = 0x0000724d2d252528 r14 = 0x000038da3c2030b8
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - r15 = 0x0000724d2272b000 rip = 0x000017869605760f
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - 15 0x724d1c299170
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rbp = 0x0000724d2d251d58 rsp = 0x0000724d2d251cb8
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rip = 0x0000724d1c299170
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - Found by: previous frame's frame pointer
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - 16 0x178695ff17a4
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rbp = 0x0000724d2d251da0 rsp = 0x0000724d2d251d68
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - rip = 0x0000178695ff17a4
[task 2019-07-13T15:08:39.502Z] 15:08:39 INFO - Found by: previous frame's frame pointer
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 17 0x724d1ffb0cc8
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbp = 0x0000724d2d251e38 rsp = 0x0000724d2d251db0
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rip = 0x0000724d1ffb0cc8
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: previous frame's frame pointer
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 18 0x178695f5e4df
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbp = 0x0000724d2d251eb0 rsp = 0x0000724d2d251e48
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rip = 0x0000178695f5e4df
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: previous frame's frame pointer
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 19 libxul.so!js::jit::MaybeEnterJit(JSContext*, js::RunState&) [Jit.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 196 + 0x2c0]
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbp = 0x0000724d2d252380 rsp = 0x0000724d2d251ec0
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rip = 0x0000724d2944c298
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: previous frame's frame pointer
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 20 libxul.so!js::RunScript(JSContext*, js::RunState&) [Interpreter.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 410 + 0xb]
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbx = 0x00000000000000c0 rbp = 0x0000724d2d2523e0
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rsp = 0x0000724d2d252390 r12 = 0x00003a7583692740
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r13 = 0x0000724d2272b000 r14 = 0x0000724d2d252450
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r15 = 0x0000724d2d252468 rip = 0x0000724d28cd2c83
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 21 libxul.so!js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) [Interpreter.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 568 + 0x8]
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbx = 0x0000724d22708c00 rbp = 0x0000724d2d2524b0
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rsp = 0x0000724d2d2523f0 r12 = 0x0000724d2d2524d8
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r13 = 0x0000000000000000 r14 = 0x0000724d2272b000
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r15 = 0x0000724d2272b020 rip = 0x0000724d28ce8b4b
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 22 libxul.so!JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [jsapi.cpp:af2f2aec7bbbf5437fd2fc67ca0d4b8c9891dc0b : 2658 + 0x33]
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbx = 0x0000724d2d252620 rbp = 0x0000724d2d252590
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rsp = 0x0000724d2d2524c0 r12 = 0x0000724d2d252658
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r13 = 0x0000724d2272b000 r14 = 0x0000000000000002
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r15 = 0x0000724d2d252688 rip = 0x0000724d290a87ef
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: call frame info
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - 23 libxul.so!mozilla::dom::RTCPeerConnection_Binding::addTrack(JSContext*, JS::Handle<JSObject*>, mozilla::dom::RTCPeerConnection*, JSJitMethodCallArgs const&) [RTCPeerConnectionBinding.cpp: : 3634 + 0x217]
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rbx = 0x0000724d2d252670 rbp = 0x0000724d2d252980
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - rsp = 0x0000724d2d2525a0 r12 = 0x0000724d132f6b10
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r13 = 0x0000724d132f6b00 r14 = 0x0000724d2d252620
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - r15 = 0x0000724d2272b000 rip = 0x0000724d27610512
[task 2019-07-13T15:08:39.503Z] 15:08:39 INFO - Found by: call frame info
Stack goes a bit deep, and seems less reliable from here, but is that normal on Android maybe? Byron, does this tell you anything?
|
||
Comment 5•5 years ago
|
||
I am not sure what is going wrong, but this is not the only intermittent failure on android that involves a call to pipe failing.
|
|
||
Comment 6•5 years ago
|
||
6 out of 13 runs of that wpt16 test fail on that try. Why are we not seeing those high numbers on nightly?
|
|
||
Comment 7•5 years ago
|
||
What happens on try if you just use the restartIce patch, and not the new wpt?
|
|
||
Comment 8•5 years ago
|
||
So, in almost all of these failures, we're asserting in webrtc.org because a call to pipe failed. In one case, we fail elsewhere, and get a little more logging:
07-13 16:07:39.972 21366 21381 I Gecko : [Child 21366: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:330: PeerConnectionImpl: PeerConnectionImpl constructor for
07-13 16:07:39.982 21302 21327 I Gecko : [Parent 21302: Unnamed thread 0x7e8617222680]: D/mtransport NrIceCtx static call to find local stun addresses
07-13 16:07:39.982 21366 21381 I Gecko : [Child 21366: Main Thread]: I/signaling [main|PeerConnectionImpl] PeerConnectionImpl.cpp:330: PeerConnectionImpl: PeerConnectionImpl constructor for
07-13 16:07:39.982 21302 21327 I Gecko : [Parent 21302: Unnamed thread 0x7e8617222680]: D/mtransport NrIceCtx static call to find local stun addresses
07-13 16:07:39.992 21366 23006 I Gecko : [Child 21366, Unnamed thread 7e86084eacd0] WARNING: Unable to create pipe named "21366.78.1663672913" in server mode error(Too many open files).: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 211
07-13 16:07:39.992 21366 23006 I Gecko : [Child 21366, Unnamed thread 7e86084eacd0] WARNING: Unable to create pipe named "21366.79.1646026653" in server mode error(Too many open files).: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 211
07-13 16:07:39.992 21366 21392 I Gecko : [Child 21366: Unnamed thread 0x7e861722b570]: E/mtransport ICE FAILED: Couldn't gather ICE candidates for 'PC:1563030459952681 (id=2147483811 url=http://web-platform.test:8000/webrtc/RTCPeerConnection-setRemoteDescription-rollback.html)', error=3
It looks like we are exceeding the fd limit or something. Maybe simply because we have finally added more tests than android can cope with. What is that limit, I wonder?
|
||
Comment 9•5 years ago
|
||
I think the limit is 1024 open file descriptors:
gbrown@mozpad2:~/src$ ./mach android-emulator
0:00.59 Starting Android emulator running Android 7.0 x86/x86_64...
Running the x86 emulator; be sure to install an x86 APK!
0:12.89 Android emulator is running.
0:12.89 Use 'mach install' to install or update Firefox on your emulator.
gbrown@mozpad2:~/src$ adb shell
generic_x86_64:/ # ulimit -a
time(cpu-seconds) unlimited
file(blocks) unlimited
coredump(blocks) 0
data(KiB) unlimited
stack(KiB) 8192
lockedmem(KiB) 64
nofiles(descriptors) 1024
processes 23875
sigpending 23875
msgqueue(bytes) 819200
maxnice 40
maxrtprio 0
resident-set(KiB) unlimited
address-space(KiB) unlimited
generic_x86_64:/ #
|
|
||
Comment 10•5 years ago
|
||
(In reply to Byron Campen [:bwc] from comment #7)
What happens on try if you just use the restartIce patch, and not the new wpt?
It's taking a while to provide this answer.
|
|
||
Comment 11•5 years ago
|
||
The answer is it's all green then.
So how do we land this? Disable some tests on android?
|
||
Comment 14•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Description
•