Closed Bug 1809319 Opened 2 years ago Closed 3 months ago

Intermittent Main app process exited normally | application crashed [@ arena_t::GetNonFullBinRun]

Categories

(Core :: Networking, defect, P3)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: crash, intermittent-failure)

Crash Data

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=401835728&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/NvD9BTeJSa6HdQhYOfB-vw/runs/1/artifacts/public/logs/live_backing.log


[task 2023-01-09T19:12:03.900Z] 19:12:03     INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ arena_t::GetNonFullBinRun(arena_bin_t*)]
[task 2023-01-09T19:12:03.900Z] 19:12:03     INFO - Crash dump filename: /tmp/tmplgldt8hb.mozrunner/minidumps/28c25519-3eca-3418-be2e-1c4666400c1d.dmp
[task 2023-01-09T19:12:03.900Z] 19:12:03     INFO - Operating system: Linux
[task 2023-01-09T19:12:03.900Z] 19:12:03     INFO -                   4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - CPU: amd64
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO -      family 6 model 85 stepping 7
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO -      4 CPUs
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - 
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - Crash reason:  SIGABRT
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - Crash address: 0x3e8000015e0
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - Crashing instruction: `mov qword [rax + 0x8], r15`
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO - Memory accessed by instruction:
[task 2023-01-09T19:12:03.901Z] 19:12:03     INFO -   0. Address: 0x00007feac0b98008
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      Size: 8
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO - Process uptime: not available
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO - 
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO - Thread 0 Isolated Web Co (crashed)
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -  0  firefox-bin!arena_t::GetNonFullBinRun(arena_bin_t*) [mozjemalloc.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 2959 + 0x0]
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rax = 0x00007feac0b98000    rdx = 0x0000000000000000
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rcx = 0x00007feac0b00e78    rbx = 0x00007feb2d400190
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rsi = 0x0000000000000000    rdi = 0x00007feb2d400000
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rbp = 0x00007ffed01356e0    rsp = 0x00007ffed01356c0
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -       r8 = 0x00007feac0b98001     r9 = 0x0000000001dcd1cd
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r10 = 0x000000000021e9ba    r11 = 0x00000000006537f7
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r12 = 0x00007feb2d400198    r13 = 0x00007feb2d400020
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r14 = 0x00007feb2d400000    r15 = 0x00007feb2d400190
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rip = 0x000055cd812366ff
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -     Found by: given as instruction pointer in context
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -  1  firefox-bin!arena_t::MallocSmall(unsigned long, bool) [mozjemalloc.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 3127 + 0x11]
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rbx = 0x00007feb2d400190    rbp = 0x00007ffed0135760
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rsp = 0x00007ffed01356f0    r12 = 0x00007feac0b97000
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r13 = 0x00007feb2d400020    r14 = 0x00007feb2d400000
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r15 = 0x0000000000000000    rip = 0x000055cd81240310
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -  2  firefox-bin!Malloc [mozjemalloc.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 3180]
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -  3  firefox-bin!BaseAllocator::malloc(unsigned long) [mozjemalloc.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 4331 + 0x28]
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rbx = 0x00007ffed0135790    rbp = 0x00007ffed0135780
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      rsp = 0x00007ffed0135770    r12 = 0x00007ffed0135848
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r13 = 0x00007feb0dcc244e    r14 = 0x0000000000000048
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -      r15 = 0x00007feb12e70870    rip = 0x000055cd812435f4
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.902Z] 19:12:03     INFO -  4  firefox-bin!Allocator<MozJemallocBase>::malloc(unsigned long) [malloc_decls.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 51 + 0x4]
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      rbx = 0x0000000000000048    rbp = 0x00007ffed01357a0
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      rsp = 0x00007ffed0135790    r12 = 0x00007ffed0135848
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      r13 = 0x00007feb0dcc244e    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      r15 = 0x00007feb12e70870    rip = 0x000055cd81242477
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -  5  firefox-bin!PageMalloc [PHC.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1140]
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -  6  firefox-bin!replace_malloc(unsigned long) [PHC.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1144 + 0x7b]
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      rbx = 0x0000000000000048    rbp = 0x00007ffed01357d0
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      rsp = 0x00007ffed01357b0    r12 = 0x00007ffed0135848
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      r13 = 0x00007feb0dcc244e    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -      r15 = 0x00007feb12e70870    rip = 0x000055cd81256bca
[task 2023-01-09T19:12:03.903Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -  7  firefox-bin!moz_xmalloc + 0x10
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -      rbx = 0x0000000000000048    rbp = 0x00007ffed01357f0
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -      rsp = 0x00007ffed01357e0    r12 = 0x00007ffed0135848
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -      r13 = 0x00007feb0dcc244e    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -      r15 = 0x00007feb12e70870    rip = 0x000055cd81259af1
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.904Z] 19:12:03     INFO -  8  libxul.so!operator new [cxxalloc.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 33]
[task 2023-01-09T19:12:03.905Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.905Z] 19:12:03     INFO -  9  libxul.so!mozilla::NewRunnableMethod<RefPtr<mozilla::net::HttpChannelChild>&, void (mozilla::net::HttpChannelChild::*)()>(char const*, RefPtr<mozilla::net::HttpChannelChild>&, void (mozilla::net::HttpChannelChild::*)()) [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1428 + 0x9]
[task 2023-01-09T19:12:03.905Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x00007ffed0135830
[task 2023-01-09T19:12:03.905Z] 19:12:03     INFO -      rsp = 0x00007ffed0135800    r12 = 0x00007ffed0135848
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO -      r13 = 0x00007feb0dcc244e    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO -      r15 = 0x00007feb12e70870    rip = 0x00007feb12e707e5
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO - 10  libxul.so!mozilla::net::HttpChannelChild::Release() [HttpChannelChild.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 225 + 0x1b]
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x00007ffed0135870
[task 2023-01-09T19:12:03.906Z] 19:12:03     INFO -      rsp = 0x00007ffed0135840    r12 = 0x0000000000000000
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -      r13 = 0x00007feb2d379348    r14 = 0x00007feb2d359000
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -      r15 = 0x00007ffed0135848    rip = 0x00007feb12e7041c
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO - 11  libxul.so!Release [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 50]
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO - 12  libxul.so!Release [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 381]
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO - 13  libxul.so!assign_assuming_AddRef [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 69]
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.907Z] 19:12:03     INFO - 14  libxul.so!operator= [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 168]
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO - 15  libxul.so!Revoke [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 775]
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO - 16  libxul.so!Revoke [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1229]
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO - 17  libxul.so!~RunnableMethodImpl [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1189]
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO - 18  libxul.so!mozilla::detail::RunnableMethodImpl<RefPtr<mozilla::net::HttpChannelChild>, void (mozilla::net::HttpChannelChild::*)(), true, (mozilla::RunnableKind)0, >::~RunnableMethodImpl() [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1189 + 0x2e]
[task 2023-01-09T19:12:03.908Z] 19:12:03     INFO -      rbx = 0x00007feb2d3b0650    rbp = 0x00007ffed0135890
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      rsp = 0x00007ffed0135880    r12 = 0x0000000000000000
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      r13 = 0x00007feb2d379348    r14 = 0x00007feb2d3b0678
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      r15 = 0x00007feb03b27780    rip = 0x00007feb12ec7a5a
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO - 19  libxul.so!mozilla::Runnable::Release() [nsThreadUtils.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 62 + 0xc]
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      rbx = 0x0000000000000022    rbp = 0x00007ffed01358a0
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      rsp = 0x00007ffed01358a0    r12 = 0x0000000000000000
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      r13 = 0x00007feb2d379348    r14 = 0x00007feb213d8769
[task 2023-01-09T19:12:03.909Z] 19:12:03     INFO -      r15 = 0x00007feb03b27780    rip = 0x00007feb12614d59
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO - 20  libxul.so!Release [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 50]
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO - 21  libxul.so!Release [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 381]
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO - 22  libxul.so!assign_assuming_AddRef [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 69]
[task 2023-01-09T19:12:03.910Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.911Z] 19:12:03     INFO - 23  libxul.so!operator= [RefPtr.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 168]
[task 2023-01-09T19:12:03.911Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.911Z] 19:12:03     INFO - 24  libxul.so!mozilla::RunnableTask::Run() [TaskController.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 540 + 0x2b]
[task 2023-01-09T19:12:03.911Z] 19:12:03     INFO -      rbx = 0x0000000000000022    rbp = 0x00007ffed0135d20
[task 2023-01-09T19:12:03.912Z] 19:12:03     INFO -      rsp = 0x00007ffed01358b0    r12 = 0x0000000000000000
[task 2023-01-09T19:12:03.912Z] 19:12:03     INFO -      r13 = 0x00007feb2d379348    r14 = 0x00007feb213d8769
[task 2023-01-09T19:12:03.912Z] 19:12:03     INFO -      r15 = 0x00007feb03b27780    rip = 0x00007feb12603f21
[task 2023-01-09T19:12:03.912Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.912Z] 19:12:03     INFO - 25  libxul.so!mozilla::TaskController::DoExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [TaskController.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 852 + 0x8]
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      rbx = 0x00007feb03b27780    rbp = 0x00007ffed0135ef0
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      rsp = 0x00007ffed0135d30    r12 = 0x00007ffed0135da0
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      r13 = 0x00007feb2d379348    r14 = 0x00007feb2d3a0e00
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      r15 = 0x00007ffed0135e68    rip = 0x00007feb125fe7d1
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO - 26  libxul.so!mozilla::TaskController::ExecuteNextTaskOnlyMainThreadInternal(mozilla::detail::BaseAutoLock<mozilla::Mutex&> const&) [TaskController.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 684 + 0x4]
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      rbx = 0x00007ffed0136050    rbp = 0x00007ffed0135f40
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      rsp = 0x00007ffed0135f00    r12 = 0x00007feb2d3a0e00
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      r13 = 0x0000083e57532a79    r14 = 0x00007ffed0135f58
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -      r15 = 0x00007feb2d3a0e00    rip = 0x00007feb125fd240
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.913Z] 19:12:03     INFO - 27  libxul.so!mozilla::TaskController::ProcessPendingMTTask(bool) [TaskController.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 462 + 0x7]
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -      rbx = 0x00007ffed0136050    rbp = 0x00007ffed0135fa0
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -      rsp = 0x00007ffed0135f50    r12 = 0x00007feb2d3a0e00
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -      r13 = 0x0000083e57532a79    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -      r15 = 0x00007feb2d379240    rip = 0x00007feb125fd687
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO - 28  libxul.so!operator() [TaskController.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 188]
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO - 29  libxul.so!mozilla::detail::RunnableFunction<mozilla::TaskController::InitializeInternal()::$_2>::Run() [nsThreadUtils.h:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 546 + 0x14]
[task 2023-01-09T19:12:03.914Z] 19:12:03     INFO -      rbx = 0x00007ffed0136050    rbp = 0x00007ffed0135fb0
[task 2023-01-09T19:12:03.915Z] 19:12:03     INFO -      rsp = 0x00007ffed0135fb0    r12 = 0x0000000000000001
[task 2023-01-09T19:12:03.915Z] 19:12:03     INFO -      r13 = 0x0000083e57532a79    r14 = 0x00007ffed01360ff
[task 2023-01-09T19:12:03.915Z] 19:12:03     INFO -      r15 = 0x00007feb2d379240    rip = 0x00007feb126079f7
[task 2023-01-09T19:12:03.915Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO - 30  libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 1197 + 0x5]
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO -      rbx = 0x00007ffed0136050    rbp = 0x00007ffed01360e0
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO -      rsp = 0x00007ffed0135fc0    r12 = 0x0000000000000001
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO -      r13 = 0x0000083e57532a79    r14 = 0x00007ffed01360ff
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO -      r15 = 0x00007feb2d379240    rip = 0x00007feb1262472c
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.916Z] 19:12:03     INFO - 31  libxul.so!NS_ProcessPendingEvents(nsIThread*, unsigned int) + 0xa1
[task 2023-01-09T19:12:03.917Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x00007ffed0136130
[task 2023-01-09T19:12:03.917Z] 19:12:03     INFO -      rsp = 0x00007ffed01360f0    r12 = 0x00000000008996e9
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      r13 = 0x00007ffed01360ff    r14 = 0x00000000ffffffff
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      r15 = 0x00007feb2d379240    rip = 0x00007feb12620832
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO - 32  libxul.so!mozilla::AppShutdown::AdvanceShutdownPhaseInternal(mozilla::ShutdownPhase, bool, char16_t const*, nsCOMPtr<nsISupports> const&) [AppShutdown.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 413 + 0x21]
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      rbx = 0x0000000000000008    rbp = 0x00007ffed0136180
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      rsp = 0x00007ffed0136140    r12 = 0x00007ffed01361e0
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      r13 = 0x00007feb2d3b0830    r14 = 0x00007feb2d379240
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -      r15 = 0x00007feb0db021a4    rip = 0x00007feb1249ad8b
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.918Z] 19:12:03     INFO - 33  libxul.so!mozilla::ShutdownXPCOM(nsIServiceManager*) [XPCOMInit.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 583 + 0xe]
[task 2023-01-09T19:12:03.919Z] 19:12:03     INFO -      rbx = 0x00007feb2d3ab408    rbp = 0x00007ffed0136220
[task 2023-01-09T19:12:03.919Z] 19:12:03     INFO -      rsp = 0x00007ffed0136190    r12 = 0x00007ffed01361e0
[task 2023-01-09T19:12:03.919Z] 19:12:03     INFO -      r13 = 0x00007ffed0137628    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.919Z] 19:12:03     INFO -      r15 = 0x00007feb2d379240    rip = 0x00007feb1267cb34
[task 2023-01-09T19:12:03.919Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO - 34  libxul.so!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 680 + 0x5]
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x00007ffed01364d0
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO -      rsp = 0x00007ffed0136230    r12 = 0x00000000000015e0
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO -      r13 = 0x00007ffed0137628    r14 = 0x0000000000000001
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO -      r15 = 0x000000002d3f8701    rip = 0x00007feb1a722dfb
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.920Z] 19:12:03     INFO - 35  firefox-bin!content_process_main [plugin-container.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 57]
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -     Found by: inlining
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO - 36  firefox-bin!main [nsBrowserApp.cpp:05db4ea9cea48f15d06214f0a7b7e7aaec27459e : 359 + 0x23]
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -      rbx = 0x0000000000000012    rbp = 0x00007ffed0137540
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -      rsp = 0x00007ffed01364e0    r12 = 0x00007ffed0137628
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -      r13 = 0x00007ffed0137620    r14 = 0x00007ffed0137628
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -      r15 = 0x00007feb2d3036c0    rip = 0x000055cd8122e989
[task 2023-01-09T19:12:03.921Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO - 37  libc.so.6!__libc_start_main [libc-start.c : 310 + 0x19]
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x000055cd8132d040
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -      rsp = 0x00007ffed0137550    r12 = 0x000055cd8122e290
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -      r13 = 0x00007ffed0137620    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -      r15 = 0x0000000000000000    rip = 0x00007feb2d54ab97
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -     Found by: call frame info
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO - 38  firefox-bin!_start + 0x28
[task 2023-01-09T19:12:03.922Z] 19:12:03     INFO -      rbx = 0x0000000000000000    rbp = 0x0000000000000000
[task 2023-01-09T19:12:03.923Z] 19:12:03     INFO -      rsp = 0x00007ffed0137610    r12 = 0x000055cd8122e290
[task 2023-01-09T19:12:03.923Z] 19:12:03     INFO -      r13 = 0x00007ffed0137620    r14 = 0x0000000000000000
[task 2023-01-09T19:12:03.923Z] 19:12:03     INFO -      r15 = 0x0000000000000000    rip = 0x000055cd8122e2b9
[task 2023-01-09T19:12:03.923Z] 19:12:03     INFO -     Found by: call frame info

Shutdown crash after dom/security/ wpt ran on Linux code coverage.

Crash Signature: [@ arena_t::GetNonFullBinRun(arena_bin_t*)] → [@ arena_t::GetNonFullBinRun]
Summary: Intermittent [Tier-2] Main app process exited normally | application crashed [@ arena_t::GetNonFullBinRun(arena_bin_t*)] → Intermittent [Tier-2] Main app process exited normally | application crashed [@ arena_t::GetNonFullBinRun]

These are shutdown hangs that trigger a crash report that happens to contain arena_t::GetNonFullBinRun in their signature, but that's not where the process is hung. The log from the last intermittent says:

[task 2023-12-15T11:19:20.472Z] 11:19:20     INFO - GECKO(1300) | [Parent 1300, IPC I/O Parent] WARNING: Process 1485 may be hanging at shutdown; will wait for up to 8000ms: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:184
[task 2023-12-15T11:19:28.475Z] 11:19:28     INFO - GECKO(1300) | [Parent 1300, IPC I/O Parent] WARNING: Process 1485 hanging at shutdown; attempting crash report (fatal error).: file /builds/worker/checkouts/gecko/ipc/chromium/src/chrome/common/process_watcher_posix_sigchld.cc:207
[task 2023-12-15T11:19:28.560Z] 11:19:28     INFO - GECKO(1300) | [Parent 1300, IPC I/O Parent] WARNING: process 1485 exited on signal 6: file /builds/worker/checkouts/gecko/ipc/chromium/src/base/process_util_posix.cc:265

In case that helps, these are the last log entries from the process that was hung and killed:

[task 2023-12-15T11:18:55.386Z] 11:18:55     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/base/GlobalTeardownObserver.cpp:51
[task 2023-12-15T11:18:55.442Z] 11:18:55     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/base/GlobalTeardownObserver.cpp:51
[task 2023-12-15T11:18:55.665Z] 11:18:55     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/checkouts/gecko/dom/base/GlobalTeardownObserver.cpp:51
[task 2023-12-15T11:18:58.682Z] 11:18:58     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PWindowGlobal::Msg_UpdateBFCacheStatus' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:02.847Z] 11:19:02     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1227
[task 2023-12-15T11:19:03.432Z] 11:19:03     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_INVALID_ARG) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/intl/l10n/L10nRegistry.cpp:385
[task 2023-12-15T11:19:03.434Z] 11:19:03     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_INVALID_ARG) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/intl/l10n/L10nRegistry.cpp:385
[task 2023-12-15T11:19:03.801Z] 11:19:03     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: '!tsi', file /builds/worker/checkouts/gecko/dom/base/Document.cpp:1630
[task 2023-12-15T11:19:03.890Z] 11:19:03     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: '!tsi', file /builds/worker/checkouts/gecko/dom/base/Document.cpp:1630
[task 2023-12-15T11:19:04.742Z] 11:19:04     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: JSWindowActorChild::SendRawMessage (Interactions, Interactions:PageHide) not sent: !CanSend() || !mManager || !mManager->CanSend(): file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:61
[task 2023-12-15T11:19:05.036Z] 11:19:05     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PWindowGlobal::Msg_UpdateBFCacheStatus' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:05.052Z] 11:19:05     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:163
[task 2023-12-15T11:19:05.053Z] 11:19:05     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PWindowGlobal::Msg_UpdateDocumentHasLoaded' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:05.345Z] 11:19:05     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PSessionStore::Msg_SessionStoreUpdate' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:07.801Z] 11:19:07     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PSessionStore::Msg_SessionStoreUpdate' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:07.802Z] 11:19:07     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PContent::Msg_AccumulateChildHistograms' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:07.803Z] 11:19:07     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: '!ipcActor->SendAccumulateChildHistograms(histogramsToSend)', file /builds/worker/checkouts/gecko/toolkit/components/telemetry/core/ipc/TelemetryIPCAccumulator.cpp:278
[task 2023-12-15T11:19:07.803Z] 11:19:07     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: IPC message 'PContent::Msg_RecordDiscardedData' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:545
[task 2023-12-15T11:19:07.804Z] 11:19:07     INFO - GECKO(1300) | [Child 1485, Main Thread] WARNING: '!ipcActor->SendRecordDiscardedData(discardedData)', file /builds/worker/checkouts/gecko/toolkit/components/telemetry/core/ipc/TelemetryIPCAccumulator.cpp:297
Component: Memory Allocator → Untriaged
Product: Core → Firefox

Moving this over to a potential component as I am not sure where this would fit best. If this is not the right, please change to a more suitable one.
Thanks!

QA Whiteboard: [qa-not-actionable]
Component: Untriaged → DOM: Security
Product: Firefox → Core

I think this is either in necko or the HTML parser, given the stacks I can see. Hope I find the right component this time...

Component: DOM: Security → Networking

I think this may have been fixed by bug 1870499

Severity: -- → S3
QA Whiteboard: [qa-not-actionable] → [qa-not-actionable][necko-monitor]
Priority: -- → P3
See Also: → 1870499
QA Whiteboard: [qa-not-actionable][necko-monitor] → [qa-not-actionable][necko-triaged][necko-monitor]
Status: NEW → RESOLVED
Closed: 10 months ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 10 months ago3 months ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.