rr icon indicating copy to clipboard operation
rr copied to clipboard

FATAL src/ReplaySession.cc:793:guard_overshoot()

Open tysmith opened this issue 1 year ago • 3 comments

[FATAL src/ReplaySession.cc:793:guard_overshoot()]
 (task 122213 (rec:118672) at time 88305)
 -> Assertion `false' failed to hold. overshot target ticks=563234366 by 6; target registers mismatched: replay != rec: rax 0x1 != 0x4a0bf159e0dd0001, rcx 0x55acfd4a5390 != 0x4a0bf159e0dd0000, rdx 0x55acfd48e110 != (nil), rsi 0x3 != 0xffff, rbp 0x7f7f2bbf3f30 != 0x7f7f2bbf4200, r8 0xbff452f2 != 0x7f7f2bbf4268
Tail of trace dump:
{
  real_time:140125.795899 global_time:88285, event:`SYSCALLBUF_FLUSH' tid:118525, ticks:478374
  { syscall:'recvmsg', ret:0x20, size:0xf8, desched:1 }
  { syscall:'sendmsg', ret:0x20, size:0x10, desched:1 }
}
{
  real_time:140125.795902 global_time:88286, event:`SYSCALL: ioctl' (state:ENTERING_SYSCALL) tid:118525, ticks:478374
rax:0xffffffffffffffda rbx:0x7f7f8e3ff640 rcx:0xffffffffffffffff rdx:0x7f7f8e3fed10 rsi:0x541b rdi:0xe rbp:0x7f7f8e3fed20 rsp:0x7f7f8e3fec80 r8:0x7f7f58000bf0 r9:0x7f7f58155010 r10:0x7f7f58155000 r11:0x246 r12:0x7f7f8e3ff640 r13:0x0 r14:0x7f7f8e4947d0 r15:0x7ffc4e09cd20 rip:0x7f7f8e51a94f eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0x10 fs_base:0x7f7f8e3ff640 gs_base:0x0
}
{
  real_time:140125.795904 global_time:88287, event:`SYSCALLBUF_RESET' tid:118525, ticks:478374
}
{
  real_time:140125.795926 global_time:88288, event:`SYSCALL: ioctl' (state:EXITING_SYSCALL) tid:118525, ticks:478374
rax:0x0 rbx:0x7f7f8e3ff640 rcx:0xffffffffffffffff rdx:0x7f7f8e3fed10 rsi:0x541b rdi:0xe rbp:0x7f7f8e3fed20 rsp:0x7f7f8e3fec80 r8:0x7f7f58000bf0 r9:0x7f7f58155010 r10:0x7f7f58155000 r11:0x246 r12:0x7f7f8e3ff640 r13:0x0 r14:0x7f7f8e4947d0 r15:0x7ffc4e09cd20 rip:0x7f7f8e51a94f eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0x10 fs_base:0x7f7f8e3ff640 gs_base:0x0
  { tid:118525, addr:0x7f7f8e3fed10, length:0x4 }
}
{
  real_time:140125.795958 global_time:88289, event:`SYSCALLBUF_FLUSH' tid:118525, ticks:478453
  { syscall:'poll', ret:0x0, size:0x28 }
}
{
  real_time:140125.795966 global_time:88290, event:`SYSCALL: poll' (state:ENTERING_SYSCALL) tid:118525, ticks:478453
rax:0xffffffffffffffda rbx:0x7f7f661fffa0 rcx:0xffffffffffffffff rdx:0x7530 rsi:0x3 rdi:0x7f7f8e3fecc0 rbp:0x7f7f8e3fedc0 rsp:0x7f7f661ffdf0 r8:0x0 r9:0x7f7f58155010 r10:0x7f7f58155000 r11:0x246 r12:0x7f7f8e3ff640 r13:0x0 r14:0x7f7f8e4947d0 r15:0x7ffc4e09cd20 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0x7 fs_base:0x7f7f8e3ff640 gs_base:0x0
}
{
  real_time:140125.795968 global_time:88291, event:`SYSCALLBUF_RESET' tid:118525, ticks:478453
}
{
  real_time:140125.795986 global_time:88292, event:`SYSCALL: futex' (state:EXITING_SYSCALL) tid:118621, ticks:3566873
rax:0x0 rbx:0x7f7f2fffcfa0 rcx:0xffffffffffffffff rdx:0x0 rsi:0x189 rdi:0x55acfbd131f4 rbp:0x55acfbd131c8 rsp:0x7f7f2fffcdf0 r8:0x0 r9:0xffffffff r10:0x0 r11:0x246 r12:0x0 r13:0x0 r14:0x42f r15:0x55acfbd131f4 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f307fd640 gs_base:0x0
}
{
  real_time:140125.796057 global_time:88293, event:`SYSCALLBUF_FLUSH' tid:118621, ticks:3567964
  { syscall:'futex', ret:0x0, size:0x14 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
}
{
  real_time:140125.796062 global_time:88294, event:`SYSCALL: futex' (state:ENTERING_SYSCALL) tid:118621, ticks:3567964
rax:0xffffffffffffffda rbx:0x7f7f2fffcfa0 rcx:0xffffffffffffffff rdx:0x0 rsi:0x189 rdi:0x55acfbd131f0 rbp:0x55acfbd131c8 rsp:0x7f7f2fffcdf0 r8:0x0 r9:0xffffffff r10:0x0 r11:0x246 r12:0x0 r13:0x0 r14:0x430 r15:0x55acfbd131f0 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f307fd640 gs_base:0x0
}
{
  real_time:140125.796064 global_time:88295, event:`SYSCALLBUF_RESET' tid:118621, ticks:3567964
}
{
  real_time:140125.796082 global_time:88296, event:`SYSCALL: sched_yield' (state:EXITING_SYSCALL) tid:118801, ticks:63509819
rax:0x0 rbx:0x7f7f716c13c0 rcx:0xffffffffffffffff rdx:0xff031002200000d7 rsi:0x3fbfbfc802a1e1 rdi:0x55acf9cd2400 rbp:0x7f7f261e78e0 rsp:0x7f7f261e7898 r8:0x0 r9:0x0 r10:0x0 r11:0x246 r12:0x7f7f261ea6e8 r13:0x7f7f83e29d28 r14:0x7f7f83e2aab8 r15:0x7f7f60008ac0 rip:0x7f7f8eaca1ab eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0x18 fs_base:0x7f7f261ec640 gs_base:0x0
}
{
  real_time:140125.796145 global_time:88297, event:`SYSCALL: sched_yield' (state:ENTERING_SYSCALL) tid:118801, ticks:63509849
rax:0xffffffffffffffda rbx:0x7f7f716c13c0 rcx:0xffffffffffffffff rdx:0xff031002200000d7 rsi:0x3fbfbfc802a1e1 rdi:0x55acf9cd2400 rbp:0x7f7f261e78e0 rsp:0x7f7f261e7898 r8:0x0 r9:0x0 r10:0x0 r11:0x246 r12:0x7f7f261ea6e8 r13:0x7f7f83e29d28 r14:0x7f7f83e2aab8 r15:0x7f7f60008ac0 rip:0x7f7f8eaca1ab eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0x18 fs_base:0x7f7f261ec640 gs_base:0x0
}
{
  real_time:140125.796165 global_time:88298, event:`SYSCALL: futex' (state:EXITING_SYSCALL) tid:118618, ticks:173101184
rax:0xfffffffffffffff5 rbx:0x7f7f34ffefa0 rcx:0xffffffffffffffff rdx:0x17e rsi:0x89 rdi:0x7f7f60006d80 rbp:0x17e rsp:0x7f7f34ffedf0 r8:0x0 r9:0xffc41c0affffffff r10:0x0 r11:0x246 r12:0x7f7f8e51e870 r13:0x7f7f8e42a250 r14:0x7f7f60006d80 r15:0x7f7f31bfbbb8 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f31bff640 gs_base:0x0
}
{
  real_time:140125.796486 global_time:88299, event:`SYSCALLBUF_FLUSH' tid:118618, ticks:173109543
  { syscall:'sendmsg', ret:0x34, size:0x10, desched:1 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'futex', ret:0x1, size:0x14 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
}
{
  real_time:140125.796492 global_time:88300, event:`SYSCALL: futex' (state:ENTERING_SYSCALL) tid:118618, ticks:173109543
rax:0xffffffffffffffda rbx:0x7f7f34ffefa0 rcx:0xffffffffffffffff rdx:0x0 rsi:0x189 rdi:0x55acfa65feb0 rbp:0x55acfa65fe88 rsp:0x7f7f34ffedf0 r8:0x0 r9:0xffffffff r10:0x0 r11:0x246 r12:0x0 r13:0x0 r14:0x15c r15:0x55acfa65feb0 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f31bff640 gs_base:0x0
}
{
  real_time:140125.796495 global_time:88301, event:`SYSCALLBUF_RESET' tid:118618, ticks:173109543
}
{
  real_time:140125.796557 global_time:88302, event:`SYSCALL: futex' (state:EXITING_SYSCALL) tid:118629, ticks:319135
rax:0xfffffffffffffe00 rbx:0x7f7f2d5f8fa0 rcx:0xffffffffffffffff rdx:0x0 rsi:0x189 rdi:0x55acfc5ad2a4 rbp:0x55acfc5ad278 rsp:0x7f7f2d5f8df0 r8:0x0 r9:0xffffffff r10:0x0 r11:0x246 r12:0x0 r13:0x0 r14:0x7 r15:0x55acfc5ad2a4 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f2d3f8640 gs_base:0x0
}
{
  real_time:140125.796592 global_time:88303, event:`SYSCALL: restart_syscall' (state:ENTERING_SYSCALL) tid:118629, ticks:319135
rax:0xffffffffffffffda rbx:0x7f7f2d5f8fa0 rcx:0xffffffffffffffff rdx:0x0 rsi:0x189 rdi:0x55acfc5ad2a4 rbp:0x55acfc5ad278 rsp:0x7f7f2d5f8df0 r8:0x0 r9:0xffffffff r10:0x0 r11:0x246 r12:0x0 r13:0x0 r14:0x7 r15:0x55acfc5ad2a4 rip:0x70000002 eflags:0x246 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xca fs_base:0x7f7f2d3f8640 gs_base:0x0
}
{
  real_time:140125.799516 global_time:88304, event:`SYSCALLBUF_FLUSH' tid:118672, ticks:563234366
  { syscall:'clock_gettime', ret:0x0, size:0x20 }
  { syscall:'futex', ret:0x1, size:0x14 }
}
{
  real_time:140125.799522 global_time:88305, event:`SCHED' tid:118672, ticks:563234366
rax:0x4a0bf159e0dd0001 rbx:0x7f7f2bbf6640 rcx:0x4a0bf159e0dd0000 rdx:0x0 rsi:0xffff rdi:0x1 rbp:0x7f7f2bbf4200 rsp:0x7f7f2bbf4200 r8:0x7f7f2bbf4268 r9:0x55acffad4610 r10:0x7f7f8e61b150 r11:0x7f7f8e61ace0 r12:0x7f7f2bbf6640 r13:0x0 r14:0x7f7f8e4947d0 r15:0x7ffc4e094200 rip:0x7f7f6e8db4ef eflags:0x202 cs:0x33 ss:0x2b ds:0x0 es:0x0 fs:0x0 gs:0x0 orig_rax:0xffffffffffffffff fs_base:0x7f7f2bbf6640 gs_base:0x0
}
{
  real_time:140125.799525 global_time:88306, event:`SYSCALLBUF_RESET' tid:118672, ticks:563234366
}
=== Start rr backtrace:
rr(_ZN2rr9GdbServer15emergency_debugEPNS_4TaskE+0x12a)[0x5557d9c8c0ba]
rr(+0xccb8a)[0x5557d9c9fb8a]
rr(+0xcd8bf)[0x5557d9ca08bf]
rr(+0xcd8f9)[0x5557d9ca08f9]
rr(+0x15e7b9)[0x5557d9d317b9]
rr(_ZN2rr13ReplaySession20emulate_async_signalEPNS_10ReplayTaskERKNS0_15StepConstraintsElNS_15remote_code_ptrE+0x628)[0x5557d9d36958]
rr(_ZN2rr13ReplaySession18try_one_trace_stepEPNS_10ReplayTaskERKNS0_15StepConstraintsE+0x291)[0x5557d9d3a581]
rr(_ZN2rr13ReplaySession11replay_stepERKNS0_15StepConstraintsE+0x17f)[0x5557d9d407af]
rr(+0x15aed6)[0x5557d9d2ded6]
rr(_ZN2rr13ReplayCommand3runERSt6vectorINSt7__cxx1112basic_stringIcSt11char_traitsIcESaIcEEESaIS7_EE+0x64a)[0x5557d9d2ee0a]
rr(main+0x1a1)[0x5557d9c21431]
/lib/x86_64-linux-gnu/libc.so.6(+0x29d90)[0x7ff73e629d90]
/lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0x80)[0x7ff73e629e40]
rr(_start+0x25)[0x5557d9c23f55]
=== End rr backtrace

tysmith avatar Feb 06 '24 01:02 tysmith

what is the gdb stack trace for thread 118672:

(gdb) bt
#0  0x00007f7f6e8db4ef in MOZ_AssertAssignmentTest (exprResult=true) at /builds/worker/workspace/obj-build/dist/include/mozilla/StaticAnalysisFunctions.h:59
#1  0x00007f7f6e9112f3 in js::gc::IsInsideNursery (cell=0x21f011074740) at /builds/worker/workspace/obj-build/dist/include/js/HeapAPI.h:597
#2  0x00007f7f7badeac5 in js::gc::Cell::isTenured (this=0x21f011074740) at /builds/worker/checkouts/gecko/js/src/gc/Cell.h:156
#3  0x00007f7f7c9e37f9 in js::gc::Cell::isAligned (this=0x21f011074740) at /builds/worker/checkouts/gecko/js/src/gc/Cell.h:598
#4  0x00007f7f7c9e4f0d in js::CheckTracedThing<JSString> (trc=0x7f7f2bbf4290, thing=0x21f011074740) at /builds/worker/checkouts/gecko/js/src/gc/Marking.cpp:175
#5  0x00007f7f7baf07f4 in js::gc::TraceEdgeInternal (trc=0x7f7f2bbf4290, thingp=0x7f7f2bbf4070, String=0x7f7f66b3e2f0 "scope name") at /builds/worker/checkouts/gecko/js/src/gc/Tracer.h:109
#6  0x00007f7f7bd58ec5 in js::TraceManuallyBarrieredEdge<JSAtom*> (trc=0x7f7f2bbf4290, thingp=0x7f7f2bbf4070, name=0x7f7f66b3e2f0 "scope name")
    at /builds/worker/checkouts/gecko/js/src/gc/Tracer.h:252
#7  0x00007f7f7c14694d in js::TraceBindingNames (trc=0x7f7f2bbf4290, names=0x55acfd831f60, length=2) at /builds/worker/checkouts/gecko/js/src/vm/Scope.h:200
#8  0x00007f7f7c150057 in js::RuntimeScopeData<js::LexicalScope::SlotInfo>::trace (this=0x55acfd831f50, trc=0x7f7f2bbf4290)
    at /builds/worker/checkouts/gecko/js/src/gc/TraceMethods-inl.h:183
#9  0x00007f7f7c9a24e0 in js::Scope::traceChildren(JSTracer*)::{lambda(auto:1)#1}::operator()<js::RuntimeScopeData<js::LexicalScope::SlotInfo>*>(js::RuntimeScopeData<js::LexicalScope::SlotInfo>*) const (this=0x7f7f2bbf4180, data=0x55acfd831f50) at /builds/worker/checkouts/gecko/js/src/gc/TraceMethods-inl.h:203
#10 0x00007f7f7c9a2309 in js::Scope::applyScopeDataTyped<js::Scope::traceChildren(JSTracer*)::{lambda(auto:1)#1}>(js::Scope::traceChildren(JSTracer*)::{lambda(auto:1)#1}&&) (
    this=0x21f0110090a0, f=...) at /builds/worker/checkouts/gecko/js/src/vm/Scope.h:1160
#11 0x00007f7f7c9a21d6 in js::Scope::traceChildren (this=0x21f0110090a0, trc=0x7f7f2bbf4290) at /builds/worker/checkouts/gecko/js/src/gc/TraceMethods-inl.h:203
#12 0x00007f7f7cad1fde in JS::TraceChildren(JSTracer*, JS::GCCellPtr)::$_0::operator()<js::Scope*>(js::Scope*) const (this=0x7f7f2bbf4248, t=0x21f0110090a0)
    at /builds/worker/checkouts/gecko/js/src/gc/Tracer.cpp:62
#13 0x00007f7f7cad1c59 in JS::MapGCThingTyped<JS::TraceChildren(JSTracer*, JS::GCCellPtr)::$_0>(void*, JS::TraceKind, JS::TraceChildren(JSTracer*, JS::GCCellPtr)::$_0&&) (
    thing=0x21f0110090a0, traceKind=JS::TraceKind::Scope, f=...) at /builds/worker/workspace/obj-build/dist/include/js/TraceKind.h:253
#14 0x00007f7f7ca9a7b3 in JS::ApplyGCThingTyped<JS::TraceChildren(JSTracer*, JS::GCCellPtr)::$_0>(void*, JS::TraceKind, JS::TraceChildren(JSTracer*, JS::GCCellPtr)::$_0&&) (
    thing=0x21f0110090a0, traceKind=JS::TraceKind::Scope, f=...) at /builds/worker/workspace/obj-build/dist/include/js/TraceKind.h:268
#15 0x00007f7f7ca9a76e in JS::TraceChildren (trc=0x7f7f2bbf4290, thing=...) at /builds/worker/checkouts/gecko/js/src/gc/Tracer.cpp:59
#16 0x00007f7f6e8efe00 in mozilla::CycleCollectedJSRuntime::NoteGCThingJSChildren (this=0x55acfd4b0670, aThing=..., aCb=...)
    at /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSRuntime.cpp:846
#17 0x00007f7f6e8ea7b7 in mozilla::CycleCollectedJSRuntime::TraverseGCThing (this=0x55acfd4b0670, aTs=mozilla::CycleCollectedJSRuntime::TRAVERSE_FULL, aThing=..., aCb=...)
    at /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSRuntime.cpp:918
#18 0x00007f7f6e8ea699 in mozilla::JSGCThingParticipant::TraverseNative (this=0x55acfd4b0680, aPtr=0x21f0110090a0, aCb=...)
    at /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSRuntime.cpp:371
#19 0x00007f7f6e94ba9d in nsCycleCollectionParticipant::TraverseNativeAndJS (this=0x55acfd4b0680, aPtr=0x21f0110090a0, aCb=...)
    at /builds/worker/workspace/obj-build/dist/include/nsCycleCollectionParticipant.h:228
#20 0x00007f7f6e94b6c3 in CCGraphBuilder::BuildGraph (this=0x55acfe285d90, aBudget=...) at /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:2098
#21 0x00007f7f6e94f9e3 in nsCycleCollector::MarkRoots (this=0x55acfd4937e0, aBudget=...) at /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:2715
#22 0x00007f7f6e9541a9 in nsCycleCollector::Collect (this=0x55acfd4937e0, aReason=mozilla::CCReason::GC_FINISHED, aIsManual=CCIsManual, aBudget=..., aManualListener=0x0,
    aPreferShorterSlices=false) at /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3475
#23 0x00007f7f6e957c3b in nsCycleCollector_collect (aReason=mozilla::CCReason::GC_FINISHED, aManualListener=0x0) at /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3982
#24 0x00007f7f76fc2866 in mozilla::dom::workerinternals::(anonymous namespace)::WorkerJSRuntime::CustomGCCallback (this=0x55acfd4b0670, aStatus=JSGC_END)
    at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:820
#25 0x00007f7f6e8f0fca in mozilla::CycleCollectedJSRuntime::OnGC (this=0x55acfd4b0670, aContext=0x55acfd4a5390, aStatus=JSGC_END, aReason=JS::GCReason::DOM_WORKER)
    at /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSRuntime.cpp:1853
#26 0x00007f7f6e8ee270 in mozilla::CycleCollectedJSRuntime::GCCallback (aContext=0x55acfd4a5390, aStatus=JSGC_END, aReason=JS::GCReason::DOM_WORKER, aData=0x55acfd4b0670)
    at /builds/worker/checkouts/gecko/xpcom/base/CycleCollectedJSRuntime.cpp:1037
#27 0x00007f7f7c9806e3 in js::gc::GCRuntime::callGCCallback (this=0x55acfd49b708, status=JSGC_END, reason=JS::GCReason::DOM_WORKER) at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:1435
#28 0x00007f7f7c9944ea in js::gc::GCRuntime::maybeCallGCCallback (this=0x55acfd49b708, status=JSGC_END, reason=JS::GCReason::DOM_WORKER)
    at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:4159
#29 0x00007f7f7c995510 in js::gc::AutoCallGCCallbacks::~AutoCallGCCallbacks (this=0x7f7f2bbf4848) at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:4132
--Type <RET> for more, q to quit, c to continue without paging--c
#30 0x00007f7f7c994dab in js::gc::GCRuntime::gcCycle (this=0x55acfd49b708, nonincrementalByAPI=true, budgetArg=..., reason=JS::GCReason::DOM_WORKER) at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:4249
#31 0x00007f7f7c995f0d in js::gc::GCRuntime::collect (this=0x55acfd49b708, nonincrementalByAPI=true, budget=..., reason=JS::GCReason::DOM_WORKER) at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:4434
#32 0x00007f7f7c963cb2 in js::gc::GCRuntime::gc (this=0x55acfd49b708, options=JS::GCOptions::Normal, reason=JS::GCReason::DOM_WORKER) at /builds/worker/checkouts/gecko/js/src/gc/GC.cpp:4511
#33 0x00007f7f7c9d6dda in JS::NonIncrementalGC (cx=0x55acfd4a5390, options=JS::GCOptions::Normal, reason=JS::GCReason::DOM_WORKER) at /builds/worker/checkouts/gecko/js/src/gc/GCAPI.cpp:298
#34 0x00007f7f76ff56e6 in mozilla::dom::WorkerPrivate::GarbageCollectInternal (this=0x55acfb3c5a00, aCx=0x55acfd4a5390, aShrinking=true, aCollectChildren=false) at /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:5574
#35 0x00007f7f76ff92cd in mozilla::dom::(anonymous namespace)::IdleGCTimerCallback (aTimer=0x55acfca7f2d0, aClosure=0x55acfb3c5a00) at /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:657
#36 0x00007f7f6eb4c548 in nsTimerImpl::Fire(int)::$_3::operator()(nsTimerImpl::FuncCallback const&) const (this=0x7f7f2bbf4d10, f=...) at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:681
#37 0x00007f7f6eb4c4c7 in mozilla::detail::VariantImplementation<unsigned char, 3ul, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) (aV=..., aMi=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:309
#38 0x00007f7f6eb4c291 in mozilla::detail::VariantImplementation<unsigned char, 2ul, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_2, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_2&&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) (aV=..., aMi=..., aMs=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318
#39 0x00007f7f6eb4c109 in mozilla::detail::VariantImplementation<unsigned char, 1ul, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_1, nsTimerImpl::Fire(int)::$_2, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_1&&, nsTimerImpl::Fire(int)::$_2&&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) (aV=..., aMi=..., aMs=..., aMs=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318
#40 0x00007f7f6eb4bfc1 in mozilla::detail::VariantImplementation<unsigned char, 0ul, nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_0, nsTimerImpl::Fire(int)::$_1, nsTimerImpl::Fire(int)::$_2, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_0&&, nsTimerImpl::Fire(int)::$_1&&, nsTimerImpl::Fire(int)::$_2&&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) (aV=..., aMi=..., aMs=..., aMs=..., aMs=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:318
#41 0x00007f7f6eb4bf3d in mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::matchN<mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_0, nsTimerImpl::Fire(int)::$_1, nsTimerImpl::Fire(int)::$_2, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>&, nsTimerImpl::Fire(int)::$_0&&, nsTimerImpl::Fire(int)::$_1&&, nsTimerImpl::Fire(int)::$_2&&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) (aVariant=..., aM0=..., aM1=..., aMs=..., aMs=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:902
#42 0x00007f7f6eb4560d in mozilla::Variant<nsTimerImpl::UnknownCallback, nsCOMPtr<nsITimerCallback>, nsCOMPtr<nsIObserver>, nsTimerImpl::FuncCallback, nsTimerImpl::ClosureCallback>::match<nsTimerImpl::Fire(int)::$_0, nsTimerImpl::Fire(int)::$_1, nsTimerImpl::Fire(int)::$_2, nsTimerImpl::Fire(int)::$_3, nsTimerImpl::Fire(int)::$_4>(nsTimerImpl::Fire(int)::$_0&&, nsTimerImpl::Fire(int)::$_1&&, nsTimerImpl::Fire(int)::$_2&&, nsTimerImpl::Fire(int)::$_3&&, nsTimerImpl::Fire(int)::$_4&&) & (this=0x7f7f2bbf4d78, aM0=..., aM1=..., aMs=..., aMs=..., aMs=...) at /builds/worker/workspace/obj-build/dist/include/mozilla/Variant.h:857
#43 0x00007f7f6eb1ed1e in nsTimerImpl::Fire (this=0x55acfd2511b0, aGeneration=13) at /builds/worker/checkouts/gecko/xpcom/threads/nsTimerImpl.cpp:675
#44 0x00007f7f6eb1e3a5 in nsTimerEvent::Run (this=0x7f7f3c0066e0) at /builds/worker/checkouts/gecko/xpcom/threads/TimerThread.cpp:515
#45 0x00007f7f76fd1e6a in mozilla::dom::(anonymous namespace)::WrappedControlRunnable::WorkerRun (this=0x7f7f3c151380, aCx=0x55acfd4a5390, aWorkerPrivate=0x55acfb3c5a00) at /builds/worker/checkouts/gecko/dom/workers/WorkerEventTarget.cpp:52
#46 0x00007f7f7700ae01 in mozilla::dom::WorkerRunnable::Run (this=0x7f7f3c151380) at /builds/worker/checkouts/gecko/dom/workers/WorkerRunnable.cpp:378
#47 0x00007f7f76ff5c12 in mozilla::dom::WorkerPrivate::ProcessAllControlRunnablesLocked (this=0x55acfb3c5a00) at /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:4014
#48 0x00007f7f76ff48f9 in mozilla::dom::WorkerPrivate::DoRunLoop (this=0x55acfb3c5a00, aCx=0x55acfd4a5390) at /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp:3256
#49 0x00007f7f76fc0bb0 in mozilla::dom::workerinternals::(anonymous namespace)::WorkerThreadPrimaryRunnable::Run (this=0x55acfd490ad0) at /builds/worker/checkouts/gecko/dom/workers/RuntimeService.cpp:2108
#50 0x00007f7f6eb2f2b8 in nsThread::ProcessNextEvent (this=0x55acfd3194d0, aMayWait=true, aResult=0x7f7f2bbf58f7) at /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:1193
#51 0x00007f7f6eb37886 in NS_ProcessNextEvent (aThread=0x55acfd3194d0, aMayWait=true) at /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:480
#52 0x00007f7f701047eb in mozilla::ipc::MessagePumpForNonMainThreads::Run (this=0x55acfd48f830, aDelegate=0x7f7f2bbf5be8) at /builds/worker/checkouts/gecko/ipc/glue/MessagePump.cpp:330
#53 0x00007f7f6ff65bc8 in MessageLoop::RunInternal (this=0x7f7f2bbf5be8) at /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:370
#54 0x00007f7f6ff65b45 in MessageLoop::RunHandler (this=0x7f7f2bbf5be8) at /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:363
#55 0x00007f7f6ff65b00 in MessageLoop::Run (this=0x7f7f2bbf5be8) at /builds/worker/checkouts/gecko/ipc/chromium/src/base/message_loop.cc:345
#56 0x00007f7f6eb293f6 in nsThread::ThreadFunc (aArg=0x55acfd48df60) at /builds/worker/checkouts/gecko/xpcom/threads/nsThread.cpp:370
#57 0x00007f7f8e711956 in _pt_root (arg=0x55acfd48df80) at /builds/worker/checkouts/gecko/nsprpub/pr/src/pthreads/ptthread.c:201
#58 0x00007f7f8e494ac3 in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:442
#59 0x00007f7f8e525a04 in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:100

tysmith avatar Feb 06 '24 01:02 tysmith

Can you re-record that, and if you do, does it still fail to replay?

Yes I was able to re-record with the (latest rr commit) and replay successfully.

tysmith avatar Feb 06 '24 01:02 tysmith

Unfortunately, given re-recording doesn't reproduce the bug, we don't have much to go on here. The failing thread is doing GC and presumably some state it touches has diverged, but we don't know which state.

rocallahan avatar Feb 06 '24 09:02 rocallahan