Closed Bug 1575028 Opened 5 years ago Closed 4 years ago

Intermittent Assertion failure: IsAcceptingPromises(), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp:95

Categories

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

defect

Tracking

()

RESOLVED FIXED
mozilla78
Tracking Status
firefox-esr68 --- unaffected
firefox76 --- wontfix
firefox77 --- wontfix
firefox78 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: apavel)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(2 files)

Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=262301746&repo=mozilla-central
Full log: https://queue.taskcluster.net/v1/task/ZRVfzN3TQ8yu9IDM4N6fgg/runs/0/artifacts/public/logs/live_backing.log


[task 2019-08-19T17:11:31.792Z] 17:11:31 INFO - TEST-OK | /fetch/range/sw.https.window.html | took 2734ms
[task 2019-08-19T17:11:31.812Z] 17:11:31 INFO - PID 18805 | 1566234691806 Marionette INFO Stopped listening on port 51640
[task 2019-08-19T17:11:32.034Z] 17:11:32 INFO - PID 18805 | [Parent 18805, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/workspace/build/src/netwerk/protocol/http/nsHttpConnectionMgr.cpp, line 278
[task 2019-08-19T17:11:32.038Z] 17:11:32 INFO - PID 18805 | [Parent 18805, Cache2 I/O] WARNING: 'NS_FAILED(aResult)', file /builds/worker/workspace/build/src/netwerk/cache2/CacheFileChunk.cpp, line 587
[task 2019-08-19T17:11:32.045Z] 17:11:32 INFO - PID 18805 | [Parent 18805, Main Thread] WARNING: '!window', file /builds/worker/workspace/build/src/dom/cache/CacheStorage.cpp, line 575
[task 2019-08-19T17:11:32.046Z] 17:11:32 INFO - PID 18805 | [Child 18868, Main Thread] WARNING: Finishing incremental GC in progress during CC: file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3302
[task 2019-08-19T17:11:32.046Z] 17:11:32 INFO - PID 18805 | [Parent 18805, IPDL Background] WARNING: 'aResult.IsReject()', file /builds/worker/workspace/build/src/dom/workers/remoteworkers/RemoteWorkerController.cpp, line 444
[task 2019-08-19T17:11:32.047Z] 17:11:32 INFO - PID 18805 | [Parent 18805, IPDL Background] WARNING: 'aResult.IsReject()', file /builds/worker/workspace/build/src/dom/workers/remoteworkers/RemoteWorkerControllerParent.cpp, line 108
[task 2019-08-19T17:11:32.056Z] 17:11:32 INFO - PID 18805 | [Child 19076, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 318
[task 2019-08-19T17:11:32.056Z] 17:11:32 INFO - PID 18805 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-08-19T17:11:32.056Z] 17:11:32 INFO - PID 18805 | [Child 19076, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 318
[task 2019-08-19T17:11:32.137Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f8615cc9800 == 4 [pid = 18868] [id = {8a6d1ae4-477a-48a6-9b5e-f468e688de04}] [url = moz-extension://23d2d30a-eaf1-45af-a85a-f07b2f366527/_generated_background_page.html]
[task 2019-08-19T17:11:32.137Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f8615dae800 == 3 [pid = 18868] [id = {e1a377d2-803b-4725-bc5f-84b8dfd6bf7f}] [url = moz-extension://619aec71-6bc7-40c2-9235-bcbabeee4217/_generated_background_page.html]
[task 2019-08-19T17:11:32.137Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f8615da4000 == 2 [pid = 18868] [id = {cc52b277-988f-4e5c-98e8-25147ddc78d1}] [url = moz-extension://55cfd16f-8bd7-4599-9e6c-5b1a6edfba68/_generated_background_page.html]
[task 2019-08-19T17:11:32.138Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f8615da7800 == 1 [pid = 18868] [id = {2f137439-d9ee-4cf4-bd9d-84b5b67a3389}] [url = moz-extension://69582440-789b-4a0a-8f98-05ecedb0520f/_generated_background_page.html]
[task 2019-08-19T17:11:32.138Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f8615dab000 == 0 [pid = 18868] [id = {88c156d1-bdff-4e66-9a7f-0a190a0e7ab5}] [url = moz-extension://481ed748-f38b-4a90-9ef7-0c47a27b6fbf/_generated_background_page.html]
[task 2019-08-19T17:11:32.179Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13f9591000 == 5 [pid = 19076] [id = {418d3164-410b-4f48-82b5-64cbbdfdf3ad}] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.9482143575276093]
[task 2019-08-19T17:11:32.179Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13fd24b800 == 4 [pid = 19076] [id = {919b1a9d-6cd6-4284-898d-fb7dbcd28509}] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.6900770448977248]
[task 2019-08-19T17:11:32.180Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13fda8d800 == 3 [pid = 19076] [id = {0b6ebe41-c253-45f7-8148-91c7e9fb3ac2}] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.48010672598843274]
[task 2019-08-19T17:11:32.180Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13fd250800 == 2 [pid = 19076] [id = {0fbf84fb-f1ca-4351-be7b-f2b2652fb21f}] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.26398076381642444]
[task 2019-08-19T17:11:32.181Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13fd24b000 == 1 [pid = 19076] [id = {9534eb80-cca1-4c8d-b7e6-3d7bd49a296f}] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.29952975252822645]
[task 2019-08-19T17:11:32.181Z] 17:11:32 INFO - PID 18805 | --DOCSHELL 0x7f13fd7c0000 == 0 [pid = 19076] [id = {3ceba5f7-d1cc-4177-8360-2ddd6d96b45e}] [url = https://web-platform.test:8443/fetch/range/sw.https.window.html]
[task 2019-08-19T17:11:32.188Z] 17:11:32 INFO - PID 18805 | WARN 2019-08-19T17:11:32Z: xulstore::persist: tried to remove key that isn't in the store
[task 2019-08-19T17:11:32.188Z] 17:11:32 INFO - PID 18805 | WARN 2019-08-19T17:11:32Z: xulstore::persist: tried to remove key that isn't in the store
[task 2019-08-19T17:11:32.225Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 14 (0x7f86177f16a0) [pid = 18868] [serial = 1] [outer = (nil)] [url = moz-extension://23d2d30a-eaf1-45af-a85a-f07b2f366527/_generated_background_page.html]
[task 2019-08-19T17:11:32.225Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 13 (0x7f8615b12000) [pid = 18868] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:32.226Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 12 (0x7f8617714000) [pid = 18868] [serial = 10] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:32.226Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 11 (0x7f86177f07a0) [pid = 18868] [serial = 9] [outer = (nil)] [url = moz-extension://619aec71-6bc7-40c2-9235-bcbabeee4217/_generated_background_page.html]
[task 2019-08-19T17:11:32.227Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 10 (0x7f86177f1a60) [pid = 18868] [serial = 3] [outer = (nil)] [url = moz-extension://55cfd16f-8bd7-4599-9e6c-5b1a6edfba68/_generated_background_page.html]
[task 2019-08-19T17:11:32.227Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 9 (0x7f8615c58c00) [pid = 18868] [serial = 4] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:32.228Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 8 (0x7f86177f03e0) [pid = 18868] [serial = 5] [outer = (nil)] [url = moz-extension://69582440-789b-4a0a-8f98-05ecedb0520f/_generated_background_page.html]
[task 2019-08-19T17:11:32.228Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 7 (0x7f8615c5b400) [pid = 18868] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:32.228Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 6 (0x7f86177f05c0) [pid = 18868] [serial = 7] [outer = (nil)] [url = moz-extension://481ed748-f38b-4a90-9ef7-0c47a27b6fbf/_generated_background_page.html]
[task 2019-08-19T17:11:32.228Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 5 (0x7f8617711c00) [pid = 18868] [serial = 8] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:32.228Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 4 (0x7f8617711400) [pid = 18868] [serial = 11] [outer = (nil)] [url = moz-extension://23d2d30a-eaf1-45af-a85a-f07b2f366527/_generated_background_page.html]
[task 2019-08-19T17:11:32.229Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 3 (0x7f861771d800) [pid = 18868] [serial = 12] [outer = (nil)] [url = moz-extension://55cfd16f-8bd7-4599-9e6c-5b1a6edfba68/_generated_background_page.html]
[task 2019-08-19T17:11:32.230Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 2 (0x7f861771f000) [pid = 18868] [serial = 13] [outer = (nil)] [url = moz-extension://69582440-789b-4a0a-8f98-05ecedb0520f/_generated_background_page.html]
[task 2019-08-19T17:11:32.230Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 1 (0x7f8617720400) [pid = 18868] [serial = 14] [outer = (nil)] [url = moz-extension://481ed748-f38b-4a90-9ef7-0c47a27b6fbf/_generated_background_page.html]
[task 2019-08-19T17:11:32.232Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 0 (0x7f861795a800) [pid = 18868] [serial = 15] [outer = (nil)] [url = moz-extension://619aec71-6bc7-40c2-9235-bcbabeee4217/_generated_background_page.html]
[task 2019-08-19T17:11:32.232Z] 17:11:32 INFO - PID 18805 | [Child 19076, Main Thread] WARNING: Wrong inner/outer window combination!: file /builds/worker/workspace/build/src/dom/base/Document.cpp, line 6849
[task 2019-08-19T17:11:32.248Z] 17:11:32 INFO - PID 18805 | [Child 18868, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:32.255Z] 17:11:32 INFO - PID 18805 | [Child 18868, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:32.255Z] 17:11:32 INFO - PID 18805 | nsStringStats
[task 2019-08-19T17:11:32.256Z] 17:11:32 INFO - PID 18805 | => mAllocCount: 14831
[task 2019-08-19T17:11:32.256Z] 17:11:32 INFO - PID 18805 | => mReallocCount: 0
[task 2019-08-19T17:11:32.256Z] 17:11:32 INFO - PID 18805 | => mFreeCount: 14831
[task 2019-08-19T17:11:32.257Z] 17:11:32 INFO - PID 18805 | => mShareCount: 8699
[task 2019-08-19T17:11:32.257Z] 17:11:32 INFO - PID 18805 | => mAdoptCount: 456
[task 2019-08-19T17:11:32.257Z] 17:11:32 INFO - PID 18805 | => mAdoptFreeCount: 486
[task 2019-08-19T17:11:32.257Z] 17:11:32 INFO - PID 18805 | => Process ID: 18868, Thread ID: 140214325159744
[task 2019-08-19T17:11:32.265Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 11 (0x7f13fd7176a0) [pid = 19076] [serial = 7] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.29952975252822645]
[task 2019-08-19T17:11:32.265Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 10 (0x7f13fd717880) [pid = 19076] [serial = 9] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.26398076381642444]
[task 2019-08-19T17:11:32.265Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 9 (0x7f13fd7174c0) [pid = 19076] [serial = 5] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.6900770448977248]
[task 2019-08-19T17:11:32.265Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 8 (0x7f13fd717a60) [pid = 19076] [serial = 11] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.48010672598843274]
[task 2019-08-19T17:11:32.266Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 7 (0x7f13fd62f000) [pid = 19076] [serial = 8] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.29952975252822645]
[task 2019-08-19T17:11:32.266Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 6 (0x7f13fd9acc00) [pid = 19076] [serial = 10] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.26398076381642444]
[task 2019-08-19T17:11:32.266Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 5 (0x7f13fd624000) [pid = 19076] [serial = 6] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.6900770448977248]
[task 2019-08-19T17:11:32.266Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 4 (0x7f13fd717c40) [pid = 19076] [serial = 13] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.9482143575276093]
[task 2019-08-19T17:11:32.267Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 3 (0x7f13f9557c00) [pid = 19076] [serial = 14] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.9482143575276093]
[task 2019-08-19T17:11:32.267Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 2 (0x7f14175d2000) [pid = 19076] [serial = 12] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/resources/basic.html?0.48010672598843274]
[task 2019-08-19T17:11:32.267Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 1 (0x7f13fd716f20) [pid = 19076] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/sw.https.window.html]
[task 2019-08-19T17:11:32.267Z] 17:11:32 INFO - PID 18805 | --DOMWINDOW == 0 (0x7f13fd2edc00) [pid = 19076] [serial = 4] [outer = (nil)] [url = https://web-platform.test:8443/fetch/range/sw.https.window.html]
[task 2019-08-19T17:11:32.295Z] 17:11:32 INFO - PID 18805 | [Child 19076, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:32.295Z] 17:11:32 INFO - PID 18805 | [Child 19076, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:32.295Z] 17:11:32 INFO - PID 18805 | nsStringStats
[task 2019-08-19T17:11:32.295Z] 17:11:32 INFO - PID 18805 | => mAllocCount: 13373
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => mReallocCount: 0
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => mFreeCount: 13373
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => mShareCount: 19073
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => mAdoptCount: 879
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => mAdoptFreeCount: 911
[task 2019-08-19T17:11:32.296Z] 17:11:32 INFO - PID 18805 | => Process ID: 19076, Thread ID: 139724290590528
[task 2019-08-19T17:11:32.357Z] 17:11:32 INFO - PID 18805 | [Child 18896, Worker Launcher] WARNING: '!mPromiseHolder.IsEmpty()', file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerOp.cpp, line 420
[task 2019-08-19T17:11:32.357Z] 17:11:32 INFO - PID 18805 | [Child 18896, Worker Launcher] WARNING: 'aResult.IsReject()', file /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerOp.cpp, line 409
[task 2019-08-19T17:11:32.373Z] 17:11:32 INFO - PID 18805 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-08-19T17:11:32.409Z] 17:11:32 INFO - PID 18805 | Assertion failure: IsAcceptingPromises(), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp:95
[task 2019-08-19T17:11:32.409Z] 17:11:32 INFO - PID 18805 | [Parent 18805, IPDL Background] WARNING: 'aOwner->mState == RemoteWorkerController::eTerminated', file /builds/worker/workspace/build/src/dom/workers/remoteworkers/RemoteWorkerController.cpp, line 399
[task 2019-08-19T17:11:32.410Z] 17:11:32 INFO - PID 18805 | [Parent 18805, IPDL Background] WARNING: 'aResult.IsReject()', file /builds/worker/workspace/build/src/dom/workers/remoteworkers/RemoteWorkerControllerParent.cpp, line 108
[task 2019-08-19T17:11:55.429Z] 17:11:55 INFO - PID 18805 | #01: mozilla::dom::ServiceWorkerPrivateImpl::Shutdown() [dom/serviceworkers/ServiceWorkerPrivateImpl.cpp:932]
[task 2019-08-19T17:11:55.429Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.429Z] 17:11:55 INFO - PID 18805 | #02: mozilla::dom::RemoteWorkerControllerChild::RecvTerminated() [dom/workers/remoteworkers/RemoteWorkerControllerChild.cpp:97]
[task 2019-08-19T17:11:55.430Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.430Z] 17:11:55 INFO - PID 18805 | #03: mozilla::dom::PRemoteWorkerControllerChild::OnMessageReceived(IPC::Message const&) [s3:gecko-generated-sources:33ca2280d6fcae74f60330357bc8e9bbb80ed8a1c4ccc355e825459795a02f2d685d3e0c8b41230e2288dbc48bc419d1605c44b56aeb757df8000b4a1f244033/ipc/ipdl/PRemoteWorkerControllerChild.cpp::0]
[task 2019-08-19T17:11:55.430Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.431Z] 17:11:55 INFO - PID 18805 | #04: mozilla::ipc::PBackgroundChild::OnMessageReceived(IPC::Message const&) [s3:gecko-generated-sources:2f5bc768df28311b19143177965573e6baf0359d850066722656e9d6f7e7f13ac2ac88f0b0a979bbb8a32eb148902a1460fc71bf37fa5c35d0777fa83c6d13a3/ipc/ipdl/PBackgroundChild.cpp::5768]
[task 2019-08-19T17:11:55.431Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.431Z] 17:11:55 INFO - PID 18805 | #05: mozilla::ipc::MessageChannel::DispatchAsyncMessage(mozilla::ipc::ActorLifecycleProxy*, IPC::Message const&) [ipc/glue/MessageChannel.cpp:2185]
[task 2019-08-19T17:11:55.431Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.433Z] 17:11:55 INFO - PID 18805 | #06: mozilla::ipc::MessageChannel::DispatchMessage(IPC::Message&&) [ipc/glue/MessageChannel.cpp:2111]
[task 2019-08-19T17:11:55.433Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.433Z] 17:11:55 INFO - PID 18805 | #07: mozilla::ipc::MessageChannel::RunMessage(mozilla::ipc::MessageChannel::MessageTask&) [ipc/glue/MessageChannel.cpp:0]
[task 2019-08-19T17:11:55.433Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.433Z] 17:11:55 INFO - PID 18805 | #08: mozilla::ipc::MessageChannel::MessageTask::Run() [ipc/glue/MessageChannel.cpp:1988]
[task 2019-08-19T17:11:55.434Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.434Z] 17:11:55 INFO - PID 18805 | #09: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1214]
[task 2019-08-19T17:11:55.434Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.435Z] 17:11:55 INFO - PID 18805 | #10: NS_InvokeByIndex
[task 2019-08-19T17:11:55.436Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.436Z] 17:11:55 INFO - PID 18805 | #11: CallMethodHelper::Call() [js/xpconnect/src/XPCWrappedNative.cpp:1187]
[task 2019-08-19T17:11:55.436Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.436Z] 17:11:55 INFO - PID 18805 | #12: XPCWrappedNative::CallMethod(XPCCallContext&, XPCWrappedNative::CallMode) [js/xpconnect/src/XPCWrappedNative.cpp:1149]
[task 2019-08-19T17:11:55.436Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.437Z] 17:11:55 INFO - PID 18805 | #13: XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) [js/xpconnect/src/XPCWrappedNativeJSOps.cpp:943]
[task 2019-08-19T17:11:55.437Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.439Z] 17:11:55 INFO - PID 18805 | #14: CallJSNative(JSContext*, bool ()(JSContext, unsigned int, JS::Value*), JS::CallArgs const&) [js/src/vm/Interpreter.cpp:447]
[task 2019-08-19T17:11:55.439Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.439Z] 17:11:55 INFO - PID 18805 | #15: js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) [js/src/vm/Interpreter.cpp:539]
[task 2019-08-19T17:11:55.439Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.440Z] 17:11:55 INFO - PID 18805 | #16: Interpret(JSContext*, js::RunState&) [js/src/vm/Interpreter.cpp:0]
[task 2019-08-19T17:11:55.440Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.440Z] 17:11:55 INFO - PID 18805 | #17: js::RunScript(JSContext*, js::RunState&) [js/src/vm/Interpreter.cpp:424]
[task 2019-08-19T17:11:55.440Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.441Z] 17:11:55 INFO - PID 18805 | #18: js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) [js/src/vm/Interpreter.cpp:567]
[task 2019-08-19T17:11:55.442Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.442Z] 17:11:55 INFO - PID 18805 | #19: <name omitted> [js/src/vm/Interpreter.cpp:610]
[task 2019-08-19T17:11:55.442Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.442Z] 17:11:55 INFO - PID 18805 | #20: JS_CallFunctionValue(JSContext*, JS::Handle<JSObject*>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) [js/src/jsapi.cpp:2659]
[task 2019-08-19T17:11:55.442Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.443Z] 17:11:55 INFO - PID 18805 | #21: nsXPCWrappedJS::CallMethod(unsigned short, nsXPTMethodInfo const*, nsXPTCMiniVariant*) [js/xpconnect/src/XPCWrappedJSClass.cpp:978]
[task 2019-08-19T17:11:55.443Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.443Z] 17:11:55 INFO - PID 18805 | #22: PrepareAndDispatch [xpcom/reflect/xptcall/md/unix/xptcstubs_x86_64_linux.cpp:125]
[task 2019-08-19T17:11:55.443Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.444Z] 17:11:55 INFO - PID 18805 | #23: SharedStub
[task 2019-08-19T17:11:55.444Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.444Z] 17:11:55 INFO - PID 18805 | #24: nsObserverList::NotifyObservers(nsISupports*, char const*, char16_t const*) [xpcom/ds/nsObserverList.cpp:65]
[task 2019-08-19T17:11:55.444Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.444Z] 17:11:55 INFO - PID 18805 | #25: nsObserverService::NotifyObservers(nsISupports*, char const*, char16_t const*) [xpcom/ds/nsObserverService.cpp:294]
[task 2019-08-19T17:11:55.445Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.446Z] 17:11:55 INFO - PID 18805 | #26: nsXREDirProvider::DoShutdown() [toolkit/xre/nsXREDirProvider.cpp:1096]
[task 2019-08-19T17:11:55.446Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.446Z] 17:11:55 INFO - PID 18805 | #27: ScopedXPCOMStartup::~ScopedXPCOMStartup() [toolkit/xre/nsAppRunner.cpp:1239]
[task 2019-08-19T17:11:55.446Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.447Z] 17:11:55 INFO - PID 18805 | #28: mozilla::UniquePtr<ScopedXPCOMStartup, mozilla::DefaultDelete<ScopedXPCOMStartup> >::reset(ScopedXPCOMStartup*) [mfbt/UniquePtr.h:323]
[task 2019-08-19T17:11:55.447Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.447Z] 17:11:55 INFO - PID 18805 | #29: XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:4776]
[task 2019-08-19T17:11:55.447Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.448Z] 17:11:55 INFO - PID 18805 | #30: XRE_main(int, char**, mozilla::BootstrapConfig const&) [toolkit/xre/nsAppRunner.cpp:4822]
[task 2019-08-19T17:11:55.448Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.448Z] 17:11:55 INFO - PID 18805 | #31: _fini
[task 2019-08-19T17:11:55.448Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.449Z] 17:11:55 INFO - PID 18805 | #32: libc.so.6 + 0x20830
[task 2019-08-19T17:11:55.450Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.450Z] 17:11:55 INFO - PID 18805 | #33: _fini
[task 2019-08-19T17:11:55.450Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.450Z] 17:11:55 INFO - PID 18805 | ExceptionHandler::GenerateDump cloned child 19192ExceptionHandler::WaitForContinueSignal waiting for continue signal...
[task 2019-08-19T17:11:55.451Z] 17:11:55 INFO - PID 18805 | ExceptionHandler::SendContinueSignalToChild sent continue signal to child
[task 2019-08-19T17:11:55.451Z] 17:11:55 INFO - PID 18805 | nsStringStats
[task 2019-08-19T17:11:55.451Z] 17:11:55 INFO - PID 18805 | => mAllocCount: 5952
[task 2019-08-19T17:11:55.452Z] 17:11:55 INFO - PID 18805 | => mReallocCount: 0
[task 2019-08-19T17:11:55.453Z] 17:11:55 INFO - PID 18805 | => mFreeCount: 5952
[task 2019-08-19T17:11:55.453Z] 17:11:55 INFO - PID 18805 | => mShareCount: 3671
[task 2019-08-19T17:11:55.453Z] 17:11:55 INFO - PID 18805 | => mAdoptCount: 73
[task 2019-08-19T17:11:55.454Z] 17:11:55 INFO - PID 18805 | => mAdoptFreeCount: 81
[task 2019-08-19T17:11:55.454Z] 17:11:55 INFO - PID 18805 | => Process ID: 19124, Thread ID: 140600857311040
[task 2019-08-19T17:11:55.454Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 8 (0x7f0fd7513400) [pid = 18896] [serial = 3] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:55.455Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 7 (0x7f0fd5a33800) [pid = 18896] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:55.456Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 6 (0x7f0fd751c000) [pid = 18896] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:55.456Z] 17:11:55 INFO - PID 18805 | --DOCSHELL 0x7f0fd5ac3800 == 1 [pid = 18896] [id = {78603238-3f90-4b3d-aec7-9219e6e39fe3}] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-08-19T17:11:55.457Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 5 (0x7f0fd75ee4c0) [pid = 18896] [serial = 5] [outer = (nil)] [url = about:newtab]
[task 2019-08-19T17:11:55.457Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 4 (0x7f0fd75edf20) [pid = 18896] [serial = 1] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-08-19T17:11:55.457Z] 17:11:55 INFO - PID 18805 | --DOCSHELL 0x7f0fd753e000 == 0 [pid = 18896] [id = {76886021-cd9e-4e9a-895e-0b373d31e780}] [url = about:newtab]
[task 2019-08-19T17:11:55.458Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 3 (0x7f0fd0a4f000) [pid = 18896] [serial = 9] [outer = (nil)] [url = https://web-platform.test:8443/testharness_runner.html]
[task 2019-08-19T17:11:55.459Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 2 (0x7f0fd7517c00) [pid = 18896] [serial = 4] [outer = (nil)] [url = about:blank]
[task 2019-08-19T17:11:55.459Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 1 (0x7f0fd5599400) [pid = 18896] [serial = 8] [outer = (nil)] [url = http://web-platform.test:8000/testharness_runner.html]
[task 2019-08-19T17:11:55.459Z] 17:11:55 INFO - PID 18805 | --DOMWINDOW == 0 (0x7f0fd5594400) [pid = 18896] [serial = 7] [outer = (nil)] [url = about:newtab]
[task 2019-08-19T17:11:55.460Z] 17:11:55 INFO - PID 18805 | [Child 18896, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:55.461Z] 17:11:55 INFO - PID 18805 | [Child 18896, Main Thread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/workspace/build/src/xpcom/base/nsTraceRefcnt.cpp, line 198
[task 2019-08-19T17:11:55.461Z] 17:11:55 INFO - PID 18805 | nsStringStats
[task 2019-08-19T17:11:55.462Z] 17:11:55 INFO - PID 18805 | => mAllocCount: 15020
[task 2019-08-19T17:11:55.462Z] 17:11:55 INFO - PID 18805 | => mReallocCount: 0
[task 2019-08-19T17:11:55.462Z] 17:11:55 INFO - PID 18805 | => mFreeCount: 15020
[task 2019-08-19T17:11:55.463Z] 17:11:55 INFO - PID 18805 | => mShareCount: 23099
[task 2019-08-19T17:11:55.463Z] 17:11:55 INFO - PID 18805 | => mAdoptCount: 682
[task 2019-08-19T17:11:55.463Z] 17:11:55 INFO - PID 18805 | => mAdoptFreeCount: 718
[task 2019-08-19T17:11:55.464Z] 17:11:55 INFO - PID 18805 | => Process ID: 18896, Thread ID: 139706442639168
[task 2019-08-19T17:11:55.480Z] 17:11:55 INFO - Browser exited with return code 11
[task 2019-08-19T17:11:55.480Z] 17:11:55 INFO - PROCESS LEAKS /tmp/tmpSBH06I.mozrunner/runtests_leaks_871.log
[task 2019-08-19T17:11:55.480Z] 17:11:55 INFO - leakcheck | Processing log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871.log for scope /fetch/range
[task 2019-08-19T17:11:55.480Z] 17:11:55 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 51200 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 51200 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2019-08-19T17:11:55.481Z] 17:11:55 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid19076.log
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 19076
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.482Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.483Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.483Z] 17:11:55 INFO - 0 |TOTAL | 40 0| 128064 0|
[task 2019-08-19T17:11:55.486Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.487Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 1125 entries
[task 2019-08-19T17:11:55.487Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.487Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid19124.log
[task 2019-08-19T17:11:55.488Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.488Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 19124
[task 2019-08-19T17:11:55.488Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.488Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.489Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.489Z] 17:11:55 INFO - 0 |TOTAL | 51 0| 17384 0|
[task 2019-08-19T17:11:55.490Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.490Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 601 entries
[task 2019-08-19T17:11:55.491Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.491Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid18868.log
[task 2019-08-19T17:11:55.491Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.492Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 18868
[task 2019-08-19T17:11:55.492Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.493Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.493Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.493Z] 17:11:55 INFO - 0 |TOTAL | 43 0| 73016 0|
[task 2019-08-19T17:11:55.495Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.495Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 762 entries
[task 2019-08-19T17:11:55.495Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.496Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871.log
[task 2019-08-19T17:11:55.496Z] 17:11:55 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default missing output line for total leaks!
[task 2019-08-19T17:11:55.496Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid18989.log
[task 2019-08-19T17:11:55.496Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.497Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 18989
[task 2019-08-19T17:11:55.498Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.498Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.498Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.498Z] 17:11:55 INFO - 0 |TOTAL | 45 0| 44760 0|
[task 2019-08-19T17:11:55.500Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.500Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 929 entries
[task 2019-08-19T17:11:55.500Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.501Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid18896.log
[task 2019-08-19T17:11:55.502Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.502Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 18896
[task 2019-08-19T17:11:55.502Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.502Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.502Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.503Z] 17:11:55 INFO - 0 |TOTAL | 34 0| 251988 0|
[task 2019-08-19T17:11:55.510Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.510Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 1208 entries
[task 2019-08-19T17:11:55.510Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.511Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid19037.log
[task 2019-08-19T17:11:55.511Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.511Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 19037
[task 2019-08-19T17:11:55.511Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.512Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.512Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.512Z] 17:11:55 INFO - 0 |TOTAL | 43 0| 47685 0|
[task 2019-08-19T17:11:55.512Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.514Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 997 entries
[task 2019-08-19T17:11:55.514Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.514Z] 17:11:55 INFO - leakcheck | Processing leak log file /tmp/tmpSBH06I.mozrunner/runtests_leaks_871_tab_pid18950.log
[task 2019-08-19T17:11:55.514Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.515Z] 17:11:55 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 18950
[task 2019-08-19T17:11:55.515Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.515Z] 17:11:55 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2019-08-19T17:11:55.516Z] 17:11:55 INFO - | | Per-Inst Leaked| Total Rem|
[task 2019-08-19T17:11:55.516Z] 17:11:55 INFO - 0 |TOTAL | 43 0| 43933 0|
[task 2019-08-19T17:11:55.519Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.519Z] 17:11:55 INFO - nsTraceRefcnt::DumpStatistics: 889 entries
[task 2019-08-19T17:11:55.520Z] 17:11:55 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2019-08-19T17:11:55.521Z] 17:11:55 INFO - Closing logging queue
[task 2019-08-19T17:11:55.521Z] 17:11:55 INFO - queue closed
[task 2019-08-19T17:11:55.583Z] 17:11:55 INFO - Setting up ssl
[task 2019-08-19T17:11:55.664Z] 17:11:55 INFO - certutil |
[task 2019-08-19T17:11:55.740Z] 17:11:55 INFO - certutil |
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO - certutil |
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO - Certificate Nickname Trust Attributes
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO - SSL,S/MIME,JAR/XPI
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO - web-platform-tests CT,,
[task 2019-08-19T17:11:55.808Z] 17:11:55 INFO -
[task 2019-08-19T17:11:55.824Z] 17:11:55 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpaEkcHT.mozrunner
[task 2019-08-19T17:11:55.884Z] 17:11:55 INFO - Starting runner
[task 2019-08-19T17:11:55.920Z] 17:11:55 INFO - PID 19198 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpaEkcHT.mozrunner/runtests_leaks_871.log
[task 2019-08-19T17:11:56.145Z] 17:11:56 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/extensions/permissions/nsPermissionManager.cpp, line 2901
[task 2019-08-19T17:11:56.346Z] 17:11:56 INFO - PID 19198 | [19198, Main Thread] WARNING: Workers don't support the 'mem.mem.' preference!: file /builds/worker/workspace/build/src/dom/workers/RuntimeService.cpp, line 544
[task 2019-08-19T17:11:57.493Z] 17:11:57 INFO - PID 19198 | 1566234717489 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: mozillaAddons
[task 2019-08-19T17:11:57.493Z] 17:11:57 INFO - PID 19198 | 1566234717490 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: telemetry
[task 2019-08-19T17:11:57.495Z] 17:11:57 INFO - PID 19198 | 1566234717491 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: resource://pdf.js/
[task 2019-08-19T17:11:57.495Z] 17:11:57 INFO - PID 19198 | 1566234717491 addons.webextension.screenshots@mozilla.org WARN Loading extension 'screenshots@mozilla.org': Reading manifest: Invalid extension permission: about:reader*
[task 2019-08-19T17:11:57.938Z] 17:11:57 INFO - PID 19198 | [19198, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/workspace/build/src/dom/media/gmp/GMPServiceParent.cpp, line 1571
[task 2019-08-19T17:11:58.166Z] 17:11:58 INFO - PID 19198 | [19198, Main Thread] WARNING: 'mIndex >= Count()', file /builds/worker/workspace/build/src/xpcom/ds/nsStringEnumerator.cpp, line 202
[task 2019-08-19T17:11:58.327Z] 17:11:58 INFO - PID 19198 | ++DOCSHELL 0x7f4e14bba800 == 1 [pid = 19198] [id = {6ccb7e87-8ab2-4252-8a32-50048a07a225}]
[task 2019-08-19T17:11:58.327Z] 17:11:58 INFO - PID 19198 | ++DOMWINDOW == 1 (0x7f4e1b4866a0) [pid = 19198] [serial = 1] [outer = (nil)]
[task 2019-08-19T17:11:58.329Z] 17:11:58 INFO - PID 19198 | ++DOMWINDOW == 2 (0x7f4e14ca3400) [pid = 19198] [serial = 2] [outer = 0x7f4e1b4866a0]
[task 2019-08-19T17:11:58.409Z] 17:11:58 INFO - PID 19198 | [19198, Main Thread] WARNING: Attempting to get a displayport from a content with no primary frame!: file /builds/worker/workspace/build/src/layout/base/nsLayoutUtils.cpp, line 767
[task 2019-08-19T17:11:58.417Z] 17:11:58 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 374
[task 2019-08-19T17:11:58.782Z] 17:11:58 INFO - PID 19198 | ++DOCSHELL 0x7f4e14ae6000 == 2 [pid = 19198] [id = {f6d3f0b9-b540-473e-a82d-43929c72b0c0}]
[task 2019-08-19T17:11:58.782Z] 17:11:58 INFO - PID 19198 | ++DOMWINDOW == 3 (0x7f4e13cc4020) [pid = 19198] [serial = 3] [outer = (nil)]
[task 2019-08-19T17:11:58.863Z] 17:11:58 INFO - PID 19198 | ++DOCSHELL 0x7f4e13a42000 == 3 [pid = 19198] [id = {4c59dd25-9619-435e-9b89-62a82e8a1943}]
[task 2019-08-19T17:11:58.863Z] 17:11:58 INFO - PID 19198 | ++DOMWINDOW == 4 (0x7f4e13cc4200) [pid = 19198] [serial = 4] [outer = (nil)]
[task 2019-08-19T17:11:58.925Z] 17:11:58 INFO - PID 19198 | [19198, StreamTrans #2] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 371
[task 2019-08-19T17:11:58.940Z] 17:11:58 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 994
[task 2019-08-19T17:11:58.960Z] 17:11:58 INFO - PID 19198 | [19198, StreamTrans #1] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 371
[task 2019-08-19T17:11:58.984Z] 17:11:58 INFO - PID 19198 | [19198, StreamTrans #3] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 371
[task 2019-08-19T17:11:59.112Z] 17:11:59 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 994
[task 2019-08-19T17:11:59.128Z] 17:11:59 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 994
[task 2019-08-19T17:11:59.169Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f4e17596000 == 4 [pid = 19198] [id = {608e390f-61e3-44ae-b1be-48c9e4ab7f96}]
[task 2019-08-19T17:11:59.169Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 5 (0x7f4e13cc45c0) [pid = 19198] [serial = 5] [outer = (nil)]
[task 2019-08-19T17:11:59.169Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 6 (0x7f4e175c1000) [pid = 19198] [serial = 6] [outer = 0x7f4e13cc45c0]
[task 2019-08-19T17:11:59.257Z] 17:11:59 INFO - PID 19198 | [19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 374
[task 2019-08-19T17:11:59.258Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 7 (0x7f4e175be000) [pid = 19198] [serial = 7] [outer = 0x7f4e13cc45c0]
[task 2019-08-19T17:11:59.318Z] 17:11:59 INFO - PID 19198 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpaEkcHT.mozrunner/runtests_leaks_871_tab_pid19261.log
[task 2019-08-19T17:11:59.334Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1096
[task 2019-08-19T17:11:59.354Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1096
[task 2019-08-19T17:11:59.358Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1096
[task 2019-08-19T17:11:59.365Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1096
[task 2019-08-19T17:11:59.365Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/workspace/build/src/widget/PuppetWidget.cpp, line 1096
[task 2019-08-19T17:11:59.441Z] 17:11:59 INFO - PID 19198 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-08-19T17:11:59.542Z] 17:11:59 INFO - PID 19198 | WARN 2019-08-19T17:11:59Z: audio_thread_priority::rt_linux: Could not make thread real-time.
[task 2019-08-19T17:11:59.543Z] 17:11:59 INFO - PID 19198 | WARN 2019-08-19T17:11:59Z: audioipc_client: Could not promote audio threads to real-time during initialization.
[task 2019-08-19T17:11:59.544Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f33ed6c9800 == 1 [pid = 19261] [id = {5d1fccdd-59a9-4268-ab04-1db97d5385fe}]
[task 2019-08-19T17:11:59.600Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 1 (0x7f33ef1ea6a0) [pid = 19261] [serial = 1] [outer = (nil)]
[task 2019-08-19T17:11:59.600Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 2 (0x7f33ed617000) [pid = 19261] [serial = 2] [outer = 0x7f33ef1ea6a0]
[task 2019-08-19T17:11:59.616Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-19T17:11:59.617Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/BrowserChild.cpp, line 2630
[task 2019-08-19T17:11:59.638Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f33ed647000 == 2 [pid = 19261] [id = {9558a502-d870-450a-bb78-432f76cb6fa9}]
[task 2019-08-19T17:11:59.638Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 3 (0x7f33ef1eaa60) [pid = 19261] [serial = 3] [outer = (nil)]
[task 2019-08-19T17:11:59.639Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 4 (0x7f33ef39cc00) [pid = 19261] [serial = 4] [outer = 0x7f33ef1eaa60]
[task 2019-08-19T17:11:59.643Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/BrowserChild.cpp, line 2630
[task 2019-08-19T17:11:59.650Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f33ed64a800 == 3 [pid = 19261] [id = {10d0a2f3-d76a-47bc-8e03-67186d099578}]
[task 2019-08-19T17:11:59.651Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 5 (0x7f33ef1e93e0) [pid = 19261] [serial = 5] [outer = (nil)]
[task 2019-08-19T17:11:59.651Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 6 (0x7f33ef39f400) [pid = 19261] [serial = 6] [outer = 0x7f33ef1e93e0]
[task 2019-08-19T17:11:59.654Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/BrowserChild.cpp, line 2630
[task 2019-08-19T17:11:59.658Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f33ed64e800 == 4 [pid = 19261] [id = {33d6b936-7a67-411e-a5da-8ced2a7e5685}]
[task 2019-08-19T17:11:59.658Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 7 (0x7f33ef1e95c0) [pid = 19261] [serial = 7] [outer = (nil)]
[task 2019-08-19T17:11:59.658Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 8 (0x7f33ed787c00) [pid = 19261] [serial = 8] [outer = 0x7f33ef1e95c0]
[task 2019-08-19T17:11:59.666Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/BrowserChild.cpp, line 2630
[task 2019-08-19T17:11:59.668Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f33ed652000 == 5 [pid = 19261] [id = {897a1095-2133-470f-b72c-a0d48498a303}]
[task 2019-08-19T17:11:59.668Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 9 (0x7f33ef1e97a0) [pid = 19261] [serial = 9] [outer = (nil)]
[task 2019-08-19T17:11:59.669Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 10 (0x7f33ed78a000) [pid = 19261] [serial = 10] [outer = 0x7f33ef1e97a0]
[task 2019-08-19T17:11:59.677Z] 17:11:59 INFO - PID 19198 | [Child 19261, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/workspace/build/src/dom/ipc/BrowserChild.cpp, line 2630
[task 2019-08-19T17:11:59.713Z] 17:11:59 INFO - PID 19198 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpaEkcHT.mozrunner/runtests_leaks_871_tab_pid19289.log
[task 2019-08-19T17:11:59.769Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 11 (0x7f33ed793000) [pid = 19261] [serial = 11] [outer = 0x7f33ef1ea6a0]
[task 2019-08-19T17:11:59.777Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 12 (0x7f33ed794c00) [pid = 19261] [serial = 12] [outer = 0x7f33ef1eaa60]
[task 2019-08-19T17:11:59.792Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 13 (0x7f33ed796800) [pid = 19261] [serial = 13] [outer = 0x7f33ef1e93e0]
[task 2019-08-19T17:11:59.793Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 14 (0x7f33ef366800) [pid = 19261] [serial = 14] [outer = 0x7f33ef1e95c0]
[task 2019-08-19T17:11:59.808Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 15 (0x7f33ef369c00) [pid = 19261] [serial = 15] [outer = 0x7f33ef1e97a0]
[task 2019-08-19T17:11:59.844Z] 17:11:59 INFO - PID 19198 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-08-19T17:11:59.860Z] 17:11:59 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/workspace/build/src/layout/base/nsCSSFrameConstructor.cpp, line 8655
[task 2019-08-19T17:11:59.948Z] 17:11:59 INFO - PID 19198 | WARN 2019-08-19T17:11:59Z: audio_thread_priority::rt_linux: Could not make thread real-time.
[task 2019-08-19T17:11:59.948Z] 17:11:59 INFO - PID 19198 | WARN 2019-08-19T17:11:59Z: audio_thread_priority::rt_linux: Could not make thread real-time.
[task 2019-08-19T17:11:59.949Z] 17:11:59 INFO - PID 19198 | WARN 2019-08-19T17:11:59Z: audioipc_client: Could not promote audio threads to real-time during initialization.
[task 2019-08-19T17:11:59.953Z] 17:11:59 INFO - PID 19198 | ++DOCSHELL 0x7f180a2c3800 == 1 [pid = 19289] [id = {457fc74b-f3bb-4ccb-aaee-396c2ed4c2e2}]
[task 2019-08-19T17:11:59.954Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 8 (0x7f4e11c44800) [pid = 19198] [serial = 8] [outer = 0x7f4e13cc4020]
[task 2019-08-19T17:11:59.969Z] 17:11:59 INFO - PID 19198 | ++DOMWINDOW == 9 (0x7f4e1371b800) [pid = 19198] [serial = 9] [outer = 0x7f4e13cc4200]
[task 2019-08-19T17:12:00.005Z] 17:12:00 INFO - PID 19198 | ++DOMWINDOW == 1 (0x7f180be9ff20) [pid = 19289] [serial = 1] [outer = (nil)]
[task 2019-08-19T17:12:00.007Z] 17:12:00 INFO - PID 19198 | ++DOMWINDOW == 2 (0x7f180a22d800) [pid = 19289] [serial = 2] [outer = 0x7f180be9ff20]
[task 2019-08-19T17:12:01.208Z] 17:12:01 INFO - PID 19198 | ++DOCSHELL 0x7f4e1193b000 == 5 [pid = 19198] [id = {a41e9cd7-0c5c-4854-adcd-cf895a80badf}]
[task 2019-08-19T17:12:01.208Z] 17:12:01 INFO - PID 19198 | ++DOMWINDOW == 10 (0x7f4e1109a3e0) [pid = 19198] [serial = 10] [outer = (nil)]
[task 2019-08-19T17:12:01.208Z] 17:12:01 INFO - PID 19198 | ++DOMWINDOW == 11 (0x7f4e11093000) [pid = 19198] [serial = 11] [outer = 0x7f4e1109a3e0]
[task 2019-08-19T17:12:01.224Z] 17:12:01 INFO - PID 19198 | [Child 19289, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-19T17:12:01.240Z] 17:12:01 INFO - PID 19198 | ++DOMWINDOW == 3 (0x7f180a6a1c00) [pid = 19289] [serial = 3] [outer = 0x7f180be9ff20]
[task 2019-08-19T17:12:01.247Z] 17:12:01 INFO - PID 19198 | [Child 19289, Main Thread] WARNING: NS_ENSURE_SUCCESS(mStatus, *this) failed with result 0x80004005: file /builds/worker/workspace/build/src/obj-firefox/dist/include/nsIURIMutator.h, line 489
[task 2019-08-19T17:12:01.248Z] 17:12:01 INFO - PID 19198 | ++DOMWINDOW == 4 (0x7f180a6a3400) [pid = 19289] [serial = 4] [outer = 0x7f180be9ff20]
[task 2019-08-19T17:12:01.256Z] 17:12:01 INFO - PID 19198 | [Child 19289, Main Thread] WARNING: NS_ENSURE_SUCCESS(mStatus, *this) failed with result 0x80004005: file /builds/worker/workspace/build/src/obj-firefox/dist/include/nsIURIMutator.h, line 489
[task 2019-08-19T17:12:01.418Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/netwerk/cache/nsCacheService.cpp, line 169
[task 2019-08-19T17:12:01.499Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 374
[task 2019-08-19T17:12:01.499Z] 17:12:01 INFO - PID 19198 | ++DOMWINDOW == 12 (0x7f4e0e8d5400) [pid = 19198] [serial = 12] [outer = 0x7f4e1109a3e0]
[task 2019-08-19T17:12:01.583Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/ThirdPartyUtil.cpp, line 374
[task 2019-08-19T17:12:01.585Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/workspace/build/src/parser/html/nsHtml5StreamParser.cpp, line 1142
[task 2019-08-19T17:12:01.585Z] 17:12:01 INFO - PID 19198 | [Parent 19198, StreamTrans #1] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 371
[task 2019-08-19T17:12:01.592Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/worker/workspace/build/src/modules/libjar/nsJARChannel.cpp, line 994
[task 2019-08-19T17:12:01.870Z] 17:12:01 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Failed to get base domain!: file /builds/worker/workspace/build/src/ipc/glue/BackgroundUtils.cpp, line 361
[task 2019-08-19T17:12:02.248Z] 17:12:02 INFO - PID 19198 | [Parent 19198, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x7f4e0da90ec0 (http://mzl.la/1FuID0j).: file /builds/worker/workspace/build/src/storage/mozStoragePrivateHelpers.cpp, line 108
[task 2019-08-19T17:12:03.209Z] 17:12:03 INFO - PID 19198 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpaEkcHT.mozrunner/runtests_leaks_871_tab_pid19344.log
[task 2019-08-19T17:12:03.330Z] 17:12:03 INFO - PID 19198 | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-08-19T17:12:03.446Z] 17:12:03 INFO - PID 19198 | WARN 2019-08-19T17:12:03Z: audio_thread_priority::rt_linux: Could not make thread real-time.
[task 2019-08-19T17:12:03.446Z] 17:12:03 INFO - PID 19198 | WARN 2019-08-19T17:12:03Z: audioipc_client: Could not promote audio threads to real-time during initialization.
[task 2019-08-19T17:12:03.502Z] 17:12:03 INFO - PID 19198 | 1566234723497 Marionette INFO Listening on port 51640
[task 2019-08-19T17:12:03.638Z] 17:12:03 INFO - PID 19198 | [Child 19289, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-19T17:12:03.638Z] 17:12:03 INFO - PID 19198 | ++DOCSHELL 0x7f1809db4800 == 2 [pid = 19289] [id = {02771a0e-890f-47bd-a9da-c621f048f5ec}]
[task 2019-08-19T17:12:03.639Z] 17:12:03 INFO - PID 19198 | ++DOMWINDOW == 5 (0x7f180bea04c0) [pid = 19289] [serial = 5] [outer = (nil)]
[task 2019-08-19T17:12:03.639Z] 17:12:03 INFO - PID 19198 | ++DOMWINDOW == 6 (0x7f180a261000) [pid = 19289] [serial = 6] [outer = 0x7f180bea04c0]
[task 2019-08-19T17:12:03.750Z] 17:12:03 INFO - PID 19198 | ++DOMWINDOW == 7 (0x7f180ac89800) [pid = 19289] [serial = 7] [outer = 0x7f180bea04c0]
[task 2019-08-19T17:12:03.771Z] 17:12:03 INFO - PID 19198 | [Child 19289, Main Thread] WARNING: NS_ENSURE_SUCCESS(mStatus, *this) failed with result 0x80004005: file /builds/worker/workspace/build/src/obj-firefox/dist/include/nsIURIMutator.h, line 489
[task 2019-08-19T17:12:03.832Z] 17:12:03 INFO - PID 19198 | [Parent 19198, URL Classifier] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/toolkit/components/url-classifier/LookupCache.cpp, line 882
[task 2019-08-19T17:12:03.832Z] 17:12:03 INFO - PID 19198 | [Parent 19198, URL Classifier] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/toolkit/components/url-classifier/LookupCache.cpp, line 882
[task 2019-08-19T17:12:03.879Z] 17:12:03 INFO - PID 19198 | ++DOMWINDOW == 8 (0x7f180ac8d800) [pid = 19289] [serial = 8] [outer = 0x7f180be9ff20]

Hi Perry, are you working on this?
There are 57 total failures in the last 7 days and 111 total failures in the last 30.

There seems to be a spike starting from October 9th: https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2019-09-25&endday=2019-10-25&tree=trunk&bug=1575028 with this merge https://hg.mozilla.org/mozilla-central/pushloghtml?changeset=be9a6289486a6f366e431782b84a0c0633f8fec2

Is it from bug 1456995?

Flags: needinfo?(perry)

Geoff any suggestions here?

Flags: needinfo?(gbrown)

This assertion

https://searchfox.org/mozilla-central/rev/74cc0f4dce444fe0757e2a6b8307d19e4d0e0212/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp#95

was added by bug 1231213. Hopefully :perry can have a look.

From what I can see, this assertion always happens during web-platform test /service-workers/service-worker/xsl-base-url.https.html; perhaps we can resolve the failures in the short term by skipping that test, on debug.

Flags: needinfo?(gbrown)
Regressed by: 1231213
Pushed by rmaries@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/184a83566a58 disable xsl-base-url.https.html on debug to reduce assertion failure r=gbrown
Keywords: leave-open
Whiteboard: [stockwell disable-recommended] → [stockwell disabled]

We appear to have reproduced this in Pernosco: https://pernos.co/debug/ZCVWEwibp2vYvxQkOrgT4A/index.html

The call stack seems to involve JS spinning the XPCOM event loop at shutdown.

I believe that this is resolved by bug 1591101. At the very least, the incorrect behavior captured by the Pernosco recording in comment 17 shouldn't happen with bug 1591101's patch.

Flags: needinfo?(perry)
Summary: Intermittent PID 18805 | Assertion failure: IsAcceptingPromises(), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp:95 → Intermittent Assertion failure: IsAcceptingPromises(), at /builds/worker/workspace/build/src/dom/serviceworkers/ServiceWorkerShutdownBlocker.cpp:95

Hi :apavel, as bug 1591101 is fixed now, do you want to try to re-enable the test ? Thanks!

Flags: needinfo?(apavel)
Assignee: nobody → apavel
Status: NEW → ASSIGNED

Hi Jens, sure, please see attachment.

Flags: needinfo?(apavel)
Keywords: leave-open
Whiteboard: [stockwell disabled]
Pushed by apavel@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/bc06fe69b39d re-enable xsl-base-url.https.html on debug r=jstutte
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla78
Has Regression Range: --- → yes
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: