Closed Bug 1763842 Opened 3 years ago Closed 3 years ago

Intermittent [tier 2] toolkit/components/extensions/test/xpcshell/<test_name>.js | application crashed [@ NS_DispatchToMainThread(already_AddRefed<nsIRunnable>&&, unsigned int)]

Categories

(WebExtensions :: General, defect)

defect

Tracking

(firefox-esr91 unaffected, firefox99 unaffected, firefox100 unaffected, firefox101 affected)

RESOLVED DUPLICATE of bug 1762638
Tracking Status
firefox-esr91 --- unaffected
firefox99 --- unaffected
firefox100 --- unaffected
firefox101 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

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

Crash Data

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


[task 2022-04-08T16:28:57.701Z] 16:28:57     INFO -  TEST-START | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_privacy.js
[task 2022-04-08T16:28:59.981Z] 16:28:59  WARNING -  PROCESS-CRASH | xpcshell-remote.ini:toolkit/components/extensions/test/xpcshell/test_ext_contentscript_css.js | application crashed [@ NS_DispatchToMainThread(already_AddRefed<nsIRunnable>&&, unsigned int)]
[task 2022-04-08T16:28:59.982Z] 16:28:59     INFO -  Crash dump filename: /var/folders/4n/2fxfks050t51m97r3t99d6wc000014/T/xpc-other-zn6yklrg/71533FF3-2999-4468-A744-6BC4B403158E.dmp
[task 2022-04-08T16:28:59.982Z] 16:28:59     INFO -  Operating system: Mac OS X
[task 2022-04-08T16:28:59.982Z] 16:28:59     INFO -                    10.15.7 19H524
[task 2022-04-08T16:28:59.982Z] 16:28:59     INFO -  CPU: amd64
[task 2022-04-08T16:28:59.983Z] 16:28:59     INFO -       family 6 model 158 stepping 10
[task 2022-04-08T16:28:59.983Z] 16:28:59     INFO -       12 CPUs
[task 2022-04-08T16:28:59.983Z] 16:28:59     INFO -  Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2022-04-08T16:28:59.983Z] 16:28:59     INFO -  Crash address: 0x0
[task 2022-04-08T16:28:59.984Z] 16:28:59     INFO -  Mac Crash Info:
[task 2022-04-08T16:28:59.984Z] 16:28:59     INFO -  Process uptime: 29 seconds
[task 2022-04-08T16:28:59.984Z] 16:28:59     INFO -  Thread 7 StyleThread#0 (crashed)
[task 2022-04-08T16:28:59.985Z] 16:28:59     INFO -   0  XUL!NS_DebugBreak [nsDebugImpl.cpp:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 399 + 0x43]
[task 2022-04-08T16:28:59.985Z] 16:28:59     INFO -       rax = 0x000000010b84d3e8    rdx = 0x0000000000000000
[task 2022-04-08T16:28:59.985Z] 16:28:59     INFO -       rcx = 0x000070000cc690ac    rbx = 0x00007ffee47c0db6
[task 2022-04-08T16:28:59.986Z] 16:28:59     INFO -       rsi = 0x00000000000120a8    rdi = 0x00007fff8e907ca8
[task 2022-04-08T16:28:59.986Z] 16:28:59     INFO -       rbp = 0x000070000cc68880    rsp = 0x000070000cc68200
[task 2022-04-08T16:28:59.986Z] 16:28:59     INFO -        r8 = 0x00000000000130a8     r9 = 0x0000000000000000
[task 2022-04-08T16:28:59.987Z] 16:28:59     INFO -       r10 = 0x00007fff8e907cc8    r11 = 0x00007fff8e907cc0
[task 2022-04-08T16:28:59.987Z] 16:28:59     INFO -       r12 = 0x0000000000000000    r13 = 0x000000011eecdfd8
[task 2022-04-08T16:28:59.987Z] 16:28:59     INFO -       r14 = 0x000070000cc68240    r15 = 0x000070000cc68550
[task 2022-04-08T16:28:59.987Z] 16:28:59     INFO -       rip = 0x00000001153b44f4
[task 2022-04-08T16:28:59.988Z] 16:28:59     INFO -      Found by: given as instruction pointer in context
[task 2022-04-08T16:28:59.988Z] 16:28:59     INFO -   1  XUL!NS_DispatchToMainThread(already_AddRefed<nsIRunnable>&&, unsigned int) [nsThreadUtils.cpp:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 221 + 0x20]
[task 2022-04-08T16:28:59.988Z] 16:28:59     INFO -       rbx = 0x00000000c1f30001    rbp = 0x000070000cc688d0
[task 2022-04-08T16:28:59.989Z] 16:28:59     INFO -       rsp = 0x000070000cc68890    r12 = 0x000000010bafe730
[task 2022-04-08T16:28:59.989Z] 16:28:59     INFO -       r13 = 0x0000000113fab548    r14 = 0x000000011eecdfd8
[task 2022-04-08T16:28:59.989Z] 16:28:59     INFO -       r15 = 0x000000011440d0c0    rip = 0x00000001154ecee4
[task 2022-04-08T16:28:59.990Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:28:59.990Z] 16:28:59     INFO -   2  XUL!Gecko_StyleSheet_FinishAsyncParse [GeckoBindings.cpp:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 1448 + 0x76]
[task 2022-04-08T16:28:59.990Z] 16:28:59     INFO -       rbx = 0x000000011440d0c0    rbp = 0x000070000cc68910
[task 2022-04-08T16:28:59.991Z] 16:28:59     INFO -       rsp = 0x000070000cc688e0    r12 = 0x000000010bafe730
[task 2022-04-08T16:28:59.991Z] 16:28:59     INFO -       r13 = 0x0000000113fab548    r14 = 0x0000000000000000
[task 2022-04-08T16:28:59.991Z] 16:28:59     INFO -       r15 = 0x000000011440e028    rip = 0x000000011991f9b1
[task 2022-04-08T16:28:59.992Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:28:59.992Z] 16:28:59     INFO -   3  XUL!geckoservo::stylesheet_loader::AsyncStylesheetParser::parse [stylesheet_loader.rs:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 147 + 0x7]
[task 2022-04-08T16:28:59.992Z] 16:28:59     INFO -       rbx = 0x0000000000000000    rbp = 0x000070000cc689c0
[task 2022-04-08T16:28:59.993Z] 16:28:59     INFO -       rsp = 0x000070000cc68920    r12 = 0x000070000cc689d8
[task 2022-04-08T16:28:59.993Z] 16:28:59     INFO -       r13 = 0x0000000113fab548    r14 = 0x000070000cc689e0
[task 2022-04-08T16:28:59.993Z] 16:28:59     INFO -       r15 = 0x0000000000000019    rip = 0x000000011d2cee52
[task 2022-04-08T16:28:59.994Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:28:59.994Z] 16:28:59     INFO -   4  XUL!<rayon_core::job::HeapJob<BODY> as rayon_core::job::Job>::execute [job.rs:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 167 + 0xd0]
[task 2022-04-08T16:28:59.994Z] 16:28:59     INFO -       rbx = 0x0000000113fb6c80    rbp = 0x000070000cc68a70
[task 2022-04-08T16:28:59.995Z] 16:28:59     INFO -       rsp = 0x000070000cc689d0    r12 = 0x0000000113884310
[task 2022-04-08T16:28:59.995Z] 16:28:59     INFO -       r13 = 0x000070000cc68c00    r14 = 0x0000000000000000
[task 2022-04-08T16:28:59.995Z] 16:28:59     INFO -       r15 = 0x0000000113884310    rip = 0x000000011d24b713
[task 2022-04-08T16:28:59.996Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:28:59.996Z] 16:28:59     INFO -   5  XUL!rayon_core::registry::WorkerThread::wait_until_cold [registry.rs:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 726 + 0x5]
[task 2022-04-08T16:28:59.996Z] 16:28:59     INFO -       rbx = 0x0000000113fb6c80    rbp = 0x000070000cc68b70
[task 2022-04-08T16:28:59.996Z] 16:28:59     INFO -       rsp = 0x000070000cc68a80    r12 = 0x0000000113884310
[task 2022-04-08T16:28:59.997Z] 16:28:59     INFO -       r13 = 0x000070000cc68c00    r14 = 0x0000000113fb6c00
[task 2022-04-08T16:28:59.997Z] 16:28:59     INFO -       r15 = 0x000000011d24b620    rip = 0x000000011d8aef6c
[task 2022-04-08T16:28:59.997Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:28:59.998Z] 16:28:59     INFO -   6  XUL!rayon_core::registry::ThreadBuilder::run [registry.rs:d62c69b51528bc1a7c555d666ec3b6d5ca22cc01 : 55 + 0x4e]
[task 2022-04-08T16:28:59.998Z] 16:28:59     INFO -       rbx = 0x0000000113fb6c00    rbp = 0x000070000cc68e70
[task 2022-04-08T16:28:59.998Z] 16:28:59     INFO -       rsp = 0x000070000cc68b80    r12 = 0x0000000000000000
[task 2022-04-08T16:28:59.999Z] 16:28:59     INFO -       r13 = 0x000000010ba9fb80    r14 = 0x000000010ba9fbc0
[task 2022-04-08T16:28:59.999Z] 16:28:59     INFO -       r15 = 0x0000000000000000    rip = 0x000000011d6e6b6d
[task 2022-04-08T16:28:59.999Z] 16:28:59     INFO -      Found by: call frame info
[task 2022-04-08T16:29:00.000Z] 16:29:00     INFO -   7  XUL!std::sys_common::backtrace::__rust_begin_short_backtrace [backtrace.rs:9d1b2106e23b1abd32fce1f17267604a5102f57a : 123 + 0x12]
[task 2022-04-08T16:29:00.000Z] 16:29:00     INFO -       rbx = 0x000000011fe107e8    rbp = 0x000070000cc68ee0
[task 2022-04-08T16:29:00.000Z] 16:29:00     INFO -       rsp = 0x000070000cc68e80    r12 = 0x0000000113f9f900
[task 2022-04-08T16:29:00.001Z] 16:29:00     INFO -       r13 = 0x0000000000000000    r14 = 0x000070000cc68ef0
[task 2022-04-08T16:29:00.001Z] 16:29:00     INFO -       r15 = 0x0000000113f9f900    rip = 0x000000011d6ef4f2
[task 2022-04-08T16:29:00.001Z] 16:29:00     INFO -      Found by: call frame info
[task 2022-04-08T16:29:00.002Z] 16:29:00     INFO -   8  XUL!core::ops::function::FnOnce::call_once{{vtable.shim}} [function.rs:9d1b2106e23b1abd32fce1f17267604a5102f57a : 227 + 0x77]
[task 2022-04-08T16:29:00.002Z] 16:29:00     INFO -       rbx = 0x000000011fe107e8    rbp = 0x000070000cc68f60
[task 2022-04-08T16:29:00.002Z] 16:29:00     INFO -       rsp = 0x000070000cc68ef0    r12 = 0x0000000113f9f900
[task 2022-04-08T16:29:00.002Z] 16:29:00     INFO -       r13 = 0x0000000000000000    r14 = 0x000070000cc68ef0
[task 2022-04-08T16:29:00.003Z] 16:29:00     INFO -       r15 = 0x0000000113f9f900    rip = 0x000000011d6e0c68
[task 2022-04-08T16:29:00.003Z] 16:29:00     INFO -      Found by: call frame info
[task 2022-04-08T16:29:00.003Z] 16:29:00     INFO -   9  XUL!std::sys::unix::thread::Thread::new::thread_start [thread.rs:9d1b2106e23b1abd32fce1f17267604a5102f57a : 108 + 0xc]
[task 2022-04-08T16:29:00.004Z] 16:29:00     INFO -       rbx = 0x000000011fe107e8    rbp = 0x000070000cc68fb0
[task 2022-04-08T16:29:00.004Z] 16:29:00     INFO -       rsp = 0x000070000cc68f70    r12 = 0x0000000113f9f900
[task 2022-04-08T16:29:00.004Z] 16:29:00     INFO -       r13 = 0x0000000000000000    r14 = 0x0000000000000000
[task 2022-04-08T16:29:00.005Z] 16:29:00     INFO -       r15 = 0x0000000113f5ff90    rip = 0x000000011d793c27
[task 2022-04-08T16:29:00.005Z] 16:29:00     INFO -      Found by: call frame info
[task 2022-04-08T16:29:00.005Z] 16:29:00     INFO -  10  libsystem_pthread.dylib!_pthread_start + 0x93
[task 2022-04-08T16:29:00.005Z] 16:29:00     INFO -       rbx = 0x000070000cc69000    rbp = 0x000070000cc68fd0
[task 2022-04-08T16:29:00.006Z] 16:29:00     INFO -       rsp = 0x000070000cc68fc0    r12 = 0x0000000000000000
[task 2022-04-08T16:29:00.006Z] 16:29:00     INFO -       r13 = 0x0000000000000000    r14 = 0x0000000000000000
[task 2022-04-08T16:29:00.006Z] 16:29:00     INFO -       r15 = 0x0000000000000000    rip = 0x00007fff68260109
[task 2022-04-08T16:29:00.006Z] 16:29:00     INFO -      Found by: call frame info
[task 2022-04-08T16:29:00.007Z] 16:29:00     INFO -  11  libsystem_pthread.dylib!thread_start + 0xe
[task 2022-04-08T16:29:00.007Z] 16:29:00     INFO -       rbx = 0x0000000000000000    rbp = 0x000070000cc68ff0
[task 2022-04-08T16:29:00.007Z] 16:29:00     INFO -       rsp = 0x000070000cc68fe0    r12 = 0x0000000000000000
[task 2022-04-08T16:29:00.007Z] 16:29:00     INFO -       r13 = 0x0000000000000000    r14 = 0x0000000000000000
[task 2022-04-08T16:29:00.008Z] 16:29:00     INFO -       r15 = 0x0000000000000000    rip = 0x00007fff6825bb8b
[task 2022-04-08T16:29:00.008Z] 16:29:00     INFO -      Found by: call frame info

Hi Joel! Could this be caused by your changes in Bug 1751492. Can you please take a look?
Thank you!

Two tests are crashing here:

  • test_ext_contentscript_css.js
  • test_ext_i18n_css.js

All are on macosx1015-64-qr debug. I think these might be due to the assertion that's present on all crashes:

ASSERTION: Failed NS_DispatchToMainThread() in shutdown; leaking: 'false', file /builds/worker/checkouts/gecko/xpcom/threads/nsThreadUtils.cpp:222) at /builds/worker/checkouts/gecko/xpcom/base/nsDebugImpl.cpp:450 - https://treeherder.mozilla.org/logviewer?job_id=373911571&repo=autoland&lineNumber=5578

Regressed by: 1751492
Whiteboard: [retriggered]

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

:jmaher, since you are the author of the regressor, bug 1751492, could you take a look?
For more information, please visit auto_nag documentation.

Flags: needinfo?(jmaher)

Style sheet parsing crash.

Flags: needinfo?(emilio)

Failed NS_DispatchToMainThread() in shutdown; leaking

So it's kind of expected, and the bug is that someone is loading a stylesheet during shutdown.

Is it only test_ext_contentscript_css.js that fails? Or something else?

This looks similar to bug 1762638.

Flags: needinfo?(emilio) → needinfo?(aryx.bugmail)
Status: NEW → RESOLVED
Closed: 3 years ago
Flags: needinfo?(jmaher)
Flags: needinfo?(aryx.bugmail)
Resolution: --- → DUPLICATE
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.