Intermittent leakcheck | default X bytes leaked (ThreadSafeWeakReference<UnscaledFont>, UnscaledFontMac, gfxFontEntry, nsStringBuffer, nsTArray_base)
Categories
(Firefox :: Tabbed Browser, defect, P5)
Tracking
()
Tracking | Status | |
---|---|---|
firefox-esr78 | --- | unaffected |
firefox85 | --- | unaffected |
firefox86 | --- | unaffected |
firefox87 | --- | fixed |
People
(Reporter: intermittent-bug-filer, Assigned: jfkthame)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, Whiteboard: [retriggered][stockwell fixed:patch])
Attachments
(3 files)
Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=328523340&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/JMQDlfsrTb6WoCNN2qfcoA/runs/0/artifacts/public/logs/live_backing.log
[task 2021-02-02T04:06:49.088Z] 04:06:49 INFO - TEST-START | browser/base/content/test/tabcrashed/browser_withoutDump.js
[task 2021-02-02T04:06:49.109Z] 04:06:49 INFO - GECKO(1788) | [Child 1823: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x10de11400 == 1 [pid = 1823] [id = 0]
[task 2021-02-02T04:06:49.109Z] 04:06:49 INFO - GECKO(1788) | [Child 1823: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0x1127f2040) [pid = 1823] [serial = 1] [outer = 0x0]
[task 2021-02-02T04:06:49.109Z] 04:06:49 INFO - GECKO(1788) | [Child 1823: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (0x1127df000) [pid = 1823] [serial = 2] [outer = 0x1127f2040]
[task 2021-02-02T04:06:49.183Z] 04:06:49 INFO - GECKO(1788) | [Child 1823: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (0x11286d000) [pid = 1823] [serial = 3] [outer = 0x1127f2040]
[task 2021-02-02T04:06:49.303Z] 04:06:49 INFO - GECKO(1788) | [1825, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2021-02-02T04:06:49.303Z] 04:06:49 INFO - GECKO(1788) | [1825, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2021-02-02T04:06:49.303Z] 04:06:49 INFO - GECKO(1788) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1825.log
[task 2021-02-02T04:06:49.304Z] 04:06:49 INFO - GECKO(1788) | [1825, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2021-02-02T04:06:49.304Z] 04:06:49 INFO - GECKO(1788) | [1825, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2021-02-02T04:06:49.304Z] 04:06:49 INFO - GECKO(1788) | [1825, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:251
[task 2021-02-02T04:06:49.593Z] 04:06:49 INFO - GECKO(1788) | Et tu, Brute?
[task 2021-02-02T04:06:49.593Z] 04:06:49 INFO - GECKO(1788) | XPCOM_MEM_BLOAT_LOG: /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks.log
[task 2021-02-02T04:06:49.593Z] 04:06:49 INFO - GECKO(1788) | Writing to log: /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1823.log
[task 2021-02-02T04:06:49.788Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Unnamed thread 12625d680] WARNING: Resource acquired is being released in non-LIFO order; why?
[task 2021-02-02T04:06:49.788Z] 04:06:49 INFO - GECKO(1788) | : file /builds/worker/checkouts/gecko/xpcom/threads/BlockingResourceBase.cpp:292
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | --- Mutex : dumpSafetyLock (currently acquired)
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | calling context
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | [stack trace unavailable]
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.789Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.790Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.790Z] 04:06:49 INFO - GECKO(1788) | [Child 1820: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x109ed5c00 == 3 [pid = 1820] [id = 2]
[task 2021-02-02T04:06:49.790Z] 04:06:49 INFO - GECKO(1788) | [Child 1820: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x109f0e3c0) [pid = 1820] [serial = 5] [outer = 0x0]
[task 2021-02-02T04:06:49.797Z] 04:06:49 INFO - GECKO(1788) | [Child 1820: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x109ed6c00) [pid = 1820] [serial = 6] [outer = 0x109f0e3c0]
[task 2021-02-02T04:06:49.797Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.798Z] 04:06:49 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x1081d9c00 == 4 [pid = 1805] [id = 1] [url = about:blank]
[task 2021-02-02T04:06:49.798Z] 04:06:49 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x108282c00 == 3 [pid = 1805] [id = 4] [url = http://example.com/]
[task 2021-02-02T04:06:49.798Z] 04:06:49 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x1081dcc00 == 2 [pid = 1805] [id = 3] [url = http://example.com/]
[task 2021-02-02T04:06:49.798Z] 04:06:49 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x1081d1c00 == 1 [pid = 1805] [id = 2] [url = about:blank]
[task 2021-02-02T04:06:49.859Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:512
[task 2021-02-02T04:06:49.859Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/workspace/obj-build/dist/include/mozilla/ipc/ProtocolUtils.h:299
[task 2021-02-02T04:06:49.860Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x125d9c000 == 14 [pid = 1788] [id = 26]
[task 2021-02-02T04:06:49.860Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 29 (0x11cbc2900) [pid = 1788] [serial = 79] [outer = 0x0]
[task 2021-02-02T04:06:49.860Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 30 (0x12694dc00) [pid = 1788] [serial = 80] [outer = 0x11cbc2900]
[task 2021-02-02T04:06:49.944Z] 04:06:49 INFO - GECKO(1788) | [Parent 1788: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 31 (0x126e0a800) [pid = 1788] [serial = 81] [outer = 0x11cbc2900]
[task 2021-02-02T04:06:49.955Z] 04:06:49 INFO - GECKO(1788) | Crash cleaned up
[task 2021-02-02T04:06:49.982Z] 04:06:49 INFO - GECKO(1788) | about:tabcrashed loaded and ready
[task 2021-02-02T04:06:50.005Z] 04:06:50 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (0x1081ec3c0) [pid = 1805] [serial = 7] [outer = 0x0] [url = http://example.com/]
[task 2021-02-02T04:06:50.006Z] 04:06:50 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (0x1081ecc80) [pid = 1805] [serial = 10] [outer = 0x0] [url = http://example.com/]
[task 2021-02-02T04:06:50.006Z] 04:06:50 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (0x1081ec040) [pid = 1805] [serial = 5] [outer = 0x0] [url = about:blank]
[task 2021-02-02T04:06:50.007Z] 04:06:50 INFO - GECKO(1788) | [Child 1805: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (0x1081ec200) [pid = 1805] [serial = 3] [outer = 0x0] [url = about:blank]
[task 2021-02-02T04:06:50.090Z] 04:06:50 INFO - GECKO(1788) | MEMORY STAT | vsize 7836MB | residentFast 347MB | heapAllocated 123MB
[task 2021-02-02T04:06:50.090Z] 04:06:50 INFO - TEST-OK | browser/base/content/test/tabcrashed/browser_withoutDump.js | took 994ms
task 2021-02-02T04:06:57.070Z] 04:06:57 INFO - GECKO(1788) | Completed ShutdownLeaks collections in process 1788
[task 2021-02-02T04:06:57.070Z] 04:06:57 INFO - TEST-START | Shutdown
[task 2021-02-02T04:06:57.070Z] 04:06:57 INFO - Browser Chrome Test Summary
[task 2021-02-02T04:06:57.071Z] 04:06:57 INFO - Passed: 58
[task 2021-02-02T04:06:57.071Z] 04:06:57 INFO - Failed: 0
[task 2021-02-02T04:06:57.071Z] 04:06:57 INFO - Todo: 0
[task 2021-02-02T04:06:57.071Z] 04:06:57 INFO - Mode: e10s
[task 2021-02-02T04:06:57.071Z] 04:06:57 INFO - *** End BrowserChrome Test Results ***
[task 2021-02-02T04:06:59.082Z] 04:06:59 INFO - TEST-INFO | Main app process: exit 0
[task 2021-02-02T04:06:59.082Z] 04:06:59 INFO - TEST-INFO | Confirming we saw 86 DOCSHELL created and 47 destroyed log strings.
[task 2021-02-02T04:06:59.082Z] 04:06:59 INFO - TEST-INFO | Confirming we saw 236 DOMWINDOW created and 131 destroyed log strings.
[task 2021-02-02T04:06:59.082Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_autoSubmitRequest.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.083Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_autoSubmitRequest.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.083Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_clearEmail.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.083Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_clearEmail.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.083Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_launchFail.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.083Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_launchFail.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_multipleCrashedTabs.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_multipleCrashedTabs.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_printpreview_crash.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_printpreview_crash.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_showForm.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.084Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_showForm.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_shown.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_shown.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_shownRestartRequired.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_shownRestartRequired.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_withoutDump.js | This test created 0 hidden window(s)
[task 2021-02-02T04:06:59.085Z] 04:06:59 INFO - TEST-INFO | browser/base/content/test/tabcrashed/browser_withoutDump.js | This test created 1 hidden docshell(s)
[task 2021-02-02T04:06:59.086Z] 04:06:59 INFO - runtests.py | Application ran for: 0:00:53.886175
[task 2021-02-02T04:06:59.187Z] 04:06:59 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2021-02-02T04:06:59.187Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1799.log
[task 2021-02-02T04:06:59.187Z] 04:06:59 INFO - ==> process 1799 will purposefully crash
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1820.log
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 1820
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - | | Per-Inst Leaked| Total Rem|
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - 0 |TOTAL | 44 0| 33966 0|
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.188Z] 04:06:59 INFO - nsTraceRefcnt::DumpStatistics: 624 entries
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1822.log
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - ==> process 1822 will purposefully crash
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1823.log
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - ==> process 1823 will purposefully crash
[task 2021-02-02T04:06:59.189Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks.log
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 1788
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - | | Per-Inst Leaked| Total Rem|
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - 0 |TOTAL | 38 464|10878980 11|
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - 1254 |ThreadSafeWeakReference<UnscaledFont> | 24 24| 7 1|
[task 2021-02-02T04:06:59.190Z] 04:06:59 INFO - 1295 |UnscaledFontMac | 56 56| 8 1|
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - 1450 |gfxFontEntry | 320 320| 609 1|
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - 1968 |nsStringBuffer | 8 16| 234910 2|
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - 2003 |nsTArray_base | 8 48| 4472361 6|
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - nsTraceRefcnt::DumpStatistics: 2120 entries
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-INFO | leakcheck | default leaked 1 ThreadSafeWeakReference<UnscaledFont>
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-INFO | leakcheck | default leaked 1 UnscaledFontMac
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-INFO | leakcheck | default leaked 1 gfxFontEntry
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-INFO | leakcheck | default leaked 2 nsStringBuffer
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-INFO | leakcheck | default leaked 6 nsTArray_base
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 464 bytes leaked (ThreadSafeWeakReference<UnscaledFont>, UnscaledFontMac, gfxFontEntry, nsStringBuffer, nsTArray_base)
[task 2021-02-02T04:06:59.191Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1812.log
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - ==> process 1812 will purposefully crash
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1797.log
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - ==> process 1797 will purposefully crash
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1805.log
[task 2021-02-02T04:06:59.192Z] 04:06:59 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 1805
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - | | Per-Inst Leaked| Total Rem|
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - 0 |TOTAL | 34 0| 471609 0|
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - nsTraceRefcnt::DumpStatistics: 834 entries
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2021-02-02T04:06:59.193Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1795.log
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - ==> process 1795 will purposefully crash
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1810.log
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - ==> process 1810 will purposefully crash
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1814.log
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - ==> process 1814 will purposefully crash
[task 2021-02-02T04:06:59.194Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1790.log
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - ==> process 1790 will purposefully crash
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1791.log
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 1791
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - | | Per-Inst Leaked| Total Rem|
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO - 0 |TOTAL | 36 0| 208655 0|
[task 2021-02-02T04:06:59.195Z] 04:06:59 INFO -
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - nsTraceRefcnt::DumpStatistics: 939 entries
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1801.log
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - ==> process 1801 will purposefully crash
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1803.log
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - ==> process 1803 will purposefully crash
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1793.log
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - ==> process 1793 will purposefully crash
[task 2021-02-02T04:06:59.196Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1792.log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - ==> process 1792 will purposefully crash
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1816.log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - ==> process 1816 will purposefully crash
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - leakcheck | Processing leak log file /var/folders/4y/fxf4tjpj6hz4v2ddcs7_hln8000017/T/tmpa3gRos.mozrunner/runtests_leaks_tab_pid1802.log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - ==> process 1802 will purposefully crash
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - TEST-INFO | leakcheck | tab deliberate crash and thus no leak log
[task 2021-02-02T04:06:59.197Z] 04:06:59 INFO - runtests.py | Running tests: end.```
Comment 1•3 years ago
|
||
Set release status flags based on info from the regressing bug 1687622
Comment 2•3 years ago
|
||
Jonathan, could you please take a look?
It is the same issue as reported in Bug 1688804.
Comment hidden (Intermittent Failures Robot) |
Assignee | ||
Comment 4•3 years ago
|
||
Ugh, that's frustrating - I ran a bunch of retriggers on try before re-landing bug 1687622, but was not able to reproduce this. And currently on autoland it seems quite variable; we have times like 15ea118b8e5602a20e6b0193ec4535b809b009e0 where 20+ retriggers hit the leak every time, but then we also have series of many pushes where it never occurs.
I don't see how the real "root cause" of this can be bug 1687622, as that didn't change anything about the actual allocation, ownership or management of fonts; it just revised our default fallbacks, which means that we will in some cases be picking a different fallback font than before for certain characters.
My hunch is that we have some sort of timing issue or race condition whereby we don't always finish releasing all cached font instances before shutting down, but it's hard to see how to isolate the problem. I'll create a debug build locally and see if I can get it to reproduce at all.
Comment 5•3 years ago
|
||
The difference between permanent and passing seems to be the tests which run for bc1. The failing ones run many more test folders, see the 'Test Groups' tab at the bottom above the failure lines. 5/5 of the failures I checked got reported after browser/base/content/test/tabcrashed got executed. With that folder included, the failure is permanent (that view doesn't show backfill tasks).
Assignee | ||
Comment 6•3 years ago
|
||
Interesting - thanks! Is there a way for me to control whether that will be included in bc1 for a given try push?
Comment 7•3 years ago
|
||
Either do a mach try empty
and then 'Add new Jobs' from the push menu on the top right in Treeherder or mach try fuzzy
with test path.
Comment 8•3 years ago
|
||
(In reply to Sebastian Hengst [:aryx] (needinfo on intermittent or backout) from comment #7)
Either do a
mach try empty
and then 'Add new Jobs'
Meant this in combination with filtering by test path: Filter button in second toolbar at top > Test path > Enter the folder and save.
Updated•3 years ago
|
Comment hidden (Intermittent Failures Robot) |
Comment 10•3 years ago
|
||
Latest failures are under browser/base/content/test/tabcrashed/browser_withoutDump.js
Can't add jobs under that manifest for https://treeherder.mozilla.org/jobs?repo=try&resultStatus=testfailed%2Cbusted%2Cexception&classifiedState=unclassified&revision=6413a07a4bf27b2c2228b927228afc3d496dbff6
Comment hidden (Intermittent Failures Robot) |
Comment 12•3 years ago
|
||
Updated•3 years ago
|
Updated•3 years ago
|
Updated•3 years ago
|
Comment 13•3 years ago
|
||
Jonathan can the failing test be disabled until there is a fix here?
Updated•3 years ago
|
Assignee | ||
Comment 14•3 years ago
|
||
(In reply to Andreea Pavel [:apavel] from comment #13)
Jonathan can the failing test be disabled until there is a fix here?
I guess that's OK.... although I think there's a chance it'll just start to show up on a different test. But it's fine to try.
(I'm not sure whether there is really a bug here; IIUC, this is happening on testcases that have explicitly crashed a tab, which means we may not have had the opportunity to clean up and free resources properly. But I'm hoping to try and figure out what font is involved, and if there's something we can do about it.)
Comment hidden (Intermittent Failures Robot) |
Comment 16•3 years ago
|
||
Pushed by archaeopteryx@coole-files.de: https://hg.mozilla.org/integration/autoland/rev/229f6b955db1 disable browser_withoutDump.js on osx-qr debug r=intermittent-reviewers,jmaher DONTBUILD
Updated•3 years ago
|
Comment 17•3 years ago
|
||
bugherder |
Updated•3 years ago
|
Comment 18•3 years ago
|
||
Still an issue, needs bisection which test(s) trigger the leak.
Assignee | ||
Comment 19•3 years ago
|
||
Assignee | ||
Comment 20•3 years ago
|
||
Depends on D105103
Comment hidden (Intermittent Failures Robot) |
Comment 22•3 years ago
|
||
Pushed by jkew@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/9b1fb42a6171 Fix possible leaks of an unreferenced gfxFont in FindFontForChar and GlobalFontFallback. r=m_kato https://hg.mozilla.org/integration/autoland/rev/7e0472edbc43 Back out changeset 229f6b955db1 to re-enable browser_withoutDump.js test. r=m_kato
Comment 23•3 years ago
|
||
bugherder |
Comment 24•3 years ago
|
||
Backout of changeset 229f6b955db1 to re-enable browser_withoutDump.js test merged:
https://hg.mozilla.org/mozilla-central/rev/7e0472edbc43
Updated•3 years ago
|
Updated•3 years ago
|
Updated•3 years ago
|
Updated•3 years ago
|
Updated•3 years ago
|
Comment hidden (Intermittent Failures Robot) |
Updated•3 years ago
|
Description
•