Closed Bug 1682775 Opened 4 years ago Closed 4 years ago

Intermittent org.mozilla.geckoview.test.[<something>] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const] | application crashed [@ mozilla::ipc::IProtocol::ChannelSend(IPC::Message*)]

Categories

(Core :: Graphics: WebRender, defect)

Unspecified
Android
defect

Tracking

()

RESOLVED FIXED
86 Branch
Tracking Status
firefox-esr78 --- unaffected
firefox84 --- unaffected
firefox85 --- unaffected
firefox86 --- fixed

People

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

References

(Regression)

Details

(Keywords: crash, intermittent-failure, regression, Whiteboard: [retriggered][stockwell unknown])

Crash Data

Attachments

(1 file)

Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=324658717&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Wqt35rbfR5GN1RAVIjo13Q/runs/0/artifacts/public/logs/live_backing.log


[task 2020-12-16T08:47:57.666Z] 08:47:57     INFO -  TEST-START | org.mozilla.geckoview.test.SelectionActionDelegateTest.paste[#textarea]
[task 2020-12-16T08:47:58.124Z] 08:47:58     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_RESULT: shortMsg=Process crashed.
[task 2020-12-16T08:47:58.125Z] 08:47:58     INFO -  org.mozilla.geckoview.test | INSTRUMENTATION_CODE: 0
[task 2020-12-16T08:47:58.139Z] 08:47:58     INFO -  org.mozilla.geckoview.test | adb_returncode=0
[task 2020-12-16T08:47:58.142Z] 08:47:58     INFO -  Passed: 469
[task 2020-12-16T08:47:58.142Z] 08:47:58     INFO -  Failed: 0
[task 2020-12-16T08:47:58.142Z] 08:47:58     INFO -  Todo: 48
[task 2020-12-16T08:47:58.142Z] 08:47:58     INFO -  SUITE-END | took 334s
[task 2020-12-16T08:47:58.265Z] 08:47:58     INFO -  mozcrash Copy/paste: /builds/worker/fetches/minidump_stackwalk/minidump_stackwalk /tmp/tmpWfLhir/567087c2-0ea9-5bb6-2bd3-c566c45d9103.dmp /builds/worker/workspace/build/symbols
[task 2020-12-16T08:48:03.297Z] 08:48:03     INFO -  mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/567087c2-0ea9-5bb6-2bd3-c566c45d9103.dmp
[task 2020-12-16T08:48:03.298Z] 08:48:03     INFO -  mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/567087c2-0ea9-5bb6-2bd3-c566c45d9103.extra
[task 2020-12-16T08:48:03.313Z] 08:48:03  WARNING -  PROCESS-CRASH | org.mozilla.geckoview.test.SelectionActionDelegateTest.paste[#textarea] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const]
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Mozilla crash reason: MOZ_ASSERT(mRawPtr != nullptr) (You can't dereference a NULL RefPtr with operator->().)
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Crash dump filename: /tmp/tmpWfLhir/567087c2-0ea9-5bb6-2bd3-c566c45d9103.dmp
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Operating system: Android
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -                    0.0.0 Linux 3.10.0+ #260 SMP PREEMPT Fri May 19 12:48:14 PDT 2017 x86_64
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  CPU: amd64
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -       family 6 model 6 stepping 3
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -       4 CPUs
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  GPU: UNKNOWN
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Crash reason:  SIGSEGV /SEGV_MAPERR
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Crash address: 0x0
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Process uptime: not available
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -  Thread 47 (crashed)
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -   0  libxul.so!RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const [RefPtr.h:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 314 + 0x29]
[task 2020-12-16T08:48:03.313Z] 08:48:03     INFO -      rax = 0x00007288bcdb04c8   rdx = 0x0000000000000004
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rcx = 0x00007288c194be08   rbx = 0x00007288987d3400
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rsi = 0x00007288ad0bcd70   rdi = 0x000000000000001b
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rbp = 0x00007288ad0bde90   rsp = 0x00007288ad0bde90
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -       r8 = 0x000000000000ffff    r9 = 0x0000000000000000
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      r10 = 0x00007288dba583d0   r11 = 0x0000000000000246
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      r12 = 0x00007288987d35f0   r13 = 0xaaaaaaaaaaaaaaaa
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      r14 = 0x00007288ad0bdf10   r15 = 0x00007288ad0bdf28
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rip = 0x00007288b7d9da69
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      Found by: given as instruction pointer in context
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -   1  libxul.so!mozilla::layers::CompositorBridgeParent::NotifyDidRender(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType> const&, mozilla::TimeStamp&, mozilla::TimeStamp&, mozilla::TimeStamp&, mozilla::wr::RendererStats*) [CompositorBridgeParent.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 2335 + 0x5]
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rbp = 0x00007288ad0bdef0   rsp = 0x00007288ad0bdea0
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rip = 0x00007288b7ebf1ef
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -   2  libxul.so!mozilla::wr::NotifyDidRender(mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats) [RenderThread.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 427 + 0xb]
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rbp = 0x00007288ad0bdf60   rsp = 0x00007288ad0bdf00
[task 2020-12-16T08:48:03.314Z] 08:48:03     INFO -      rip = 0x00007288b7f8add3
[task 2020-12-16T08:48:03.315Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.315Z] 08:48:03     INFO -   3  libxul.so!void details::CallFunction<(unsigned long)0, (unsigned long)1, (unsigned long)2, (unsigned long)3, (unsigned long)4, (unsigned long)5, (unsigned long)6, (unsigned long)7, void (*)(mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats>(std::__ndk1::integer_sequence<unsigned long, ((unsigned long)0, (unsigned long)1, (unsigned long)2, (unsigned long)3, (unsigned long)4, (unsigned long)5, (unsigned long)6, (unsigned long)7)...>, void (*)(mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::Tuple<mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats>&) [task.h:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 37 + 0x4b]
[task 2020-12-16T08:48:03.315Z] 08:48:03     INFO -      rbp = 0x00007288ad0bdfc0   rsp = 0x00007288ad0bdf70
[task 2020-12-16T08:48:03.315Z] 08:48:03     INFO -      rip = 0x00007288b7f96d12
[task 2020-12-16T08:48:03.315Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -   4  libxul.so!RunnableFunction<void (*)(mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::Tuple<mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats> >::Run() [task.h:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 324 + 0x12]
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rbp = 0x00007288ad0bdfd0   rsp = 0x00007288ad0bdfd0
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rip = 0x00007288b7f96b57
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -   5  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 1200 + 0x15]
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rbp = 0x00007288ad0be0c0   rsp = 0x00007288ad0bdfe0
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rip = 0x00007288b714b386
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -   6  libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 548 + 0x10]
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rbp = 0x00007288ad0be100   rsp = 0x00007288ad0be0d0
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rip = 0x00007288b714f50e
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -   7  libxul.so!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 332 + 0xb]
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rbp = 0x00007288ad0be150   rsp = 0x00007288ad0be110
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      rip = 0x00007288b7739607
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.316Z] 08:48:03     INFO -   8  libxul.so!MessageLoop::RunInternal() [message_loop.cc:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 334 + 0x17]
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rbp = 0x00007288ad0be190   rsp = 0x00007288ad0be160
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rip = 0x00007288b76e7762
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -   9  libxul.so!MessageLoop::Run() [message_loop.cc:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 309 + 0x8]
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rbp = 0x00007288ad0be1d0   rsp = 0x00007288ad0be1a0
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rip = 0x00007288b76e76cb
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -  10  libxul.so!nsThread::ThreadFunc(void*) [nsThread.cpp:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 441 + 0x8]
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rbp = 0x00007288ad0be3a0   rsp = 0x00007288ad0be1e0
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rip = 0x00007288b7148ce6
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -  11  libnss3.so!_pt_root [ptthread.c:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 201 + 0x7]
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rbp = 0x00007288ad0be3e0   rsp = 0x00007288ad0be3b0
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      rip = 0x00007288c0e863ae
[task 2020-12-16T08:48:03.317Z] 08:48:03     INFO -      Found by: previous frame's frame pointer
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -  12  libnss3.so!pt_recvfrom_cont [ptio.c:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 987 + 0x2f]
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rbp = 0x00007288ad0be3e0   rsp = 0x00007288ad0be3d0
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rip = 0x00007288c0e86276
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -  13  libc.so + 0x89772
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rsp = 0x00007288ad0be3f0   rip = 0x00007288dbaba772
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -  14  libnss3.so!pt_recvfrom_cont [ptio.c:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 987 + 0x2f]
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rsp = 0x00007288ad0be428   rip = 0x00007288c0e86276
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -  15  libc.so + 0x299ec
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rsp = 0x00007288ad0be440   rip = 0x00007288dba5a9ec
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -  16  libc.so + 0x896c0
[task 2020-12-16T08:48:03.318Z] 08:48:03     INFO -      rsp = 0x00007288ad0be448   rip = 0x00007288dbaba6c0
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -  17  libc.so + 0x1ca66
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -      rsp = 0x00007288ad0be450   rip = 0x00007288dba4da66
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -      Found by: stack scanning
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -  18  libnss3.so!pt_recvfrom_cont [ptio.c:e72dab7cb89d57b394e5b90950b2b3ee96fea71f : 987 + 0x2f]
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -      rsp = 0x00007288ad0be4b8   rip = 0x00007288c0e86276
[task 2020-12-16T08:48:03.319Z] 08:48:03     INFO -      Found by: stack scanning```
Summary: Intermittent org.mozilla.geckoview.test.SelectionActionDelegateTest.paste[#<something>] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const] → Intermittent org.mozilla.geckoview.test.[<something>] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const]
Component: General → Graphics
Product: GeckoView → Core

There are 20 total failures in the last 7 days on android-em-7-0-x86_64-qr debug

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=324972635&repo=mozilla-central&lineNumber=11783

[task 2020-12-18T22:06:35.060Z] 22:06:35 INFO - TEST-START | org.mozilla.geckoview.test.SelectionActionDelegateTest.pagehide[#designmode]
[task 2020-12-18T22:06:35.530Z] 22:06:35 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_RESULT: shortMsg=Process crashed.
[task 2020-12-18T22:06:35.531Z] 22:06:35 INFO - org.mozilla.geckoview.test |
[task 2020-12-18T22:06:35.531Z] 22:06:35 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_CODE: 0
[task 2020-12-18T22:06:35.546Z] 22:06:35 INFO - org.mozilla.geckoview.test | adb_returncode=0
[task 2020-12-18T22:06:35.548Z] 22:06:35 INFO - Passed: 510
[task 2020-12-18T22:06:35.548Z] 22:06:35 INFO - Failed: 0
[task 2020-12-18T22:06:35.548Z] 22:06:35 INFO - Todo: 60
[task 2020-12-18T22:06:35.548Z] 22:06:35 INFO - SUITE-END | took 389s
[task 2020-12-18T22:06:35.659Z] 22:06:35 INFO - mozcrash Copy/paste: /builds/worker/fetches/minidump_stackwalk/minidump_stackwalk /tmp/tmpaxdJi7/41245c3c-6d4f-beb1-ff42-9945c121c644.dmp /builds/worker/workspace/build/symbols
[task 2020-12-18T22:06:39.274Z] 22:06:39 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/41245c3c-6d4f-beb1-ff42-9945c121c644.dmp
[task 2020-12-18T22:06:39.274Z] 22:06:39 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/41245c3c-6d4f-beb1-ff42-9945c121c644.extra
[task 2020-12-18T22:06:39.289Z] 22:06:39 WARNING - PROCESS-CRASH | org.mozilla.geckoview.test.SelectionActionDelegateTest.pagehide[#designmode] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const]
[task 2020-12-18T22:06:39.289Z] 22:06:39 INFO - Mozilla crash reason: MOZ_ASSERT(mRawPtr != nullptr) (You can't dereference a NULL RefPtr with operator->().)
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - Crash dump filename: /tmp/tmpaxdJi7/41245c3c-6d4f-beb1-ff42-9945c121c644.dmp
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - Operating system: Android
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - 0.0.0 Linux 3.10.0+ #260 SMP PREEMPT Fri May 19 12:48:14 PDT 2017 x86_64
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - CPU: amd64
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - family 6 model 6 stepping 3
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - 4 CPUs
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - GPU: UNKNOWN
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - Crash reason: SIGSEGV /SEGV_MAPERR
[task 2020-12-18T22:06:39.290Z] 22:06:39 INFO - Crash address: 0x0
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - Process uptime: not available
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - Thread 46 (crashed)
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - 0 libxul.so!RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const [RefPtr.h:507ca4e6728999552b7ce90c7cf1513ce18f149b : 314 + 0x29]
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - rax = 0x000079cb0b9b04c8 rdx = 0x0000000000000004
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - rcx = 0x000079cb104f6e08 rbx = 0x000079caddc80400
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - rsi = 0x000079cafb1b8d70 rdi = 0x000000000000001b
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - rbp = 0x000079cafb1b9e90 rsp = 0x000079cafb1b9e90
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - r8 = 0x000000000000ffff r9 = 0x0000000000000000
[task 2020-12-18T22:06:39.291Z] 22:06:39 INFO - r10 = 0x000079cb2dd973d0 r11 = 0x0000000000000246
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - r12 = 0x000079caddc805f0 r13 = 0xaaaaaaaaaaaaaaaa
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - r14 = 0x000079cafb1b9f10 r15 = 0x000079cafb1b9f28
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - rip = 0x000079cb069f9c25
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - Found by: given as instruction pointer in context
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - 1 libxul.so!mozilla::layers::CompositorBridgeParent::NotifyDidRender(mozilla::layers::BaseTransactionId<mozilla::VsyncIdType> const&, mozilla::TimeStamp&, mozilla::TimeStamp&, mozilla::TimeStamp&, mozilla::wr::RendererStats*) [CompositorBridgeParent.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 2336 + 0x5]
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - rbp = 0x000079cafb1b9ef0 rsp = 0x000079cafb1b9ea0
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - rip = 0x000079cb06b1984f
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - 2 libxul.so!mozilla::wr::NotifyDidRender(mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats) [RenderThread.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 427 + 0xb]
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - rbp = 0x000079cafb1b9f60 rsp = 0x000079cafb1b9f00
[task 2020-12-18T22:06:39.292Z] 22:06:39 INFO - rip = 0x000079cb06be3fb3
[task 2020-12-18T22:06:39.293Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.293Z] 22:06:39 INFO - 3 libxul.so!void details::CallFunction<(unsigned long)0, (unsigned long)1, (unsigned long)2, (unsigned long)3, (unsigned long)4, (unsigned long)5, (unsigned long)6, (unsigned long)7, void ()(mozilla::layers::CompositorBridgeParent, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats>(std::__ndk1::integer_sequence<unsigned long, ((unsigned long)0, (unsigned long)1, (unsigned long)2, (unsigned long)3, (unsigned long)4, (unsigned long)5, (unsigned long)6, (unsigned long)7)...>, void ()(mozilla::layers::CompositorBridgeParent, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::Tuple<mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats>&) [task.h:507ca4e6728999552b7ce90c7cf1513ce18f149b : 37 + 0x4b]
[task 2020-12-18T22:06:39.293Z] 22:06:39 INFO - rbp = 0x000079cafb1b9fc0 rsp = 0x000079cafb1b9f70
[task 2020-12-18T22:06:39.293Z] 22:06:39 INFO - rip = 0x000079cb06befc7e
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - 4 libxul.so!RunnableFunction<void ()(mozilla::layers::CompositorBridgeParent, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats), mozilla::Tuple<mozilla::layers::CompositorBridgeParent*, RefPtr<mozilla::wr::WebRenderPipelineInfo const>, mozilla::layers::BaseTransactionId<mozilla::VsyncIdType>, mozilla::TimeStamp, mozilla::TimeStamp, mozilla::TimeStamp, bool, mozilla::wr::RendererStats> >::Run() [task.h:507ca4e6728999552b7ce90c7cf1513ce18f149b : 324 + 0x12]
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - rbp = 0x000079cafb1b9fd0 rsp = 0x000079cafb1b9fd0
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - rip = 0x000079cb06befac7
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - 5 libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 1200 + 0x15]
[task 2020-12-18T22:06:39.294Z] 22:06:39 INFO - rbp = 0x000079cafb1ba0c0 rsp = 0x000079cafb1b9fe0
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rip = 0x000079cb05db7118
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - 6 libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 548 + 0x10]
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rbp = 0x000079cafb1ba100 rsp = 0x000079cafb1ba0d0
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rip = 0x000079cb05dbb240
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - 7 libxul.so!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 302 + 0xa]
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rbp = 0x000079cafb1ba150 rsp = 0x000079cafb1ba110
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rip = 0x000079cb0639dd2a
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - 8 libxul.so!MessageLoop::RunInternal() [message_loop.cc:507ca4e6728999552b7ce90c7cf1513ce18f149b : 334 + 0x17]
[task 2020-12-18T22:06:39.295Z] 22:06:39 INFO - rbp = 0x000079cafb1ba190 rsp = 0x000079cafb1ba160
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rip = 0x000079cb0634c7b4
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - 9 libxul.so!MessageLoop::Run() [message_loop.cc:507ca4e6728999552b7ce90c7cf1513ce18f149b : 309 + 0x8]
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rbp = 0x000079cafb1ba1d0 rsp = 0x000079cafb1ba1a0
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rip = 0x000079cb0634c71d
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - 10 libxul.so!nsThread::ThreadFunc(void*) [nsThread.cpp:507ca4e6728999552b7ce90c7cf1513ce18f149b : 441 + 0x8]
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rbp = 0x000079cafb1ba3a0 rsp = 0x000079cafb1ba1e0
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rip = 0x000079cb05db4aa6
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - 11 libnss3.so!_pt_root [ptthread.c:507ca4e6728999552b7ce90c7cf1513ce18f149b : 201 + 0x7]
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rbp = 0x000079cafb1ba3e0 rsp = 0x000079cafb1ba3b0
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rip = 0x000079cb0fa86b3e
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - Found by: previous frame's frame pointer
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - 12 libnss3.so!pt_recvfrom_cont [ptio.c:507ca4e6728999552b7ce90c7cf1513ce18f149b : 987 + 0x2f]
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rbp = 0x000079cafb1ba3e0 rsp = 0x000079cafb1ba3d0
[task 2020-12-18T22:06:39.296Z] 22:06:39 INFO - rip = 0x000079cb0fa86a09
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 13 libc.so + 0x89772
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba3f0 rip = 0x000079cb2ddf9772
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 14 libnss3.so!pt_recvfrom_cont [ptio.c:507ca4e6728999552b7ce90c7cf1513ce18f149b : 987 + 0x2f]
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba428 rip = 0x000079cb0fa86a09
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 15 libc.so + 0x299ec
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba440 rip = 0x000079cb2dd999ec
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 16 libc.so + 0x896c0
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba448 rip = 0x000079cb2ddf96c0
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 17 libc.so + 0x1ca66
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba450 rip = 0x000079cb2dd8ca66
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - 18 libnss3.so!pt_recvfrom_cont [ptio.c:507ca4e6728999552b7ce90c7cf1513ce18f149b : 987 + 0x2f]
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - rsp = 0x000079cafb1ba4b8 rip = 0x000079cb0fa86a09
[task 2020-12-18T22:06:39.297Z] 22:06:39 INFO - Found by: stack scanning

Jim please assign someone to take a look. Thank you!

Flags: needinfo?(jmathies)

This looks to have started from Bug 1676862: https://hg.mozilla.org/integration/autoland/rev/6e726f9e1812ddc7044adf0cc738dc51123da606
Retriggers here.
Lee, could you please have a look over this quite frequent crash? Only fails on webrender debug buids: https://treeherder.mozilla.org/intermittent-failures/bugdetails?startday=2020-12-13&endday=2020-12-20&tree=trunk&bug=1682775

Flags: needinfo?(lsalzman)
Regressed by: 1676862
Whiteboard: [retriggered]
Has Regression Range: --- → yes
Keywords: regression
Crash Signature: [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const] → [@ mozilla::ipc::IProtocol::ChannelSend(IPC::Message*)] [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const]
Summary: Intermittent org.mozilla.geckoview.test.[<something>] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const] → Intermittent org.mozilla.geckoview.test.[<something>] | application crashed [@ RefPtr<mozilla::layers::UiCompositorControllerParent>::operator->() const] | application crashed [@ mozilla::ipc::IProtocol::ChannelSend(IPC::Message*)]

Set release status flags based on info from the regressing bug 1676862

Jamie, seems like the uiController is null at this early point in time. This query for it was added in bug 1479754. Any idea what would be the simplest way to deal with this case would be?

Flags: needinfo?(lsalzman) → needinfo?(jnicol)
See Also: → 1479754
Assignee: nobody → lsalzman
Status: NEW → ASSIGNED
Flags: needinfo?(jnicol)
Flags: needinfo?(jmathies)
Component: Graphics → Graphics: WebRender
OS: All → Android

I'm concerned that without the first paint message being delivered to the geckoview code, the android View won't be uncovered meaning we never see any content. So this patch might replace an intermittent crash, where at least it's obvious where the problem lies, with intermittent reftest failures due to completely blank screens without obvious cause.

It would be good to understand why the UI controller is null.

(In reply to Jamie Nicol [:jnicol] from comment #13)

I'm concerned that without the first paint message being delivered to the geckoview code, the android View won't be uncovered meaning we never see any content. So this patch might replace an intermittent crash, where at least it's obvious where the problem lies, with intermittent reftest failures due to completely blank screens without obvious cause.

It would be good to understand why the UI controller is null.

This is because the wake_up notifier inside WebRender can get changed by status in the debug panel, which triggers a spurious early render, and that these debug wake_up triggers happen sometimes well before everything is set up to actually render everything.

What do you mean by the debug panel?

In any case, and after reading the patch properly, this is probably fine. Because mIsForcedFirstPaint will remain true until the UI controller becomes initialized, and the message will therefore be delivered then.

Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → 86 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: