Closed Bug 1524653 Opened 6 years ago Closed 5 years ago

Intermittent leakcheck | default X bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)

Categories

(Core :: DOM: Service Workers, defect, P2)

Product:
Core
Component:
DOM: Service Workers
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, perf-alert, Whiteboard: [stockwell disabled])

Attachments

(2 files)

Bug 1524653 - disabled test for multiple failures
(deleted), text/x-phabricator-request
Details
Bug 1524653 - Allow leaks in 2dcontext tests,
(deleted), text/x-phabricator-request
Details

#[markdown(off)]
Filed by: ncsoregi [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=225517884&repo=mozilla-central

https://queue.taskcluster.net/v1/task/abI9kCVOQuuHUAZ-7IhikA/runs/0/artifacts/public/logs/live_backing.log

[task 2019-02-01T19:21:46.343Z] 19:21:46 INFO - TEST-INFO | leakcheck | default leaked 128 nsStringBuffer
[task 2019-02-01T19:21:46.344Z] 19:21:46 INFO - TEST-INFO | leakcheck | default leaked 32 nsTArray_base
[task 2019-02-01T19:21:46.345Z] 19:21:46 INFO - TEST-INFO | leakcheck | default leaked 1 nsVariant
[task 2019-02-01T19:21:46.346Z] 19:21:46 INFO - TEST-INFO | leakcheck | default leaked 11 nsWeakReference
[task 2019-02-01T19:21:46.347Z] 19:21:46 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 22904 bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)
[task 2019-02-01T19:21:46.348Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.350Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3695.log
[task 2019-02-01T19:21:46.351Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.352Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3695
[task 2019-02-01T19:21:46.353Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.354Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.355Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.356Z] 19:21:46 INFO - 0 |TOTAL | 42 0| 32019 0|
[task 2019-02-01T19:21:46.357Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.359Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 831 entries
[task 2019-02-01T19:21:46.360Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.361Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3626.log
[task 2019-02-01T19:21:46.362Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.363Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3626
[task 2019-02-01T19:21:46.364Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.365Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.367Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.368Z] 19:21:46 INFO - 0 |TOTAL | 42 0| 33171 0|
[task 2019-02-01T19:21:46.369Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.370Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 841 entries
[task 2019-02-01T19:21:46.371Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.372Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3775.log
[task 2019-02-01T19:21:46.373Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.374Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3775
[task 2019-02-01T19:21:46.375Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.377Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.378Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.379Z] 19:21:46 INFO - 0 |TOTAL | 47 0| 22461 0|
[task 2019-02-01T19:21:46.380Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.382Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 412 entries
[task 2019-02-01T19:21:46.383Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.384Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3657.log
[task 2019-02-01T19:21:46.385Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.387Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3657
[task 2019-02-01T19:21:46.388Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.389Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.390Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.392Z] 19:21:46 INFO - 0 |TOTAL | 41 0| 45347 0|
[task 2019-02-01T19:21:46.393Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.394Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 895 entries
[task 2019-02-01T19:21:46.395Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.397Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3459.log
[task 2019-02-01T19:21:46.398Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.399Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3459
[task 2019-02-01T19:21:46.401Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.402Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.403Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.405Z] 19:21:46 INFO - 0 |TOTAL | 38 0| 196282 0|
[task 2019-02-01T19:21:46.406Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.408Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 792 entries
[task 2019-02-01T19:21:46.409Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.410Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3530.log
[task 2019-02-01T19:21:46.412Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.413Z] 19:21:46 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3530
[task 2019-02-01T19:21:46.414Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.416Z] 19:21:46 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-02-01T19:21:46.417Z] 19:21:46 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-02-01T19:21:46.419Z] 19:21:46 INFO - 0 |TOTAL | 43 0| 51218 0|
[task 2019-02-01T19:21:46.420Z] 19:21:46 INFO -
[task 2019-02-01T19:21:46.421Z] 19:21:46 INFO - nsTraceRefcnt::DumpStatistics: 889 entries
[task 2019-02-01T19:21:46.423Z] 19:21:46 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-02-01T19:21:46.424Z] 19:21:46 INFO - leakcheck | Processing leak log file /tmp/tmpk96XvJ.mozrunner/runtests_leaks_tab_pid3478.log
[task 2019-02-01T19:21:46.425Z] 19:21:46 INFO -

Last test that ran: dom/serviceworkers/test/test_xslt.html

Looked over ~10 logs and the test failing is 2dcontext/imagebitmap/createImageBitmap-transfer.html

Created a patch to disable this on linux, win and osx, debug, as there were 102 total failures in the last 7 days,

Recent failure log:

[task 2019-03-24T11:54:05.584Z] 11:54:05 INFO - TEST-START | /2dcontext/imagebitmap/createImageBitmap-transfer.html
[task 2019-03-24T11:54:05.587Z] 11:54:05 INFO - Closing window 23622320129
[task 2019-03-24T11:54:05.704Z] 11:54:05 INFO - PID 899 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-03-24T11:54:05.726Z] 11:54:05 INFO - PID 899 | ++DOCSHELL 0xe6d12800 == 1 [pid = 1374] [id = {34a1abb7-76b4-4306-b5ce-417a7c8e8d9b}]
[task 2019-03-24T11:54:05.765Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 14 (0xdeb65400) [pid = 957] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.765Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 13 (0xf7092c00) [pid = 957] [serial = 4] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.765Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 12 (0xde595000) [pid = 957] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.765Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 11 (0xde599400) [pid = 957] [serial = 10] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.765Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 10 (0xde597000) [pid = 957] [serial = 8] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.801Z] 11:54:05 INFO - PID 899 | ++DOMWINDOW == 1 (0xf7169460) [pid = 1374] [serial = 1] [outer = (nil)]
[task 2019-03-24T11:54:05.837Z] 11:54:05 INFO - PID 899 | ++DOMWINDOW == 2 (0xe7235800) [pid = 1374] [serial = 2] [outer = 0xf7169460]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | --DOCSHELL 0xe6d10800 == 0 [pid = 1318] [id = {4f9561ab-f01e-4e88-9dfd-ff333d0f367f}] [url = http://web-platform.test:8000/2dcontext/imagebitmap/createImageBitmap-sizeOverflow.html]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 3 (0xf7069460) [pid = 1318] [serial = 1] [outer = (nil)] [url = http://web-platform.test:8000/2dcontext/imagebitmap/createImageBitmap-sizeOverflow.html]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 2 (0xe7233800) [pid = 1318] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 1 (0xe7869400) [pid = 1318] [serial = 4] [outer = (nil)] [url = http://web-platform.test:8000/2dcontext/imagebitmap/createImageBitmap-sizeOverflow.html]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | --DOMWINDOW == 0 (0xe7860000) [pid = 1318] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-03-24T11:54:05.980Z] 11:54:05 INFO - PID 899 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp0cNk49.mozrunner/runtests_leaks_844_tab_pid1403.log
[task 2019-03-24T11:54:06.029Z] 11:54:06 INFO - PID 899 | nsStringStats
[task 2019-03-24T11:54:06.029Z] 11:54:06 INFO - PID 899 | => mAllocCount: 8435
[task 2019-03-24T11:54:06.029Z] 11:54:06 INFO - PID 899 | => mReallocCount: 0
[task 2019-03-24T11:54:06.029Z] 11:54:06 INFO - PID 899 | => mFreeCount: 8435
[task 2019-03-24T11:54:06.030Z] 11:54:06 INFO - PID 899 | => mShareCount: 5869
[task 2019-03-24T11:54:06.031Z] 11:54:06 INFO - PID 899 | => mAdoptCount: 483
[task 2019-03-24T11:54:06.031Z] 11:54:06 INFO - PID 899 | => mAdoptFreeCount: 487
[task 2019-03-24T11:54:06.033Z] 11:54:06 INFO - PID 899 | => Process ID: 1318, Thread ID: 4146968320
[task 2019-03-24T11:54:06.190Z] 11:54:06 INFO - PID 899 | [Parent 899, Main Thread] WARNING: '!parent', file /builds/worker/workspace/build/src/netwerk/ipc/NeckoParent.cpp, line 955
[task 2019-03-24T11:54:06.218Z] 11:54:06 INFO - PID 899 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-03-24T11:54:06.220Z] 11:54:06 INFO - PID 899 | [Child 1403, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/netwerk/base/nsIOService.cpp, line 941
[task 2019-03-24T11:54:06.221Z] 11:54:06 INFO - PID 899 | [Child 1403, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/workspace/build/src/dom/media/CubebUtils.cpp, line 359
[task 2019-03-24T11:54:06.277Z] 11:54:06 INFO - PID 899 | ++DOMWINDOW == 3 (0xe7b12000) [pid = 1374] [serial = 3] [outer = 0xf7169460]
[task 2019-03-24T11:54:06.396Z] 11:54:06 INFO - PID 899 | [Child 1374, Main Thread] WARNING: site security information will not be persisted: file /builds/worker/workspace/build/src/security/manager/ssl/nsSiteSecurityService.cpp, line 506
[task 2019-03-24T11:54:06.432Z] 11:54:06 INFO - PID 899 | ++DOMWINDOW == 4 (0xe7b1b400) [pid = 1374] [serial = 4] [outer = 0xf7169460]
[task 2019-03-24T11:54:06.933Z] 11:54:06 INFO - ...........
[task 2019-03-24T11:54:06.934Z] 11:54:06 INFO - TEST-OK | /2dcontext/imagebitmap/createImageBitmap-transfer.html | took 1347ms

[task 2019-03-24T11:54:09.691Z] 11:54:09 INFO - TEST-INFO | leakcheck | default leaked 1 nsVariant
[task 2019-03-24T11:54:09.691Z] 11:54:09 INFO - TEST-INFO | leakcheck | default leaked 11 nsWeakReference
[task 2019-03-24T11:54:09.692Z] 11:54:09 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 18920 bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)
[task 2019-03-24T11:54:09.692Z] 11:54:09 INFO -
[task 2019-03-24T11:54:09.692Z] 11:54:09 INFO - leakcheck | Processing leak log file /tmp/tmp0cNk49.mozrunner/runtests_leaks_844_tab_pid1318.log
[task 2019-03-24T11:54:09.692Z] 11:54:09 INFO -
[task 2019-03-24T11:54:09.694Z] 11:54:09 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 1318
[task 2019-03-24T11:54:09.694Z] 11:54:09 INFO -
[task 2019-03-24T11:54:09.694Z] 11:54:09 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-03-24T11:54:09.694Z] 11:54:09 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-03-24T11:54:09.695Z] 11:54:09 INFO - 0 |TOTAL | 27 0| 38783 0|
[task 2019-03-24T11:54:09.695Z] 11:54:09 INFO -
[task 2019-03-24T11:54:09.697Z] 11:54:09 INFO - nsTraceRefcnt::DumpStatistics: 867 entries
[task 2019-03-24T11:54:09.697Z] 11:54:09 INFO - TEST-PASS | leakcheck | tab no leaks detected!

There is also bug 1515809 that seems similar to this one.

See Also: → https://bugzilla.mozilla.org/show_bug.cgi?id=1515809
Keywords: checkin-needed, leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]
Pushed by rmaries@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/69f5724fb0f3 disabled test for multiple failures r=jmaher

Hi! It looks like that test was indeed skipped here: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=235783538&repo=autoland&lineNumber=1041.
The last test started before the failure above is /2dcontext/imagebitmap/createImageBitmap-sizeOverflow.html but it also has
TEST-OK | /2dcontext/imagebitmap/createImageBitmap-sizeOverflow.html | took 1172ms a few lines below. After that there are only leakchecks until the failure in the bug
TEST-UNEXPECTED-FAIL | leakcheck | default 18920 bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)
From what I can gather it doesn't look to be test dependent. Maybe James can help with what to do in this case or forward to someone who can. Thank you.

Flags: needinfo?(james)

In this case a leakcheck is done when/after we are closing the browser, not for each specific test, so the leak in this case is related to one or more tests that live in here:
https://searchfox.org/mozilla-central/source/testing/web-platform/tests/2dcontext/imagebitmap

Flags: needinfo?(jmaher)

In this case a leakcheck is done when/after we are closing the browser, not for each specific test, so the leak in this case is related to one or more tests that live in here:
https://searchfox.org/mozilla-central/source/testing/web-platform/tests/2dcontext/imagebitmap

I would backout the patch which landed here as it isn't directly related to this. The only way I know to find the leak is to push to try with each test run individually- often retriggering 100 times is needed; if that doesn't work, it is a combination of tests and we need to do dozens of other runs to find the culprit.

Or we can update the leak annotations in testing/web-platform/meta/2dcontext/__dir__.ini to allow this leak.

Flags: needinfo?(james)

These are the files currently in m-c:
testing/web-platform/meta/2dcontext/building-paths/dir.ini
testing/web-platform/meta/2dcontext/drawing-rectangles-to-the-canvas/dir.ini
testing/web-platform/meta/2dcontext/fill-and-stroke-styles/dir.ini
testing/web-platform/meta/2dcontext/path-objects/dir.ini
testing/web-platform/meta/2dcontext/shadows/dir.ini
testing/web-platform/meta/2dcontext/the-canvas-state/dir.ini
testing/web-platform/meta/dir.ini

I personally haven't done a disable involving leaks. Could you provide some documentation about how this could be done or forward this to someone who can? I assume it should look like something like this. https://searchfox.org/mozilla-central/source/testing/web-platform/meta/__dir__.ini Thank you.

Flags: needinfo?(james)
Backout by csabou@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/9eaef2b8b2c8 Backed out changeset 69f5724fb0f3 for not properly disabling the test.
Pushed by james@hoppipolla.co.uk: https://hg.mozilla.org/integration/autoland/rev/0e1d583b51cc Allow leaks in 2dcontext tests, r=aryx

This is still occurring with a higher leak https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=236292686&repo=autoland&lineNumber=2093

Can I update this bug with the current leak or should I file a new one?

I'm happy for you to update here.

Flags: needinfo?(james)
Summary: Intermittent leakcheck | default 22904 bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...) → Intermittent leakcheck | default X bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)

There are 44 failures associated to this bug in the last 7 days. These are occurring on linux32 and 64 debug.

There are 33 total failures in the last 7 days on linux64 debug.

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=242070391&repo=autoland&lineNumber=12556

[task 2019-04-23T15:25:19.057Z] 15:25:19 INFO - TEST-START | dom/serviceworkers/test/test_xslt.html
[task 2019-04-23T15:26:03.042Z] 15:26:03 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 26856 bytes leaked (BrowsingContext, BrowsingContextGroup, ChannelEventQueue, ChannelWrapper::ChannelWrapperStub, CondVar, ...)
[task 2019-04-23T15:26:03.043Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.045Z] 15:26:03 INFO - leakcheck | Processing leak log file /tmp/tmphtJRqb.mozrunner/runtests_leaks_tab_pid3138.log
[task 2019-04-23T15:26:03.046Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.047Z] 15:26:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3138
[task 2019-04-23T15:26:03.048Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.049Z] 15:26:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-04-23T15:26:03.050Z] 15:26:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-04-23T15:26:03.051Z] 15:26:03 INFO - 0 |TOTAL | 42 0| 34321 0|
[task 2019-04-23T15:26:03.052Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.053Z] 15:26:03 INFO - nsTraceRefcnt::DumpStatistics: 836 entries
[task 2019-04-23T15:26:03.055Z] 15:26:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-04-23T15:26:03.056Z] 15:26:03 INFO - leakcheck | Processing leak log file /tmp/tmphtJRqb.mozrunner/runtests_leaks_tab_pid3190.log
[task 2019-04-23T15:26:03.057Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.058Z] 15:26:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3190
[task 2019-04-23T15:26:03.059Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.060Z] 15:26:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-04-23T15:26:03.061Z] 15:26:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-04-23T15:26:03.063Z] 15:26:03 INFO - 0 |TOTAL | 42 0| 50130 0|
[task 2019-04-23T15:26:03.064Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.065Z] 15:26:03 INFO - nsTraceRefcnt::DumpStatistics: 904 entries
[task 2019-04-23T15:26:03.066Z] 15:26:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-04-23T15:26:03.068Z] 15:26:03 INFO - leakcheck | Processing leak log file /tmp/tmphtJRqb.mozrunner/runtests_leaks_tab_pid2979.log
[task 2019-04-23T15:26:03.069Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.070Z] 15:26:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 2979
[task 2019-04-23T15:26:03.071Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.072Z] 15:26:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-04-23T15:26:03.073Z] 15:26:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-04-23T15:26:03.074Z] 15:26:03 INFO - 0 |TOTAL | 34 0| 174121 0|
[task 2019-04-23T15:26:03.077Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.078Z] 15:26:03 INFO - nsTraceRefcnt::DumpStatistics: 775 entries
[task 2019-04-23T15:26:03.078Z] 15:26:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-04-23T15:26:03.078Z] 15:26:03 INFO - leakcheck | Processing leak log file /tmp/tmphtJRqb.mozrunner/runtests_leaks_tab_pid3000.log
[task 2019-04-23T15:26:03.078Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.079Z] 15:26:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3000
[task 2019-04-23T15:26:03.079Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.079Z] 15:26:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-04-23T15:26:03.080Z] 15:26:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-04-23T15:26:03.081Z] 15:26:03 INFO - 0 |TOTAL | 33 0| 7071337 0|
[task 2019-04-23T15:26:03.082Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.082Z] 15:26:03 INFO - nsTraceRefcnt::DumpStatistics: 1315 entries
[task 2019-04-23T15:26:03.082Z] 15:26:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-04-23T15:26:03.083Z] 15:26:03 INFO - leakcheck | Processing leak log file /tmp/tmphtJRqb.mozrunner/runtests_leaks_tab_pid3293.log
[task 2019-04-23T15:26:03.083Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.084Z] 15:26:03 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 3293
[task 2019-04-23T15:26:03.084Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.085Z] 15:26:03 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-04-23T15:26:03.087Z] 15:26:03 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-04-23T15:26:03.091Z] 15:26:03 INFO - 0 |TOTAL | 43 0| 18745 0|
[task 2019-04-23T15:26:03.092Z] 15:26:03 INFO -
[task 2019-04-23T15:26:03.093Z] 15:26:03 INFO - nsTraceRefcnt::DumpStatistics: 399 entries
[task 2019-04-23T15:26:03.094Z] 15:26:03 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-04-23T15:26:03.095Z] 15:26:03 INFO - runtests.py | Running tests: end.
[task 2019-04-23T15:26:03.143Z] 15:26:03 INFO - Buffered messages finished
[task 2019-04-23T15:26:03.145Z] 15:26:03 INFO - Running manifest: dom/smil/test/mochitest.ini
[task 2019-04-23T15:26:03.246Z] 15:26:03 INFO - Setting pipeline to PAUSED ...
[task 2019-04-23T15:26:03.247Z] 15:26:03 INFO - Pipeline is PREROLLING ...
[task 2019-04-23T15:26:03.248Z] 15:26:03 INFO - Pipeline is PREROLLED ...
[task 2019-04-23T15:26:03.248Z] 15:26:03 INFO - Setting pipeline to PLAYING ...
[task 2019-04-23T15:26:03.249Z] 15:26:03 INFO - New clock: GstSystemClock
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Got EOS from element "pipeline0".
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Execution ended after 0:00:00.033528092
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Setting pipeline to PAUSED ...
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Setting pipeline to READY ...
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - (gst-launch-1.0:3347): GStreamer-CRITICAL **: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Setting pipeline to NULL ...
[task 2019-04-23T15:26:03.286Z] 15:26:03 INFO - Freeing pipeline ...
[task 2019-04-23T15:26:03.746Z] 15:26:03 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2019-04-23T15:26:03.875Z] 15:26:03 INFO - MochitestServer : launching [u'/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpgjCezR.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2019-04-23T15:26:03.875Z] 15:26:03 INFO - runtests.py | Server pid: 3369
[task 2019-04-23T15:26:03.943Z] 15:26:03 INFO - runtests.py | Websocket server pid: 3373
[task 2019-04-23T15:26:04.052Z] 15:26:04 INFO - runtests.py | SSL tunnel pid: 3383
[task 2019-04-23T15:26:04.068Z] 15:26:04 INFO - [3369, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, NS_ERROR_UNEXPECTED) failed with result 0x80004005: file /builds/worker/workspace/build/src/extensions/cookie/nsPermissionManager.cpp, line 1026
[task 2019-04-23T15:26:04.225Z] 15:26:04 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-04-23T15:26:04.226Z] 15:26:04 INFO - [3369, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/workspace/build/src/dom/media/CubebUtils.cpp, line 385
[task 2019-04-23T15:26:04.255Z] 15:26:04 INFO - runtests.py | Running with scheme: http
[task 2019-04-23T15:26:04.256Z] 15:26:04 INFO - runtests.py | Running with e10s: True
[task 2019-04-23T15:26:04.257Z] 15:26:04 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2019-04-23T15:26:04.258Z] 15:26:04 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2019-04-23T15:26:04.259Z] 15:26:04 INFO - runtests.py | Running tests: start.

Andrew, could you please assign this to someone?

Flags: needinfo?(overholt)
Whiteboard: [stockwell disabled] → [stockwell disabled][stockwell needswork:owner]

Unfortunately we don't have anyone available to work on this right now. I'll upgrade it from P3 to P2 so we get to it when we have time.

Flags: needinfo?(overholt)
Priority: P3 → P2

Tentatively moving all bugs whose summaries mention "Fission" (or other Fission-related keywords) but are not assigned to a Fission Milestone to the "?" triage milestone.

This will generate a lot of bugmail, so you can filter your bugmail for the following UUID and delete them en masse:

0ee3c76a-bc79-4eb2-8d12-05dc0b68e732

Fission Milestone: --- → ?
Whiteboard: [stockwell disabled][stockwell needswork:owner] → [stockwell disabled]

Removing Fission flag because this test failure looks like it preceded Fission testing.

Fission Milestone: ? → ---
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
Keywords: perf-alert

:bebe, which perf alert is associated with this bug?

Flags: needinfo?(fstrugariu)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: