1788689 - Perma [tier 2] leakcheck | default 864 bytes leaked (CondVar, Mutex, PUtilityAudioDecoderChild, RefCountedMonitor, UtilityAudioDecoderChild, ...)

Reporter

Description

•

4 years ago

treeherder

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

[task 2022-09-01T13:42:09.779Z] 13:42:09     INFO - zombiecheck | Checking for orphan process with PID: 8188
[task 2022-09-01T13:42:09.779Z] 13:42:09     INFO - Stopping web server
[task 2022-09-01T13:42:09.780Z] 13:42:09     INFO - Server shut down.
[task 2022-09-01T13:42:09.806Z] 13:42:09     INFO - Web server killed.
[task 2022-09-01T13:42:09.806Z] 13:42:09     INFO - Stopping web socket server
[task 2022-09-01T13:42:09.839Z] 13:42:09     INFO - Stopping ssltunnel
[task 2022-09-01T13:42:09.866Z] 13:42:09     INFO - leakcheck | Processing log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks.log
[task 2022-09-01T13:42:09.866Z] 13:42:09     INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.867Z] 13:42:09     INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 1000 bytes
[task 2022-09-01T13:42:09.867Z] 13:42:09     INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2022-09-01T13:42:09.868Z] 13:42:09     INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.868Z] 13:42:09     INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.868Z] 13:42:09     INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.869Z] 13:42:09     INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.869Z] 13:42:09     INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.870Z] 13:42:09     INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.870Z] 13:42:09     INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2022-09-01T13:42:09.870Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks.log
[task 2022-09-01T13:42:09.870Z] 13:42:09     INFO - 
[task 2022-09-01T13:42:09.873Z] 13:42:09     INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 2836
[task 2022-09-01T13:42:09.873Z] 13:42:09     INFO - 
[task 2022-09-01T13:42:09.874Z] 13:42:09     INFO -      |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2022-09-01T13:42:09.875Z] 13:42:09     INFO -      |                                      | Per-Inst   Leaked|   Total      Rem|
[task 2022-09-01T13:42:09.875Z] 13:42:09     INFO -    0 |TOTAL                                 |       40      864|13112278       12|
[task 2022-09-01T13:42:09.875Z] 13:42:09     INFO -  190 |CondVar                               |       36       36|    3676        1|
[task 2022-09-01T13:42:09.875Z] 13:42:09     INFO -  625 |Mutex                                 |       44       44|   53546        1|
[task 2022-09-01T13:42:09.876Z] 13:42:09     INFO -  927 |PUtilityAudioDecoderChild             |      236      236|       2        1|
[task 2022-09-01T13:42:09.877Z] 13:42:09     INFO - 1069 |RefCountedMonitor                     |       84       84|     134        1|
[task 2022-09-01T13:42:09.877Z] 13:42:09     INFO - 1323 |UtilityAudioDecoderChild              |      248      248|       2        1|
[task 2022-09-01T13:42:09.878Z] 13:42:09     INFO - 1326 |UtilityProcessHost::Listener          |        8       24|       7        3|
[task 2022-09-01T13:42:09.878Z] 13:42:09     INFO - 1328 |UtilityProcessManager::Observer       |       16       48|       7        3|
[task 2022-09-01T13:42:09.878Z] 13:42:09     INFO - 1523 |ipc::MessageChannel                   |      144      144|     134        1|
[task 2022-09-01T13:42:09.879Z] 13:42:09     INFO - 
[task 2022-09-01T13:42:09.879Z] 13:42:09     INFO - nsTraceRefcnt::DumpStatistics: 2115 entries
[task 2022-09-01T13:42:09.880Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 CondVar
[task 2022-09-01T13:42:09.880Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 Mutex
[task 2022-09-01T13:42:09.880Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 PUtilityAudioDecoderChild
[task 2022-09-01T13:42:09.881Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 RefCountedMonitor
[task 2022-09-01T13:42:09.881Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 UtilityAudioDecoderChild
[task 2022-09-01T13:42:09.881Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 3 UtilityProcessHost::Listener
[task 2022-09-01T13:42:09.882Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 3 UtilityProcessManager::Observer
[task 2022-09-01T13:42:09.882Z] 13:42:09     INFO - TEST-INFO | leakcheck | default leaked 1 ipc::MessageChannel
[task 2022-09-01T13:42:09.883Z] 13:42:09     INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 864 bytes leaked (CondVar, Mutex, PUtilityAudioDecoderChild, RefCountedMonitor, UtilityAudioDecoderChild, ...)
[task 2022-09-01T13:42:09.883Z] 13:42:09     INFO - 
[task 2022-09-01T13:42:09.883Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_gpu_pid8504.log
[task 2022-09-01T13:42:09.884Z] 13:42:09     INFO - TEST-PASS | leakcheck | gpu no leaks detected!
[task 2022-09-01T13:42:09.884Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_rdd_pid2468.log
[task 2022-09-01T13:42:09.884Z] 13:42:09     INFO - TEST-PASS | leakcheck | rdd no leaks detected!
[task 2022-09-01T13:42:09.885Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid2884.log
[task 2022-09-01T13:42:09.885Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.885Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid2992.log
[task 2022-09-01T13:42:09.887Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.888Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid3120.log
[task 2022-09-01T13:42:09.892Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.893Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid5140.log
[task 2022-09-01T13:42:09.895Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.896Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid5284.log
[task 2022-09-01T13:42:09.899Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.899Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid6316.log
[task 2022-09-01T13:42:09.902Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.903Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid7128.log
[task 2022-09-01T13:42:09.904Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.905Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_tab_pid8188.log
[task 2022-09-01T13:42:09.907Z] 13:42:09     INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2022-09-01T13:42:09.908Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_utility_pid3836.log
[task 2022-09-01T13:42:09.908Z] 13:42:09     INFO - TEST-UNEXPECTED-FAIL | leakcheck | utility missing output line for total leaks!
[task 2022-09-01T13:42:09.908Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_utility_pid3912.log
[task 2022-09-01T13:42:09.909Z] 13:42:09     INFO - TEST-UNEXPECTED-FAIL | leakcheck | utility missing output line for total leaks!
[task 2022-09-01T13:42:09.909Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_utility_pid6028.log
[task 2022-09-01T13:42:09.910Z] 13:42:09     INFO - TEST-PASS | leakcheck | utility no leaks detected!
[task 2022-09-01T13:42:09.910Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_utility_pid6552.log
[task 2022-09-01T13:42:09.911Z] 13:42:09     INFO - TEST-UNEXPECTED-FAIL | leakcheck | utility missing output line for total leaks!
[task 2022-09-01T13:42:09.911Z] 13:42:09     INFO - leakcheck | Processing leak log file C:\Users\task_166203616748431\AppData\Local\Temp\tmp26ekcplo.mozrunner\runtests_leaks_utility_pid8176.log
[task 2022-09-01T13:42:09.912Z] 13:42:09     INFO - TEST-UNEXPECTED-FAIL | leakcheck | utility missing output line for total leaks!
[task 2022-09-01T13:42:09.912Z] 13:42:09     INFO - runtests.py | Running tests: end.
[task 2022-09-01T13:42:10.449Z] 13:42:10     INFO - Buffered messages finished
[task 2022-09-01T13:42:10.449Z] 13:42:10     INFO - Running manifest: dom\canvas\test\webgl-mochitest\mochitest.ini
[task 2022-09-01T13:42:11.850Z] 13:42:11     INFO - PID 2952 | Z:\task_166203616748431\build\tests\bin\pk12util.exe: PKCS12 IMPORT SUCCESSFUL
[task 2022-09-01T13:42:12.156Z] 13:42:12     INFO - MochitestServer : launching ['Z:\\task_166203616748431\\build\\tests\\bin\\xpcshell.exe', '-g', 'Z:\\task_166203616748431\\build\\application\\firefox', '-f', 'Z:\\task_166203616748431\\build\\tests\\bin\\components\\httpd.js', '-e', "const _PROFILE_PATH = 'C:\\\\Users\\\\task_166203616748431\\\\AppData\\\\Local\\\\Temp\\\\tmpy5jbkv5b.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', 'Z:\\task_166203616748431\\build\\tests\\mochitest\\server.js']
[task 2022-09-01T13:42:12.156Z] 13:42:12     INFO - runtests.py | Server pid: 8328
[task 2022-09-01T13:42:12.158Z] 13:42:12     INFO - runtests.py | Websocket server pid: 3736
[task 2022-09-01T13:42:12.163Z] 13:42:12     INFO - runtests.py | SSL tunnel pid: 2460
[task 2022-09-01T13:42:12.165Z] 13:42:12     INFO -  DLL blocklist was unable to intercept AppInit DLLs.
[task 2022-09-01T13:42:12.251Z] 13:42:12     INFO -  Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2022-09-01T13:42:12.252Z] 13:42:12     INFO -  [Parent 8328, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:124
[task 2022-09-01T13:42:12.254Z] 13:42:12     INFO -  [Parent 8328, Main Thread] WARNING: Failed to get directory to cache.: file /builds/worker/checkouts/gecko/security/sandbox/win/src/sandboxbroker/sandboxBroker.cpp:124
[task 2022-09-01T13:42:12.306Z] 13:42:12     INFO -  [Parent 8328, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:427
[task 2022-09-01T13:42:12.315Z] 13:42:12     INFO - runtests.py | Running with scheme: http
[task 2022-09-01T13:42:12.316Z] 13:42:12     INFO - runtests.py | Running with e10s: True
[task 2022-09-01T13:42:12.316Z] 13:42:12     INFO - runtests.py | Running with fission: True
[task 2022-09-01T13:42:12.316Z] 13:42:12     INFO - runtests.py | Running with cross-origin iframes: False
[task 2022-09-01T13:42:12.317Z] 13:42:12     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2022-09-01T13:42:12.317Z] 13:42:12     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2022-09-01T13:42:12.317Z] 13:42:12     INFO - runtests.py | Running tests: start.
[task 2022-09-01T13:42:12.317Z] 13:42:12     INFO - 
[task 2022-09-01T13:42:12.398Z] 13:42:12     INFO - Application command: Z:\task_166203616748431\build\application\firefox\firefox.exe -marionette --wait-for-browser -foreground -profile C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner
[task 2022-09-01T13:42:12.401Z] 13:42:12     INFO - runtests.py | Application pid: 516
[task 2022-09-01T13:42:12.401Z] 13:42:12     INFO - TEST-INFO | started process GECKO(516)
[task 2022-09-01T13:42:12.467Z] 13:42:12     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks.log
[task 2022-09-01T13:42:12.468Z] 13:42:12     INFO - GECKO(516) | [4676, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:12.504Z] 13:42:12     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: Rejected attempt to change type of pref extensions.formautofill.creditCards.available's user value from bool to string: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:1764
[task 2022-09-01T13:42:13.144Z] 13:42:13     INFO - GECKO(516) | [2022-09-01T13:42:13Z WARN  rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2022-09-01T13:42:13.431Z] 13:42:13     INFO - GECKO(516) | DLL blocklist was unable to intercept AppInit DLLs.
[task 2022-09-01T13:42:13.439Z] 13:42:13     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_gpu_pid8368.log
[task 2022-09-01T13:42:13.439Z] 13:42:13     INFO - GECKO(516) | [8368, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:13.502Z] 13:42:13     INFO - GECKO(516) | 1662039733500	Marionette	INFO	Marionette enabled
[task 2022-09-01T13:42:13.505Z] 13:42:13     INFO - GECKO(516) | 1662039733504	Marionette	TRACE	Received observer notification final-ui-startup
[task 2022-09-01T13:42:13.508Z] 13:42:13     INFO - GECKO(516) | 1662039733507	Marionette	INFO	Listening on port 2828
[task 2022-09-01T13:42:13.508Z] 13:42:13     INFO - GECKO(516) | 1662039733508	Marionette	DEBUG	Marionette is listening
[task 2022-09-01T13:42:13.721Z] 13:42:13     INFO - GECKO(516) | 1662039733720	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:51076
[task 2022-09-01T13:42:13.801Z] 13:42:13     INFO - GECKO(516) | 1662039733800	Marionette	DEBUG	Closed connection 0
[task 2022-09-01T13:42:13.801Z] 13:42:13     INFO - GECKO(516) | 1662039733801	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:51077
[task 2022-09-01T13:42:13.880Z] 13:42:13     INFO - GECKO(516) | [GPU 8368, Renderer] WARNING: Failed to bind API to GL!: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:617
[task 2022-09-01T13:42:13.880Z] 13:42:13     INFO - GECKO(516) | [GPU 8368, Renderer] WARNING: Failed to create GLContext from PBuffer: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:1153
[task 2022-09-01T13:42:13.881Z] 13:42:13     INFO - GECKO(516) | [GPU 8368, Renderer] WARNING: Failed to create EGLContext with khr_rbab_attribs: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:715
[task 2022-09-01T13:42:13.881Z] 13:42:13     INFO - GECKO(516) | Initializing context 0334A000 surface 03323C40 on display 019B0700
[task 2022-09-01T13:42:13.882Z] 13:42:13     INFO - GECKO(516) | GL_VENDOR: Google Inc. (NVIDIA)
[task 2022-09-01T13:42:13.882Z] 13:42:13     INFO - GECKO(516) | mVendor: NVIDIA
[task 2022-09-01T13:42:13.883Z] 13:42:13     INFO - GECKO(516) | GL_RENDERER: ANGLE (NVIDIA, NVIDIA Tesla M60 Direct3D11 vs_5_0 ps_5_0, D3D11-23.21.13.9181)
[task 2022-09-01T13:42:13.883Z] 13:42:13     INFO - GECKO(516) | mRenderer: Unknown
[task 2022-09-01T13:42:13.883Z] 13:42:13     INFO - GECKO(516) | mIsMesa: 0
[task 2022-09-01T13:42:13.925Z] 13:42:13     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1234
[task 2022-09-01T13:42:14.044Z] 13:42:14     INFO - GECKO(516) | [GPU 8368, COM MTA] WARNING: MFTEnumEx returned no IMFActivate instances: file /builds/worker/checkouts/gecko/dom/media/platforms/wmf/MFTDecoder.cpp:81
[task 2022-09-01T13:42:14.254Z] 13:42:14     INFO - GECKO(516) | 1662039734253	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2022-09-01T13:42:14.261Z] 13:42:14     INFO - GECKO(516) | 1662039734261	Marionette	DEBUG	Waiting for initial application window
[task 2022-09-01T13:42:14.402Z] 13:42:14     INFO - GECKO(516) | [Parent 4676, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1754
[task 2022-09-01T13:42:14.402Z] 13:42:14     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!mColorAccent', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:480
[task 2022-09-01T13:42:14.420Z] 13:42:14     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid7324.log
[task 2022-09-01T13:42:14.420Z] 13:42:14     INFO - GECKO(516) | [7324, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:14.422Z] 13:42:14     INFO - GECKO(516) | [2022-09-01T13:42:14Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-09-01T13:42:14.448Z] 13:42:14     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!scrollbar', file /builds/worker/checkouts/gecko/widget/Theme.cpp:1073
[task 2022-09-01T13:42:14.491Z] 13:42:14     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!mColorAccent', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:480
[task 2022-09-01T13:42:14.583Z] 13:42:14     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid1272.log
[task 2022-09-01T13:42:14.584Z] 13:42:14     INFO - GECKO(516) | [1272, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:14.674Z] 13:42:14     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:14.685Z] 13:42:14     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:14.693Z] 13:42:14     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:14.700Z] 13:42:14     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:14.710Z] 13:42:14     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:14.816Z] 13:42:14     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid5568.log
[task 2022-09-01T13:42:14.817Z] 13:42:14     INFO - GECKO(516) | [5568, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:14.828Z] 13:42:14     INFO - GECKO(516) | [2022-09-01T13:42:14Z WARN  webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2022-09-01T13:42:15.015Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!mColorAccent', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:480
[task 2022-09-01T13:42:15.017Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!mColorAccent', file /builds/worker/checkouts/gecko/widget/windows/nsLookAndFeel.cpp:480
[task 2022-09-01T13:42:15.054Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: '!scrollbar', file /builds/worker/checkouts/gecko/widget/Theme.cpp:1073
[task 2022-09-01T13:42:15.110Z] 13:42:15     INFO - GECKO(516) | [GPU 8368, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2022-09-01T13:42:15.111Z] 13:42:15     INFO - GECKO(516) | [GPU 8368, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/checkouts/gecko/gfx/layers/apz/src/APZUpdater.cpp:371
[task 2022-09-01T13:42:15.246Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1882
[task 2022-09-01T13:42:15.252Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1600
[task 2022-09-01T13:42:15.308Z] 13:42:15     INFO - GECKO(516) | [Child 7324, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-09-01T13:42:15.310Z] 13:42:15     INFO - GECKO(516) | [2022-09-01T13:42:15Z WARN  audioipc2::ipccore] AudioIPC Server RPC: EventLoop drop - closing connection for Token(0) failed: Custom { kind: NotFound, error: "I/O source not registered with `Registry`" }
[task 2022-09-01T13:42:15.310Z] 13:42:15     INFO - GECKO(516) | [Child 7324, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-09-01T13:42:15.317Z] 13:42:15     INFO - GECKO(516) | [Child 7324, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4604
[task 2022-09-01T13:42:15.419Z] 13:42:15     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid7392.log
[task 2022-09-01T13:42:15.419Z] 13:42:15     INFO - GECKO(516) | [7392, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:15.436Z] 13:42:15     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid7452.log
[task 2022-09-01T13:42:15.436Z] 13:42:15     INFO - GECKO(516) | [7452, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:15.450Z] 13:42:15     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks_tab_pid7944.log
[task 2022-09-01T13:42:15.450Z] 13:42:15     INFO - GECKO(516) | [7944, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:15.986Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Cache2 I/O] WARNING: This API is lossy. Use GetTarget !: file /builds/worker/checkouts/gecko/xpcom/io/nsLocalFileWin.cpp:3552
[task 2022-09-01T13:42:15.986Z] 13:42:15     INFO - GECKO(516) | [Parent 4676, Cache2 I/O] WARNING: This API is lossy. Use GetTarget !: file /builds/worker/checkouts/gecko/xpcom/io/nsLocalFileWin.cpp:3552
[task 2022-09-01T13:42:15.998Z] 13:42:15     INFO - GECKO(516) | DLL blocklist was unable to intercept AppInit DLLs.
[task 2022-09-01T13:42:16.039Z] 13:42:16     INFO - GECKO(516) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_166203616748431\AppData\Local\Temp\tmpy5jbkv5b.mozrunner\runtests_leaks.log
[task 2022-09-01T13:42:16.041Z] 13:42:16     INFO - GECKO(516) | [1964, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-09-01T13:42:16.042Z] 13:42:16     INFO - GECKO(516) | *** You are running in background task mode. ***
[task 2022-09-01T13:42:16.042Z] 13:42:16     INFO - GECKO(516) | *** You are running in headless mode.
[task 2022-09-01T13:42:16.045Z] 13:42:16     INFO - GECKO(516) | [1964, Main Thread] WARNING: ShouldNotProcessUpdates(): NotAnUpdatingTask: file /builds/worker/checkouts/gecko/toolkit/xre/nsAppRunner.cpp:4601
[task 2022-09-01T13:42:16.081Z] 13:42:16     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-09-01T13:42:16.082Z] 13:42:16     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-09-01T13:42:16.121Z] 13:42:16     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: WebProgress Ignored: BrowsingContext is null or discarded: file /builds/worker/checkouts/gecko/dom/ipc/BrowserParent.cpp:3078
[task 2022-09-01T13:42:16.132Z] 13:42:16     INFO - GECKO(516) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at C:\\Users\\task_166203616748431\\AppData\\Local\\Temp\\tmpy5jbkv5b.mozrunner\\search.json.mozlz4", (void 0)))
[task 2022-09-01T13:42:16.201Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/loader/ModuleLoaderBase.cpp:418
[task 2022-09-01T13:42:16.201Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012 (NS_ERROR_FILE_NOT_FOUND): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSModuleLoader.cpp:1535
[task 2022-09-01T13:42:16.204Z] 13:42:16     INFO - GECKO(516) | console.error: "C:\\Users\\task_166203616748431\\AppData\\Local\\Temp\\tmpy5jbkv5b.mozrunner" "" 0 ".purge.bg_rm"
[task 2022-09-01T13:42:16.254Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-09-01T13:42:16.257Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-09-01T13:42:16.265Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: OOPDeinit() without successful OOPInit(): file /builds/worker/checkouts/gecko/toolkit/crashreporter/nsExceptionHandler.cpp:3383
[task 2022-09-01T13:42:16.265Z] 13:42:16     INFO - GECKO(516) | [Parent 1964, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4604
[task 2022-09-01T13:42:16.329Z] 13:42:16     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1234
[task 2022-09-01T13:42:16.393Z] 13:42:16     INFO - GECKO(516) | [Child 1272, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2845
[task 2022-09-01T13:42:17.008Z] 13:42:17     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/ThirdPartyUtil.cpp:421
[task 2022-09-01T13:42:17.008Z] 13:42:17     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1234
[task 2022-09-01T13:42:17.590Z] 13:42:17     INFO - GECKO(516) | [Parent 4676, BgIOThreadPool #1] WARNING: 'GetLastError() != ERROR_FILE_NOT_FOUND', file /builds/worker/checkouts/gecko/browser/components/shell/nsWindowsShellService.cpp:1532
[task 2022-09-01T13:42:17.590Z] 13:42:17     INFO - GECKO(516) | [Parent 4676, BgIOThreadPool #1] WARNING: 'GetLastError() != ERROR_FILE_NOT_FOUND', file /builds/worker/checkouts/gecko/browser/components/shell/nsWindowsShellService.cpp:1532
[task 2022-09-01T13:42:18.270Z] 13:42:18     INFO - GECKO(516) | 1662039738269	Marionette	TRACE	Received observer notification browser-idle-startup-tasks-finished
[task 2022-09-01T13:42:18.281Z] 13:42:18     INFO - GECKO(516) | 1662039738280	RemoteAgent	TRACE	[11] Document already finished loading: about:blank
[task 2022-09-01T13:42:18.300Z] 13:42:18     INFO - GECKO(516) | 1662039738298	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"e982b00a-c0d0-4fb3-9964-2dbf95d9c1c7","capabilities":{"browserName":"firefox","browserVersion":"106.0 ... ownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2022-09-01T13:42:18.321Z] 13:42:18     INFO - GECKO(516) | 1662039738320	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"C:\\Users\\task_166203616748431\\AppData\\Local\\Temp\\tmpnpndwm2e.zip","temporary":false}]
[task 2022-09-01T13:42:18.529Z] 13:42:18     INFO - GECKO(516) | 1662039738529	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2022-09-01T13:42:18.566Z] 13:42:18     INFO - GECKO(516) | 1662039738565	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"C:\\Users\\task_166203616748431\\AppData\\Local\\Temp\\tmpgcp1l7u0.zip","temporary":false}]
[task 2022-09-01T13:42:18.626Z] 13:42:18     INFO - GECKO(516) | 1662039738625	Marionette	DEBUG	1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2022-09-01T13:42:18.641Z] 13:42:18     INFO - GECKO(516) | 1662039738640	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2022-09-01T13:42:18.645Z] 13:42:18     INFO - GECKO(516) | 1662039738644	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2022-09-01T13:42:18.648Z] 13:42:18     INFO - GECKO(516) | 1662039738647	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2022-09-01T13:42:18.649Z] 13:42:18     INFO - GECKO(516) | 1662039738648	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2022-09-01T13:42:18.652Z] 13:42:18     INFO - GECKO(516) | 1662039738651	Marionette	DEBUG	1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... ewSandbox":true,"sandbox":"default","line":2015,"filename":"Z:\\task_166203616748431\\build\\tests\\mochitest\\runtests.py"}]
[task 2022-09-01T13:42:18.662Z] 13:42:18     INFO - GECKO(516) | 1662039738660	Marionette	TRACE	[2] MarionetteCommands actor created for window id 4
[task 2022-09-01T13:42:18.679Z] 13:42:18     INFO - GECKO(516) | 1662039738679	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2022-09-01T13:42:18.711Z] 13:42:18     INFO - GECKO(516) | 1662039738710	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2022-09-01T13:42:18.711Z] 13:42:18     INFO - GECKO(516) | 1662039738710	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2022-09-01T13:42:18.720Z] 13:42:18     INFO - GECKO(516) | 1662039738719	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2022-09-01T13:42:18.724Z] 13:42:18     INFO - GECKO(516) | 1662039738724	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2022-09-01T13:42:18.728Z] 13:42:18     INFO - runtests.py | Waiting for browser...
[task 2022-09-01T13:42:18.732Z] 13:42:18     INFO - GECKO(516) | 1662039738731	Marionette	DEBUG	Closed connection 1
[task 2022-09-01T13:42:19.180Z] 13:42:19     INFO - GECKO(516) | [Parent 4676, Main Thread] WARNING: NS_ENSURE_TRUE(she && she->mInfo->mSharedState.Get()) failed: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:1127
[task 2022-09-01T13:42:19.229Z] 13:42:19     INFO - SimpleTest START
[task 2022-09-01T13:42:19.240Z] 13:42:19     INFO - Dumping test context:
[task 2022-09-01T13:42:19.240Z] 13:42:19     INFO -   fission.autostart=true
[task 2022-09-01T13:42:19.241Z] 13:42:19     INFO - TEST-START | dom/canvas/test/webgl-mochitest/ensure-exts/test_ANGLE_instanced_arrays.html

Norisz Fay [:noriszfay]

Comment 1

•

4 years ago

Hello, could you take a look at this perma tier 2 failure? It started with Bug 1780796. Here's the push with failures. Thank you!

Flags: needinfo?(lissyx+mozillians)

:gerard-majax

Assignee

Updated

•

4 years ago

Flags: needinfo?(lissyx+mozillians)

:gerard-majax

Assignee

Updated

•

4 years ago

Assignee: nobody → lissyx+mozillians

:gerard-majax

Assignee

Comment 2

•

4 years ago

It seems to only hit mingw jobs?

Sandor Molnar[:smolnar]

Comment 3

•

4 years ago

(In reply to Alexandre LISSY :gerard-majax from comment #2)

It seems to only hit mingw jobs?

yes,looking at this push , only mingw jobs seems affected

BugBot [:suhaib / :marco]

Comment 4

•

4 years ago

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

status-firefox104: --- → unaffected

status-firefox105: --- → unaffected

status-firefox106: --- → affected

status-firefox-esr102: --- → unaffected

status-firefox-esr91: --- → unaffected

Comment hidden (Intermittent Failures Robot)

:gerard-majax

Assignee

Comment 6

•

4 years ago

Attached file Bug 1788689 - Disable MITIGATION_DYNAMIC_CODE_DISABLE for more MinGW r?bobowen! — Details

Pulsebot

Comment 7

•

4 years ago

Pushed by alissy@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/6676e54c851a Disable MITIGATION_DYNAMIC_CODE_DISABLE for more MinGW r=bobowen

Andreea Pavel [:apavel]

Comment 8

•

4 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/6676e54c851a

Status: NEW → RESOLVED

Closed: 4 years ago

status-firefox106: affected → fixed

Resolution: --- → FIXED

Target Milestone: --- → 106 Branch

Comment hidden (Intermittent Failures Robot)

Bugzilla

Perma [tier 2] leakcheck | default 864 bytes leaked (CondVar, Mutex, PUtilityAudioDecoderChild, RefCountedMonitor, UtilityAudioDecoderChild, ...)

Categories

(Core :: Graphics: CanvasWebGL, defect, P5)

Tracking

()

People

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

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Crash Data

Security

(public)

User Story

Attachments

(1 file)

Description

Comment 1

Updated

Updated

Comment 2

Comment 3

Comment 4

Comment 5

Comment 6

Comment 7

Comment 8

Comment 9

Comment 10

Attachment

General

Description

File Name

Content Type