1442575 - Intermittent leakcheck | tab process: 1248 bytes leaked (DOMGCSliceCallback::InterSliceGCRunner, GCTimerFired::InterSliceGCRunnerFired, nsTArray_base)

Status: RESOLVED INCOMPLETE

(Core :: XPCOM, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=165469218&repo=autoland

https://queue.taskcluster.net/v1/task/XWd1G5WnQE2Cnp_Yzxao3g/runs/2/artifacts/public/logs/live_backing.log

09:52:20     INFO -  nsTraceRefcnt::DumpStatistics: 1073 entries
09:52:20     INFO -  TEST-INFO | leakcheck | tab process: leaked 29 DOMGCSliceCallback::InterSliceGCRunner
09:52:20     INFO -  TEST-INFO | leakcheck | tab process: leaked 2 GCTimerFired::InterSliceGCRunnerFired
09:52:20     INFO -  TEST-INFO | leakcheck | tab process: leaked 1 nsTArray_base
09:52:20    ERROR -  781 ERROR TEST-UNEXPECTED-FAIL | leakcheck | tab process: 1248 bytes leaked (DOMGCSliceCallback::InterSliceGCRunner, GCTimerFired::InterSliceGCRunnerFired, nsTArray_base)
09:52:20     INFO -  runtests.py | Running tests: end.
09:52:21     INFO -  Buffered messages finished
09:52:21     INFO -  0 INFO TEST-START | Shutdown
09:52:21     INFO -  1 INFO Passed:  5124
09:52:21     INFO -  2 INFO Failed:  0
09:52:21     INFO -  3 INFO Todo:    0
09:52:21     INFO -  4 INFO Mode:    e10s
09:52:21     INFO -  5 INFO SimpleTest FINISHED
09:52:21     INFO -  Buffered messages finished
09:52:21     INFO -  SUITE-END | took 365s
09:52:21     INFO - Return code: 0
09:52:21     INFO - TinderboxPrint: mochitest-mochitest-gl<br/>5124/0/0
09:52:21    ERROR - # TBPL FAILURE #
09:52:21  WARNING - setting return code to 2
09:52:21    ERROR - The mochitest suite: mochitest-gl ran with return status: FAILURE
09:52:21     INFO - Running post-action listener: _package_coverage_data
09:52:21     INFO - Running post-action listener: _resource_record_post_action
09:52:21     INFO - [mozharness: 2018-03-02 09:52:21.318000Z] Finished run-tests step (success)
09:52:21     INFO - Running post-run listener: _resource_record_post_run
09:52:21     INFO - Validating Perfherder data against Z:\task_1519983662\mozharness\external_tools\performance-artifact-schema.json
09:52:21     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"subtests": [{"name": "cpu_percent", "value": 37.96428571428572}, {"name": "io_write_bytes", "value": 765260288}, {"name": "io.read_bytes", "value": 184869376}, {"name": "io_write_time", "value": 192}, {"name": "io_read_time", "value": 88}], "extraOptions": ["e10s", "taskcluster-g2.2xlarge"], "name": "mochitest.mochitest-gl.mochitest-gl.7.overall"}, {"subtests": [{"name": "time", "value": 3.447000026702881}, {"name": "cpu_percent", "value": 26.229166666666668}], "name": "mochitest.mochitest-gl.mochitest-gl.7.install"}, {"subtests": [{"name": "time", "value": 0.0009999275207519531}], "name": "mochitest.mochitest-gl.mochitest-gl.7.stage-files"}, {"subtests": [{"name": "time", "value": 377.1300001144409}, {"name": "cpu_percent", "value": 38.10895721925134}], "name": "mochitest.mochitest-gl.mochitest-gl.7.run-tests"}]}
09:52:21     INFO - Total resource usage - Wall time: 380s; CPU: 38.0%; Read bytes: 184869376; Write bytes: 765260288; Read time: 88; Write time: 192
09:52:21     INFO - TinderboxPrint: CPU usage<br/>38.1%
09:52:21     INFO - TinderboxPrint: I/O read bytes / time<br/>184,869,376 / 88
09:52:21     INFO - TinderboxPrint: I/O write bytes / time<br/>765,260,288 / 192
09:52:21     INFO - TinderboxPrint: CPU idle<br/>1,900.3 (62.0%)
09:52:21     INFO - TinderboxPrint: CPU system<br/>472.5 (15.4%)
09:52:21     INFO - TinderboxPrint: CPU user<br/>663.4 (21.6%)
09:52:21     INFO - install - Wall time: 3s; CPU: 26.0%; Read bytes: 6402048; Write bytes: 9814016; Read time: 4; Write time: 1
09:52:21     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
09:52:21     INFO - run-tests - Wall time: 377s; CPU: 38.0%; Read bytes: 176328192; Write bytes: 729565696; Read time: 82; Write time: 191
09:52:21     INFO - Running post-run listener: _upload_blobber_files
09:52:21  WARNING - Blob upload gear skipped. Missing cmdline options.

Comment 1

[Andrew McCreight [:mccr8]]

Hmm, this is concerning. It is similar to bug 1431286 and bug 1427525, but we're leaking 29 DOMGCSliceCallback::InterSliceGCRunner! The other are only leaking one, which can easily be due to some shutdown weirdness we don't really care about, but this looks like a real leak. I can't imagine what has changed with DOM GC scheduling.

Comment 2

[Intermittent Failures Robot]

5 failures in 831 pushes (0.006 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* autoland: 5

Platform breakdown:
* windows10-64-qr: 5

For more details, see:
https://brasstacks.mozilla.com/orangefactor/?display=Bug&bugid=1442575&startday=2018-02-26&endday=2018-03-04&tree=all

Comment 3

[Firefox Bug Husbandry Bot]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup