Closed Bug 1756069 Opened 3 years ago Closed 3 years ago

Intermittent Main app process exited normally | application crashed [@ __memset_avx2_unaligned_erms + 0xee] | after ipc/glue/test/browser/browser_utility_crashReporter.js | Test timed out

Categories

(Core :: IPC, defect)

defect

Tracking

()

RESOLVED FIXED
99 Branch
Tracking Status
firefox-esr91 --- unaffected
firefox97 --- unaffected
firefox98 --- unaffected
firefox99 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: gerard-majax)

References

Details

(Keywords: crash, intermittent-failure)

Crash Data

Attachments

(3 files)

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


[task 2022-02-17T22:25:11.661Z] 22:25:11     INFO - TEST-START | ipc/glue/test/browser/browser_utility_crashReporter.js
[task 2022-02-17T22:25:11.665Z] 22:25:11     INFO - GECKO(14042) | Chrome file doesn't exist: /builds/worker/workspace/build/tests/mochitest/browser/ipc/glue/test/browser/head.js
[task 2022-02-17T22:25:11.762Z] 22:25:11     INFO - GECKO(14042) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpua7toq5t.mozrunner/runtests_leaks_utility_pid14292.log
[task 2022-02-17T22:25:11.763Z] 22:25:11     INFO - GECKO(14042) | [14292, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:281
[task 2022-02-17T22:25:11.777Z] 22:25:11     INFO - GECKO(14042) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpua7toq5t.mozrunner/runtests_leaks_tab_pid14297.log
[task 2022-02-17T22:25:11.777Z] 22:25:11     INFO - GECKO(14042) | [14297, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:281
[task 2022-02-17T22:25:11.800Z] 22:25:11     INFO - GECKO(14042) | [Child 14297, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:693
[task 2022-02-17T22:25:15.461Z] 22:25:15     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f94f90bf800 == 1 [pid = 14117] [id = 0] [url = about:blank]
[task 2022-02-17T22:25:15.476Z] 22:25:15     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (7f950ed95bc0) [pid = 14117] [serial = 1] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:16.058Z] 22:25:16     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f62cbda0000 == 5 [pid = 14137] [id = 4] [url = moz-extension://d0cc02cd-10b2-46c5-bef6-daaef1b7b2d5/_generated_background_page.html]
[task 2022-02-17T22:25:16.109Z] 22:25:16     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 17 (7f62e6696a40) [pid = 14137] [serial = 9] [outer = 0] [url = moz-extension://d0cc02cd-10b2-46c5-bef6-daaef1b7b2d5/_generated_background_page.html]
[task 2022-02-17T22:25:17.603Z] 22:25:17     INFO - GECKO(14042) | [Parent 14042: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (7f35efa21000) [pid = 14042] [serial = 4] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:17.605Z] 22:25:17     INFO - GECKO(14042) | [Parent 14042: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (7f35efa1f400) [pid = 14042] [serial = 9] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:19.555Z] 22:25:19     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (7f94f90c6400) [pid = 14117] [serial = 4] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:19.555Z] 22:25:19     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f94f90c0000) [pid = 14117] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:19.555Z] 22:25:19     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f94f90c1400) [pid = 14117] [serial = 3] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.152Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (7f62cab67400) [pid = 14137] [serial = 17] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.153Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 15 (7f62cab64800) [pid = 14137] [serial = 15] [outer = 0] [url = moz-extension://d0cc02cd-10b2-46c5-bef6-daaef1b7b2d5/_generated_background_page.html]
[task 2022-02-17T22:25:20.154Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (7f62cbd9b800) [pid = 14137] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.155Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (7f62cbd9e400) [pid = 14137] [serial = 6] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.155Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (7f62cbd9f400) [pid = 14137] [serial = 8] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.156Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (7f62cbd9d000) [pid = 14137] [serial = 4] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:20.157Z] 22:25:20     INFO - GECKO(14042) | [Child 14137: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (7f62cbda0400) [pid = 14137] [serial = 10] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:21.326Z] 22:25:21     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f031a2df000 == 0 [pid = 14217] [id = 0] [url = about:blank]
[task 2022-02-17T22:25:21.335Z] 22:25:21     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f0334b95bc0) [pid = 14217] [serial = 1] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:22.652Z] 22:25:22     INFO - GECKO(14042) | [Child 14189: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f1026dd5c00) [pid = 14189] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-02-17T22:25:25.417Z] 22:25:25     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f031a2df800) [pid = 14217] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-02-17T22:26:41.681Z] 22:26:41     INFO - TEST-INFO | started process screentopng
[task 2022-02-17T22:26:42.074Z] 22:26:42     INFO - TEST-INFO | screentopng: exit 0
[task 2022-02-17T22:26:42.079Z] 22:26:42     INFO - Buffered messages logged at 22:25:11
[task 2022-02-17T22:26:42.080Z] 22:26:42     INFO - Entering test bound 
[task 2022-02-17T22:26:42.081Z] 22:26:42     INFO - TEST-PASS | ipc/glue/test/browser/browser_utility_crashReporter.js | Could start Utility process: 14292 - 
[task 2022-02-17T22:26:42.082Z] 22:26:42     INFO - Leaving test bound 
[task 2022-02-17T22:26:42.082Z] 22:26:42     INFO - Entering test bound 
[task 2022-02-17T22:26:42.083Z] 22:26:42     INFO - prune any previous crashes
[task 2022-02-17T22:26:42.084Z] 22:26:42     INFO - crash Utility Process
[task 2022-02-17T22:26:42.085Z] 22:26:42     INFO - Waiting for utility process to go away.
[task 2022-02-17T22:26:42.086Z] 22:26:42     INFO - Buffered messages finished
[task 2022-02-17T22:26:42.087Z] 22:26:42     INFO - TEST-UNEXPECTED-FAIL | ipc/glue/test/browser/browser_utility_crashReporter.js | Test timed out - 
[task 2022-02-17T22:26:42.087Z] 22:26:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-02-17T22:26:42.088Z] 22:26:42     INFO - TEST-UNEXPECTED-FAIL | ipc/glue/test/browser/browser_utility_crashReporter.js | Uncaught exception received from previously timed out test - ipc:utility-shutdown observer not removed before the end of test
[task 2022-02-17T22:26:42.090Z] 22:26:42     INFO - GECKO(14042) | MEMORY STAT | vsize 3021MB | residentFast 397MB | heapAllocated 160MB
[task 2022-02-17T22:26:42.090Z] 22:26:42     INFO - TEST-OK | ipc/glue/test/browser/browser_utility_crashReporter.js | took 90030ms
[task 2022-02-17T22:26:42.094Z] 22:26:42     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f031a2df800 == 1 [pid = 14217] [id = 1]
[task 2022-02-17T22:26:42.095Z] 22:26:42     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f0334b95bc0) [pid = 14217] [serial = 3] [outer = 0]
[task 2022-02-17T22:26:42.096Z] 22:26:42     INFO - GECKO(14042) | [Child 14217: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f031a2e0000) [pid = 14217] [serial = 4] [outer = 7f0334b95bc0]
[task 2022-02-17T22:26:42.097Z] 22:26:42     INFO - GECKO(14042) | [Parent 14042, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-02-17T22:26:42.099Z] 22:26:42     INFO - GECKO(14042) | [Child 14217, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-02-17T22:26:42.100Z] 22:26:42     INFO - GECKO(14042) | [Child 14217, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-02-17T22:26:42.102Z] 22:26:42     INFO - checking window state
[task 2022-02-17T22:26:42.104Z] 22:26:42     INFO - TEST-START | ipc/glue/test/browser/browser_utility_hard_kill.js
[task 2022-02-17T22:26:42.109Z] 22:26:42     INFO - GECKO(14042) | Chrome file doesn't exist: /builds/worker/workspace/build/tests/mochitest/browser/ipc/glue/test/browser/head.js
[task 2022-02-17T22:26:42.111Z] 22:26:42     INFO - GECKO(14042) | [Parent 14042, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 9E52E2B0B456AB7A.2E5D86476ABDA517: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:340
[task 2022-02-17T22:26:42.112Z] 22:26:42     INFO - GECKO(14042) | [Parent 14042, IPC I/O Parent] WARNING: [1.1]: Ignoring message 'EVENT_MESSAGE' to unknown peer 9E52E2B0B456AB7A.2E5D86476ABDA517: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:340
[task 2022-02-17T22:26:42.113Z] 22:26:42     INFO - GECKO(14042) | MEMORY STAT | vsize 3021MB | residentFast 399MB | heapAllocated 162MB
[task 2022-02-17T22:26:42.114Z] 22:26:42     INFO - TEST-OK | ipc/glue/test/browser/browser_utility_hard_kill.js | took 81ms
[task 2022-02-17T22:26:42.115Z] 22:26:42     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f94f90c0000 == 2 [pid = 14117] [id = 2]
[task 2022-02-17T22:26:42.116Z] 22:26:42     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f950ed95bc0) [pid = 14117] [serial = 7] [outer = 0]
[task 2022-02-17T22:26:42.117Z] 22:26:42     INFO - GECKO(14042) | [Child 14117: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7f94f90c0800) [pid = 14117] [serial = 8] [outer = 7f950ed95bc0]
[task 2022-02-17T22:26:42.118Z] 22:26:42     INFO - GECKO(14042) | [Parent 14042, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-02-17T22:26:42.119Z] 22:26:42     INFO - checking window state
[task 2022-02-17T22:26:42.120Z] 22:26:42     INFO - GECKO(14042) | [Child 14117, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:129
[task 2022-02-17T22:26:42.122Z] 22:26:42     INFO - TEST-START | ipc/glue/test/browser/browser_utility_hard_kill_delayed.js
<...>
[task 2022-02-17T22:26:54.088Z] 22:26:54     INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/60c24ccd-9b47-41a9-dd43-fa40e7270e02.extra
[task 2022-02-17T22:26:54.104Z] 22:26:54     INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ __memset_avx2_unaligned_erms + 0xee]
[task 2022-02-17T22:26:54.105Z] 22:26:54     INFO - Crash dump filename: /tmp/tmpua7toq5t.mozrunner/minidumps/60c24ccd-9b47-41a9-dd43-fa40e7270e02.dmp
[task 2022-02-17T22:26:54.105Z] 22:26:54     INFO - Operating system: Linux
[task 2022-02-17T22:26:54.105Z] 22:26:54     INFO -                   0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64
[task 2022-02-17T22:26:54.105Z] 22:26:54     INFO - CPU: amd64
[task 2022-02-17T22:26:54.105Z] 22:26:54     INFO -      family 6 model 85 stepping 4
[task 2022-02-17T22:26:54.106Z] 22:26:54     INFO -      2 CPUs
[task 2022-02-17T22:26:54.106Z] 22:26:54     INFO - Linux Ubuntu 18.04 - bionic (Ubuntu 18.04.6 LTS)
[task 2022-02-17T22:26:54.106Z] 22:26:54     INFO - 
[task 2022-02-17T22:26:54.107Z] 22:26:54     INFO - Crash reason:  SIGABRT / 0x00000000
[task 2022-02-17T22:26:54.107Z] 22:26:54     INFO - Crash address: 0x3e8000036da
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO - Process uptime: not available
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO - 
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO - Thread 0 MainThread (crashed)
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO -  0  libc.so.6!__memset_avx2_unaligned_erms + 0xee
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO -     rax = 0x00007efe6e420218   rdx = 0x0000000000000008
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO -     rcx = 0xe5e5e5e5e5e5e5e5   rbx = 0x00007efe6e420000
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO -     rsi = 0x00000000000000e5   rdi = 0x00007efe6e420218
[task 2022-02-17T22:26:54.108Z] 22:26:54     INFO -     rbp = 0x00007fff08cd7110   rsp = 0x00007fff08cd70c8
[task 2022-02-17T22:26:54.109Z] 22:26:54     INFO -      r8 = 0x00007efe6e500020    r9 = 0x0000000000000000
[task 2022-02-17T22:26:54.109Z] 22:26:54     INFO -     r10 = 0x00007efe6ea0af20   r11 = 0x000000000000000a
[task 2022-02-17T22:26:54.109Z] 22:26:54     INFO -     r12 = 0x0000000000000008   r13 = 0x00007efe6e420218
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -     r14 = 0x00007efe6e500000   r15 = 0x00007efe6e5000a0
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -     rip = 0x00007efe6e9fb2ae
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -     Found by: given as instruction pointer in context
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -  1  firefox-bin!arena_t::DallocSmall(arena_chunk_t*, void*, arena_chunk_map_t*) [mozjemalloc.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 3432 + 0xf]
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -     rbx = 0x00007efe6e420000   rbp = 0x00007fff08cd7110
[task 2022-02-17T22:26:54.110Z] 22:26:54     INFO -     rsp = 0x00007fff08cd70d0   r12 = 0x0000000000000008
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r13 = 0x00007efe6e420218   r14 = 0x00007efe6e500000
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r15 = 0x00007efe6e5000a0   rip = 0x0000557e9a6f2bd5
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -  2  firefox-bin!arena_dalloc(void*, unsigned long, arena_t*) [mozjemalloc.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 3518 + 0xd]
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rbx = 0x0000000000000020   rbp = 0x00007fff08cd7150
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7120   r12 = 0x00007efe6e500020
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r13 = 0x00007efe6e400000   r14 = 0x00007efe6e420218
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r15 = 0x00007efe6e500000   rip = 0x0000557e9a6f279c
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -  3  firefox-bin!PageFree(mozilla::Maybe<unsigned long> const&, void*) [PHC.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 1292 + 0x8]
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7180   rbp = 0x00007fff08cd7240
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7160   r12 = 0x00007efe64a0915c
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r13 = 0x00007efe6e420218   r14 = 0x00007fff08cd7250
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r15 = 0x00007efe5bf9b3c8   rip = 0x0000557e9a70cd55
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -  4  firefox-bin!replace_free(void*) [PHC.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 1328 + 0x26]
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rbx = 0x00007efe5bf9c600   rbp = 0x00007fff08cd7270
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7250   r12 = 0x00007efe64a0915c
[task 2022-02-17T22:26:54.111Z] 22:26:54     INFO -     r13 = 0x00007fff08cd72d0   r14 = 0x00007efe6e420218
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     r15 = 0x00007efe5bf9b3c8   rip = 0x0000557e9a70d2b8
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -  5  libxul.so!mozilla::Telemetry::Common::IsExpiredVersion(char const*) [TelemetryCommon.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 29 + 0x7]
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     rbx = 0x00007efe5bf9c600   rbp = 0x00007fff08cd7290
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7280   r12 = 0x00007efe64a0915c
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     r13 = 0x00007fff08cd72d0   r14 = 0x00007efe6e420218
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     r15 = 0x00007efe5bf9b3c8   rip = 0x00007efe61df7a72
[task 2022-02-17T22:26:54.112Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.113Z] 22:26:54     INFO -  6  libxul.so!TelemetryEvent::InitializeGlobalState(bool, bool) [TelemetryEvent.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 703 + 0x2b]
[task 2022-02-17T22:26:54.113Z] 22:26:54     INFO -     rbx = 0x0000000000000129   rbp = 0x00007fff08cd7320
[task 2022-02-17T22:26:54.113Z] 22:26:54     INFO -     rsp = 0x00007fff08cd72a0   r12 = 0x00007efe64a0915c
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -     r13 = 0x00007fff08cd72d0   r14 = 0x00007fff08cd72e0
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -     r15 = 0x00007efe5bf9b3c8   rip = 0x00007efe61df82be
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -  7  libxul.so!already_AddRefed<nsISupports> mozCreateComponent<nsITelemetry>() [Telemetry.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 2067 + 0xa2]
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -     rbx = 0x00000000854e2600   rbp = 0x00007fff08cd7380
[task 2022-02-17T22:26:54.114Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7330   r12 = 0x0000000000000000
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -     r13 = 0x00007fff08cd7460   r14 = 0x00007fff08cd73a8
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -     r15 = 0x00007efe64ceecf8   rip = 0x00007efe61df3269
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -  8  libxul.so!mozilla::xpcom::CreateInstanceImpl(mozilla::xpcom::ModuleID, nsISupports*, nsID const&, void**) [StaticComponents.cpp: : 11616 + 0xf]
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -     rbx = 0x00007fff08cd73a8   rbp = 0x00007fff08cd73e0
[task 2022-02-17T22:26:54.115Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7390   r12 = 0x00007fff08cd75b0
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     r13 = 0x00007fff08cd7460   r14 = 0x00007fff08cd7458
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     r15 = 0x00007efe5ad95d88   rip = 0x00007efe5d9dc4a7
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -  9  libxul.so!nsComponentManagerImpl::GetServiceLocked(mozilla::Maybe<mozilla::MonitorAutoLock>&, (anonymous namespace)::EntryWrapper&, nsID const&, void**) [nsComponentManager.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 1288 + 0x32]
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     rbx = 0x0000000000000000   rbp = 0x00007fff08cd7560
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     rsp = 0x00007fff08cd73f0   r12 = 0x00007fff08cd75b0
[task 2022-02-17T22:26:54.116Z] 22:26:54     INFO -     r13 = 0x00007fff08cd7460   r14 = 0x00007fff08cd7458
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     r15 = 0x00007fff08cd75a0   rip = 0x00007efe5d9f4050
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO - 10  libxul.so!nsComponentManagerImpl::GetServiceByContractID(char const*, nsID const&, void**) [nsComponentManager.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 1477 + 0x21]
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7588   rbp = 0x00007fff08cd7600
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7570   r12 = 0x00007efe5871bc00
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     r13 = 0x00007efe5aad9187   r14 = 0x00007fff08cd75b0
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     r15 = 0xaaaaaaaaaaaaaaaa   rip = 0x00007efe5d9f4be1
[task 2022-02-17T22:26:54.117Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO - 11  libxul.so!nsGetServiceByContractID::operator()(nsID const&, void**) const [nsComponentManagerUtils.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 243 + 0x19]
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7630   rbp = 0x00007fff08cd7620
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7610   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO -     r13 = 0x00007efe6e4e9a80   r14 = 0x00007fff08cd76c0
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO -     r15 = 0x0000000000000001   rip = 0x00007efe5d9f6f45
[task 2022-02-17T22:26:54.118Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO - 12  libxul.so!nsCOMPtr<nsITelemetry>::assign_from_gs_contractid(nsGetServiceByContractID, nsID const&) [nsCOMPtr.h:640931f8d9f37064270a8e213d18140e36a986e8 : 1234 + 0xa]
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7668   rbp = 0x00007fff08cd7650
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7630   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     r13 = 0x00007efe6e4e9a80   r14 = 0x00007fff08cd76c0
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     r15 = 0x0000000000000001   rip = 0x00007efe5d9675ee
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO - 13  libxul.so!mozilla::Telemetry::Init() [Telemetry.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 1930 + 0x1c]
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7668   rbp = 0x00007fff08cd7680
[task 2022-02-17T22:26:54.119Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7660   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     r13 = 0x00007efe6e4e9a80   r14 = 0x00007fff08cd76c0
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     r15 = 0x0000000000000001   rip = 0x00007efe61df2553
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO - 14  libxul.so!NS_InitMinimalXPCOM [XPCOMInit.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 552 + 0x4]
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     rbx = 0x000000008000ffff   rbp = 0x00007fff08cd76a0
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7690   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     r13 = 0x00007efe6e4e9a80   r14 = 0x00007fff08cd76c0
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     r15 = 0x0000000000000001   rip = 0x00007efe5da55372
[task 2022-02-17T22:26:54.120Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO - 15  libxul.so!mozilla::ipc::UtilityProcessChild::Init(int, nsTString<char> const&, unsigned long, mozilla::ipc::ScopedPort) [UtilityProcessChild.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 94 + 0x4]
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     rbx = 0x00007fff08cd7748   rbp = 0x00007fff08cd7710
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     rsp = 0x00007fff08cd76b0   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     r13 = 0x00007efe6e4e9a80   r14 = 0x00007fff08cd76c0
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     r15 = 0x0000000000000001   rip = 0x00007efe5e0eaf15
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO - 16  libxul.so!mozilla::ipc::UtilityProcessImpl::Init(int, char**) [UtilityProcessImpl.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 55 + 0x16]
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     rbx = 0x00007efe6e483680   rbp = 0x00007fff08cd77d0
[task 2022-02-17T22:26:54.121Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7720   r12 = 0x00007efe6e4e9a80
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     r13 = 0x0000000000000001   r14 = 0x00007fff08cd7770
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     r15 = 0x00007fff08cd7748   rip = 0x00007efe5e0eccee
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO - 17  libxul.so!XRE_InitChildProcess(int, char**, XREChildData const*) [nsEmbedFunctions.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 681 + 0x13]
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     rbx = 0x00007efe6e4c3430   rbp = 0x00007fff08cd7ab0
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     rsp = 0x00007fff08cd77e0   r12 = 0x00000000000036da
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     r13 = 0x00007fff08cd8c68   r14 = 0x000000000000000c
[task 2022-02-17T22:26:54.122Z] 22:26:54     INFO -     r15 = 0x00007fff08cd7818   rip = 0x00007efe61ed0a12
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO - 18  firefox-bin!content_process_main(mozilla::Bootstrap*, int, char**) [plugin-container.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 57 + 0x10]
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     rbx = 0x000000000000000e   rbp = 0x00007fff08cd7af0
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7ac0   r12 = 0x00007fff08cd7ac0
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     r13 = 0x00007fff08cd8c60   r14 = 0x00007fff08cd8c68
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     r15 = 0x00007efe6e403760   rip = 0x0000557e9a6e809a
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO - 19  firefox-bin!main [nsBrowserApp.cpp:640931f8d9f37064270a8e213d18140e36a986e8 : 327 + 0x1f]
[task 2022-02-17T22:26:54.123Z] 22:26:54     INFO -     rbx = 0x0000000000000000   rbp = 0x00007fff08cd8b80
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     rsp = 0x00007fff08cd7b00   r12 = 0x0000557e9a6e7f40
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     r13 = 0x00007fff08cd8c60   r14 = 0x0000557e9a78e0f8
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     r15 = 0x0000062b49a4906d   rip = 0x0000557e9a6e84a9
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO - 20  libc.so.6!__libc_start_main [libc-start.c : 310 + 0x19]
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     rbx = 0x0000000000000000   rbp = 0x0000557e9a78a070
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     rsp = 0x00007fff08cd8b90   r12 = 0x0000557e9a6e7f40
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     r13 = 0x00007fff08cd8c60   r14 = 0x0000000000000000
[task 2022-02-17T22:26:54.124Z] 22:26:54     INFO -     r15 = 0x0000000000000000   rip = 0x00007efe6e88db97
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO - 21  firefox-bin!_start + 0x28
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     rbx = 0x0000000000000000   rbp = 0x0000000000000000
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     rsp = 0x00007fff08cd8c50   r12 = 0x0000557e9a6e7f40
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     r13 = 0x00007fff08cd8c60   r14 = 0x0000000000000000
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     r15 = 0x0000000000000000   rip = 0x0000557e9a6e7f69
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -     Found by: call frame info
[task 2022-02-17T22:26:54.125Z] 22:26:54     INFO -

browser_utility_hard_kill_delayed.js was added recently.

Kind of a weird crash, in the middle of initializing telemetry.

Keywords: regression
Regressed by: 1754572

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

It seems to be crashing in browser_utility_crashReporter.js and not browser_utility_hard_kill_delayed.js ?

Has Regression Range: --- → yes

Crash reason: SIGABRT / 0x00000000 this is what we send when we want to exercise external killing of the process, so I'm wondering what is happening there.

Keywords: regression
No longer regressed by: 1754572
Group: core-security
Has Regression Range: yes → ---
Assignee: nobody → lissyx+mozillians

Locally I managed to repro something, at which point I saw the signal delivered to the child, but then the test hanging. Plugging a gdb got me this stack:

(gdb) bt
#0  futex_wait (private=0, expected=2, futex_word=0x7fa1fa500020) at ../sysdeps/nptl/futex-internal.h:146
#1  __lll_lock_wait (futex=futex@entry=0x7fa1fa500020, private=0) at lowlevellock.c:52
#2  0x00007fa1fac92142 in __GI___pthread_mutex_lock (mutex=0x7fa1fa500020) at ../nptl/pthread_mutex_lock.c:132
#3  0x000055653a950af1 in Mutex::Lock() (this=0x7fa1fa500020) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/Mutex.h:65
#4  AutoLock<Mutex>::AutoLock(Mutex&) (aMutex=..., this=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/Mutex.h:115
#5  arena_t::MallocSmall(unsigned long, bool) (this=0x7fa1fa500000, aSize=<optimized out>, aZero=false) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/mozjemalloc.cpp:2998
#6  0x000055653a94e2dd in arena_t::Malloc(unsigned long, bool) (this=0x7fa1fa500020, aSize=128, aSize@entry=16, aZero=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/mozjemalloc.cpp:3054
#7  0x000055653a9521e2 in BaseAllocator::malloc(unsigned long) (aSize=16, this=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/mozjemalloc.cpp:4200
#8  Allocator<MozJemallocBase>::malloc(unsigned long) (arg1=16) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/malloc_decls.h:51
#9  0x000055653a96ae0f in PageMalloc(mozilla::Maybe<unsigned long> const&, unsigned long) (aArenaId=..., aReqSize=16) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/replace/phc/PHC.cpp:1134
#10 replace_malloc(unsigned long) (aReqSize=16) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/replace/phc/PHC.cpp:1138
#11 0x000055653a96c809 in moz_xmalloc(size_t) (size=16) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/mozalloc/mozalloc.cpp:52
#12 0x00007fa1ef81c71e in nsTArrayInfallibleAllocator::Malloc(unsigned long) (aSize=140333666009120) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTArray.h:256
#13 nsTArray_base<nsTArrayInfallibleAllocator, nsTArray_RelocateUsingMemutils>::EnsureCapacity<nsTArrayInfallibleAllocator>(unsigned long, unsigned long) (this=0x7fa1ea64af20, aCapacity=1, aElemSize=8) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTArray-inl.h:175
#14 0x00007fa1efa929c1 in nsTArray_Impl<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*, nsTArrayInfallibleAllocator>::InsertElementAtInternal<nsTArrayInfallibleAllocator, mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&>(unsigned long, mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&) (this=this@entry=0x7fa1ea64af20, aIndex=0, aItem=@0x7fa1fa4df3b0: 0x7fa1fa41c620) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTArray.h:2601
#15 0x00007fa1efa92975 in nsTArray_Impl<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*, nsTArrayInfallibleAllocator>::InsertElementSortedInternal<nsTArrayInfallibleAllocator, mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&, nsDefaultComparator<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*, mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&> >(mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&, nsDefaultComparator<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*, mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&> const&)
    (this=this@entry=0x7fa1ea64af20, aItem=@0x7fa1fa4df3b0: 0x7fa1fa41c620, aComp=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTArray.h:1680
#16 0x00007fa1efa8ca8f in nsTArray<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*>::InsertElementSorted<mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&>(mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::OrderingEntry*&) (this=0x7fa1ea64af20, aItem=@0x7fa1fa4df3b0: 0x7fa1fa41c620)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTArray.h:2921
#17 mozilla::DeadlockDetector<mozilla::BlockingResourceBase>::CheckAcquisition(mozilla::BlockingResourceBase const*, mozilla::BlockingResourceBase const*) (this=0x7fa1fa4b15b0, aLast=<optimized out>, aProposed=<optimized out>, aProposed@entry=0x7fa1fa4ab768)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/mozilla/DeadlockDetector.h:254
#18 0x00007fa1efa84a9f in mozilla::BlockingResourceBase::CheckAcquire() (this=this@entry=0x7fa1fa4ab768) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/threads/BlockingResourceBase.cpp:221
#19 0x00007fa1efa84f56 in mozilla::OffTheBooksMutex::Lock() (this=0x7fa1fa4ab740) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/threads/BlockingResourceBase.cpp:310
#20 0x00007fa1f45ac48c in mozilla::StaticMutex::Lock() (this=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/mozilla/StaticMutex.h:38
#21 CrashReporter::GetFlatThreadAnnotation(std::function<void (char const*)> const&, bool) (aCallback=..., aIsHandlingException=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/ThreadAnnotation.cpp:271
#22 0x00007fa1f45b3188 in CrashReporter::PrepareChildExceptionTimeAnnotations(mozilla::phc::AddrInfo const*) (addrInfo=addrInfo@entry=0x7fa1fa4df868) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/nsExceptionHandler.cpp:1664
#23 0x00007fa1f45b1643 in CrashReporter::ChildMinidumpCallback(google_breakpad::MinidumpDescriptor const&, void*, mozilla::phc::AddrInfo const*, bool) (descriptor=..., context=0x80, addr_info=0x7fa1fa500020, addr_info@entry=0x7fa1fa4df868, succeeded=true)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/nsExceptionHandler.cpp:1814
#24 0x00007fa1f45b6f91 in google_breakpad::ExceptionHandler::GenerateDump(google_breakpad::ExceptionHandler::CrashContext*, mozilla::phc::AddrInfo const*) (this=this@entry=0x7fa1fa470100, context=<optimized out>, addr_info=addr_info@entry=0x7fa1fa4df868)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/breakpad-client/linux/handler/exception_handler.cc:547
#25 0x00007fa1f45b6c74 in google_breakpad::ExceptionHandler::HandleSignal(int, siginfo_t*, void*) (this=0x7fa1fa470100, info=info@entry=0x7fa1fa4dfbf0, uc=uc@entry=0x7fa1fa4dfac0) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/breakpad-client/linux/handler/exception_handler.cc:522
#26 0x00007fa1f45b6984 in google_breakpad::ExceptionHandler::SignalHandler(int, siginfo_t*, void*) (sig=4, info=0x7fa1fa4dfbf0, uc=0x7fa1fa4dfac0) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/crashreporter/breakpad-client/linux/handler/exception_handler.cc:396
#27 0x00007fa1fac9a200 in <signal handler called> () at /lib/x86_64-linux-gnu/libpthread.so.0
#28 0x00007fa1fa89f259 in __memset_avx2_unaligned_erms () at ../sysdeps/x86_64/multiarch/memset-vec-unaligned-erms.S:215
#29 0x000055653a9512f5 in memset (__dest=0x7fa1ea613a00, __ch=229, __len=768) at /home/alexandre/.mozbuild/sysroot-x86_64-linux-gnu/usr/include/x86_64-linux-gnu/bits/string3.h:84
#30 arena_t::DallocSmall(arena_chunk_t*, void*, arena_chunk_map_t*) (this=this@entry=0x7fa1fa500000, aChunk=aChunk@entry=0x7fa1ea600000, aPtr=aPtr@entry=0x7fa1ea613a00, aMapElm=0x7fa1ea613d00) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/mozjemalloc.cpp:3432
#31 0x000055653a94d545 in arena_dalloc(void*, unsigned long, arena_t*) (aPtr=0x7fa1ea613a00, aOffset=<optimized out>, aArena=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/build/mozjemalloc.cpp:3518
#32 0x000055653a96a9fb in PageFree(mozilla::Maybe<unsigned long> const&, void*) (aArenaId=..., aPtr=0x7fa1ea613a00) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/replace/phc/PHC.cpp:1292
#33 0x000055653a96af5e in replace_free(void*) (aPtr=0xe5) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/memory/replace/phc/PHC.cpp:1328
#34 0x00007fa1efa0947a in PLDHashTable::ChangeTable(int) (this=<optimized out>, this@entry=0x7fa1f7845dc8 <(anonymous namespace)::gCategoryNames>, aDeltaLog2=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/ds/PLDHashTable.cpp:472
#35 0x00007fa1efa09887 in PLDHashTable::MakeEntryHandle(void const*, std::nothrow_t const&) (this=0x7fa1f7845dc8 <(anonymous namespace)::gCategoryNames>, aKey=0x7fff69613d80) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/ds/PLDHashTable.cpp:650
#36 0x00007fa1efa09c44 in PLDHashTable::MakeEntryHandle(void const*) (this=0x7fa1f7845dc8 <(anonymous namespace)::gCategoryNames>, aKey=0x7fa1ea613d00) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/ds/PLDHashTable.cpp:675
#37 0x00007fa1ef993a2f in PLDHashTable::WithEntryHandle<nsTHashtable<nsCStringHashKey>::WithEntryHandle<nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&)::{lambda(auto:1)#1}>(nsTSubstring<char> const&, nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&)::{lambda(auto:1)#1}&&)::{lambda(auto:1)#1}>(void const*, nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&)::{lambda(auto:1)#1}&&) (this=0xe5, aKey=0x7fa1ea613d00, aFunc=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/PLDHashTable.h:603
#38 0x00007fa1f44f7cfa in nsTHashtable<nsCStringHashKey>::WithEntryHandle<nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&)::{lambda(auto:1)#1}>(nsTSubstring<char> const&, nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&)::{lambda(auto:1)#1}&&) (this=0x7fa1ea613a00, aKey=..., aFunc=...)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTHashtable.h:434
#39 nsTHashtable<nsCStringHashKey>::PutEntry(nsTSubstring<char> const&) (this=0x7fa1ea613a00, aKey=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTHashtable.h:306
#40 nsTBaseHashSet<nsCStringHashKey>::Insert(nsTSubstring<char> const&) (this=0x7fa1ea613a00, aValue=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsTHashSet.h:86
#41 TelemetryEvent::InitializeGlobalState(bool, bool) (aCanRecordBase=<optimized out>, aCanRecordExtended=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/components/telemetry/core/TelemetryEvent.cpp:709
#42 0x00007fa1f44f2901 in (anonymous namespace)::TelemetryImpl::CreateTelemetryInstance() () at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/components/telemetry/core/Telemetry.cpp:1144
#43 mozCreateComponent<nsITelemetry>() () at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/components/telemetry/core/Telemetry.cpp:2067
#44 0x00007fa1efa6897f in mozilla::xpcom::CreateInstanceImpl(mozilla::xpcom::ModuleID, nsISupports*, nsID const&, void**) (aID=<optimized out>, aOuter=0xe5, aIID=..., aResult=0x7fff69613f08) at StaticComponents.cpp:11696
#45 0x00007fa1efa7c35e in (anonymous namespace)::EntryWrapper::CreateInstance(nsISupports*, nsID const&, void**) (this=0x7fff69614060, aOuter=0x0, aIID=..., aResult=0x7fff69613f08) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/components/nsComponentManager.cpp:181
#46 nsComponentManagerImpl::GetServiceLocked(mozilla::Maybe<mozilla::MonitorAutoLock>&, (anonymous namespace)::EntryWrapper&, nsID const&, void**) (this=this@entry=0x7fa1ea618420, aLock=..., aEntry=..., aIID=..., aResult=aResult@entry=0x7fff696140e0)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/components/nsComponentManager.cpp:1288
#47 0x00007fa1efa7ceef in nsComponentManagerImpl::GetServiceByContractID(char const*, nsID const&, void**) (this=0x7fa1ea618420, aContractID=0x7fa1ec50ff8c "@mozilla.org/base/telemetry;1", aIID=..., aResult=0x1a, aResult@entry=0x7fff696140e0)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/components/nsComponentManager.cpp:1477
#48 0x00007fa1efa7ec1f in CallGetService(char const*, nsID const&, void**) (aContractID=0xe5 <error: Cannot access memory at address 0xe5>, aIID=..., aResult=0x7fff696140e0) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/components/nsComponentManagerUtils.cpp:61
#49 nsGetServiceByContractID::operator()(nsID const&, void**) const (this=0x7fa1ea613a00, aIID=..., aInstancePtr=0x7fff696140e0) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/components/nsComponentManagerUtils.cpp:243
#50 0x00007fa1ef9e9bb4 in nsCOMPtr<nsITelemetry>::assign_from_gs_contractid(nsGetServiceByContractID, nsID const&) (this=0x7fff69614118, aGS=..., aIID=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsCOMPtr.h:1234
#51 0x00007fa1f44f1c29 in nsCOMPtr<nsITelemetry>::nsCOMPtr(nsGetServiceByContractID) (this=0x7fff69614118, aGS=...) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/obj-browser-dbg/dist/include/nsCOMPtr.h:627
#52 mozilla::Telemetry::Init() () at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/components/telemetry/core/Telemetry.cpp:1930
#53 0x00007fa1efadfff4 in NS_InitMinimalXPCOM() () at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/xpcom/build/XPCOMInit.cpp:552
#54 0x00007fa1f02453bd in mozilla::ipc::UtilityProcessChild::Init(int, nsTString<char> const&, unsigned long, mozilla::ipc::ScopedPort) (this=this@entry=0x7fa1fa47e950, aParentPid=aParentPid@entry=897710, aParentBuildID=..., aSandboxingKind=aSandboxingKind@entry=1, aPort=...)
    at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/ipc/glue/UtilityProcessChild.cpp:94
#55 0x00007fa1f0246e99 in mozilla::ipc::UtilityProcessImpl::Init(int, char**) (this=<optimized out>, aArgc=8, aArgv=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/ipc/glue/UtilityProcessImpl.cpp:55
#56 0x00007fa1f45e63ed in XRE_InitChildProcess(int, char**, XREChildData const*) (aArgc=12, aArgv=0x7fff69615748, aChildData=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/toolkit/xre/nsEmbedFunctions.cpp:681
#57 0x000055653a945f0a in content_process_main(mozilla::Bootstrap*, int, char**) (bootstrap=0x7fa1fa403780, argc=14, argv=0x7fff69615748) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/browser/app/../../ipc/contentproc/plugin-container.cpp:57
#58 0x000055653a9462f9 in main(int, char**, char**) (argc=229, argv=0x7fa1ea613d00, envp=<optimized out>) at /home/alexandre/Documents/codaz/Mozilla/MiscWork/mozilla-source/mozilla-unified/browser/app/nsBrowserApp.cpp:327
Depends on: 1756505
See Also: → 1756259
See Also: → 1755090
Attachment #9264857 - Attachment description: WIP: Bug 1756069 - Ensure proper termination of Utility process → Bug 1756069 - Ensure proper termination of Utility process r?mccr8!
Attachment #9264858 - Attachment description: WIP: Bug 1756069 - Make UtilityProcess parent wait for child init completion to resolve promise → Bug 1756069 - Make UtilityProcess parent wait for child init completion to resolve promise r?mccr8!

Depends on D139304

I believe there was also a race with how the promise is returning wrt the child init:

Pushed by alissy@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/bc405a8fde37 Ensure proper termination of Utility process r=mccr8 https://hg.mozilla.org/integration/autoland/rev/c89d9047cf8e Make UtilityProcess parent wait for child init completion to resolve promise r=mccr8 https://hg.mozilla.org/integration/autoland/rev/d39a2e21877c Avoid allocation within signal handler r=gsvelto
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: