1572050 - Perma [tier2-fission] GECKO(1371) | Assertion failure: mListener, at /builds/worker/workspace/build/src/netwerk/protocol/http/HttpChannelChild.cpp:669

Status: RESOLVED WORKSFORME

(Core :: Networking: HTTP, defect, P2)

Description

[Treeherder Bug Filer]

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

---

[task 2019-08-07T11:32:00.939Z] 11:32:00 INFO - TEST-START | browser/base/content/test/trackingUI/browser_trackingUI_fetch.js
[task 2019-08-07T11:32:00.975Z] 11:32:00 INFO - GECKO(1371) | WARN 2019-08-07T11:32:00Z: audio_thread_priority::rt_linux: Could not make thread real-time.
[task 2019-08-07T11:32:00.975Z] 11:32:00 INFO - GECKO(1371) | WARN 2019-08-07T11:32:00Z: audioipc_client: Could not promote audio threads to real-time during initialization.
[task 2019-08-07T11:32:00.992Z] 11:32:00 INFO - GECKO(1371) | ++DOCSHELL 0x7f3ee17ba000 == 1 [pid = 2125] [id = {4e9d0175-b022-4032-8921-005778db3c6a}]
[task 2019-08-07T11:32:01.089Z] 11:32:01 INFO - GECKO(1371) | --DOCSHELL 0x7fa7c895e000 == 4 [pid = 2025] [id = {6f66d029-4cac-4bfd-8309-c2339090580e}] [url = about:blank]
[task 2019-08-07T11:32:01.090Z] 11:32:01 INFO - GECKO(1371) | --DOCSHELL 0x7fa7c8953800 == 3 [pid = 2025] [id = {1d2d396b-30bd-464c-a88b-3ad16b6629e8}] [url = ]
[task 2019-08-07T11:32:01.091Z] 11:32:01 INFO - GECKO(1371) | --DOCSHELL 0x7fa7c8961000 == 2 [pid = 2025] [id = {01e4eae3-c86a-4eef-9667-30d22311b65a}] [url = ]
[task 2019-08-07T11:32:01.092Z] 11:32:01 INFO - GECKO(1371) | --DOCSHELL 0x7fa7c8965000 == 1 [pid = 2025] [id = {0fc2d042-3ca4-4907-9537-dc6f1fdc0e1a}] [url = ]
[task 2019-08-07T11:32:01.092Z] 11:32:01 INFO - GECKO(1371) | --DOCSHELL 0x7fa7c8dbc800 == 0 [pid = 2025] [id = {b0ed681d-da92-4635-8ade-8c7b599c9eba}] [url = http://example.org/browser/browser/base/content/test/trackingUI/trackingPage.html]
[task 2019-08-07T11:32:01.113Z] 11:32:01 INFO - GECKO(1371) | ++DOMWINDOW == 1 (0x7f3ee1794d40) [pid = 2125] [serial = 1] [outer = (nil)]
[task 2019-08-07T11:32:01.128Z] 11:32:01 INFO - GECKO(1371) | [Child 2125, Main Thread] WARNING: 'self->mIsBeingDestroyed', file /builds/worker/workspace/build/src/docshell/base/nsDocShell.cpp, line 13190
[task 2019-08-07T11:32:01.129Z] 11:32:01 INFO - GECKO(1371) | [Child 2125, Main Thread] WARNING: NS_ENSURE_TRUE(currentInner) failed: file /builds/worker/workspace/build/src/dom/base/WindowDestroyedEvent.cpp, line 106
[task 2019-08-07T11:32:01.150Z] 11:32:01 INFO - GECKO(1371) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpiw0HSA.mozrunner/runtests_leaks_tab_pid2146.log
[task 2019-08-07T11:32:01.194Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 6 (0x7fa7c8d95d40) [pid = 2025] [serial = 1] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/trackingUI/trackingPage.html]
[task 2019-08-07T11:32:01.195Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 5 (0x7fa7c8d30c00) [pid = 2025] [serial = 7] [outer = (nil)] [url = about:blank]
[task 2019-08-07T11:32:01.196Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 4 (0x7fa7c8d23400) [pid = 2025] [serial = 2] [outer = (nil)] [url = about:blank]
[task 2019-08-07T11:32:01.197Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 3 (0x7fa7c8d964c0) [pid = 2025] [serial = 6] [outer = (nil)] [url = about:blank]
[task 2019-08-07T11:32:01.200Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 2 (0x7fa7c9dba000) [pid = 2025] [serial = 3] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/trackingUI/trackingPage.html]
[task 2019-08-07T11:32:01.201Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 1 (0x7fa7c9d0d400) [pid = 2025] [serial = 5] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/trackingUI/trackingPage.html]
[task 2019-08-07T11:32:01.202Z] 11:32:01 INFO - GECKO(1371) | --DOMWINDOW == 0 (0x7fa7c9ee4800) [pid = 2025] [serial = 9] [outer = (nil)] [url = http://example.org/browser/browser/base/content/test/trackingUI/trackingPage.html]
[task 2019-08-07T11:32:01.218Z] 11:32:01 INFO - GECKO(1371) | [Parent 1371, Main Thread] WARNING: Constructing RangeBoundary with invalid value: 'mRef || aOffset == 0', file /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/RangeBoundary.h, line 79
[task 2019-08-07T11:32:01.219Z] 11:32:01 INFO - GECKO(1371) | [Parent 1371, Main Thread] WARNING: Constructing RangeBoundary with invalid value: 'mRef || aOffset == 0', file /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/RangeBoundary.h, line 79
[task 2019-08-07T11:32:01.226Z] 11:32:01 INFO - GECKO(1371) | [Child 2025, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/workspace/build/src/xpcom/base/nsCycleCollector.cpp, line 3361
[task 2019-08-07T11:32:01.263Z] 11:32:01 INFO - GECKO(1371) | [Child 2025, 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-07T11:32:01.264Z] 11:32:01 INFO - GECKO(1371) | [Child 2025, 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-07T11:32:01.264Z] 11:32:01 INFO - GECKO(1371) | nsStringStats
[task 2019-08-07T11:32:01.265Z] 11:32:01 INFO - GECKO(1371) | => mAllocCount: 9020
[task 2019-08-07T11:32:01.266Z] 11:32:01 INFO - GECKO(1371) | => mReallocCount: 0
[task 2019-08-07T11:32:01.267Z] 11:32:01 INFO - GECKO(1371) | => mFreeCount: 9020
[task 2019-08-07T11:32:01.268Z] 11:32:01 INFO - GECKO(1371) | => mShareCount: 9150
[task 2019-08-07T11:32:01.268Z] 11:32:01 INFO - GECKO(1371) | => mAdoptCount: 504
[task 2019-08-07T11:32:01.269Z] 11:32:01 INFO - GECKO(1371) | => mAdoptFreeCount: 532
[task 2019-08-07T11:32:01.269Z] 11:32:01 INFO - GECKO(1371) | => Process ID: 2025, Thread ID: 140359049287488
[task 2019-08-07T11:32:01.365Z] 11:32:01 INFO - GECKO(1371) | Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2019-08-07T11:32:01.382Z] 11:32:01 INFO - GECKO(1371) | Assertion failure: mListener, at /builds/worker/workspace/build/src/netwerk/protocol/http/HttpChannelChild.cpp:669
[task 2019-08-07T11:32:01.952Z] 11:32:01 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:03.762Z] 11:32:03 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:05.899Z] 11:32:05 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:06.547Z] 11:32:06 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:07.415Z] 11:32:07 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:10.808Z] 11:32:10 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:14.133Z] 11:32:14 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:15.708Z] 11:32:15 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:17.221Z] 11:32:17 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:17.402Z] 11:32:17 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:25.402Z] 11:32:25 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:25.402Z] 11:32:25 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:32.572Z] 11:32:32 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:34.574Z] 11:32:34 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:36.631Z] 11:32:36 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:38.744Z] 11:32:38 INFO - [1350, Main Thread] WARNING: No active window: file /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp, line 664
[task 2019-08-07T11:32:39.507Z] 11:32:39 INFO - GECKO(1371) | #01: mozilla::net::HttpChannelChild::OnStartRequest(nsresult const&, mozilla::net::nsHttpResponseHead const&, bool const&, mozilla::net::nsHttpHeaderArray const&, mozilla::net::ParentLoadInfoForwarderArgs const&, bool const&, bool const&, bool const&, unsigned long const&, int const&, unsigned int const&, nsTString<char> const&, nsTString<char> const&, mozilla::net::NetAddr const&, mozilla::net::NetAddr const&, unsigned int const&, nsTString<char> const&, long const&, bool const&, bool const&, bool const&, mozilla::net::ResourceTimingStruct const&, bool const&) [netwerk/protocol/http/H

Comment 1

[Noemi Erli[:noemi_erli]]

This seems to be related to: https://hg.mozilla.org/integration/autoland/rev/3011b29e256265bb4f5a9f53feb070b834f1922e

Kris, could you please take a look at this?
Joel, should we just proceed disabling this?

Comment 2

[Joel Maher ( :jmaher ) (UTC -8)]

:noemi, lets disable this and make sure that :kmag is aware of it.

Comment 3

[Kris Maglione [:kmag]]

I'm OK with disabling tests with these crashes, but please make sure the full crash signature is in the comment, since we use those for re-enabling tests as we fix crashes

Comment 4

[Intermittent Failures Robot]

19 failures in 1141 pushes (0.017 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 19

Platform breakdown:

• linux64: 19

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1572050&startday=2019-08-07&endday=2019-08-07&tree=all

Comment 5

[Noemi Erli[:noemi_erli]]

Attachment: Bug 1572050 - Disabled tests on fission for causing crashes r=jmaher

Comment 6

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/690816f5ea09
Disabled tests on fission for causing crashes r=jmaher

Comment 7

[Razvan Maries]

https://hg.mozilla.org/mozilla-central/rev/690816f5ea09

Comment 8

[Intermittent Failures Robot]

34 failures in 4666 pushes (0.007 failures/push) were associated with this bug in the last 7 days.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 34

Platform breakdown:

• linux64: 32
• windows7-32: 1
• windows10-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1572050&startday=2019-08-05&endday=2019-08-11&tree=all

Comment 9

[Kershaw Chang [:kershaw]]

I think this bug might share the same root cause with bug 1553267.

Comment 10

[Bogdan Tara[:bogdan_tara | bogdant]]

This occurs ~9 out of 10 runs on tier 2 (central)
https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&fromchange=076dd880cd6728ebcc021f8ebcf82ce0f515d8d0&searchStr=linux%2Cx64%2Cdebug%2Cmochitests%2Cwith%2Cfission%2Cenabled%2Ctest-linux64%2Fdebug-mochitest-browser-chrome-fis-e10s-9%2Cm-fis%28bc9%29&tochange=deb8af704ac64123a30aba807dd595a6a0879ba5

Comment 11

[Intermittent Failures Robot]

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

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• mozilla-central: 30

Platform breakdown:

• linux64: 30

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1572050&startday=2019-08-12&endday=2019-08-18&tree=all

Comment 12

[Honza Bambas (:mayhemer)]

(In reply to Kershaw Chang [:kershaw] from comment #9)

I think this bug might share the same root cause with bug 1553267.

per Comment 11 it either doesn't, or the fix for that bug is not sufficient.

Comment 13

[Kershaw Chang [:kershaw]]

(In reply to Honza Bambas (:mayhemer) from comment #12)

(In reply to Kershaw Chang [:kershaw] from comment #9)

I think this bug might share the same root cause with bug 1553267.

per Comment 11 it either doesn't, or the fix for that bug is not sufficient.

FWIW, the last failure happened without the fix from bug 1553267. Let's wait for few days.

Comment 14

[Chris Peterson [:cpeterson]]

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

Comment 15

[Chris Peterson [:cpeterson]]

Tracking this test failure for Fission M4.1

kmag asked me to needinfo him on this bug.

Comment 16

[Chris Peterson [:cpeterson]]

Kershaw or Ehsan, is this test failure still a problem for Fission? The tests disabled for Fission in comment 6 have since been re-enabled by bug 1590696.

Comment 17

[Kershaw Chang [:kershaw]]

(In reply to Chris Peterson [:cpeterson] from comment #16)

Kershaw or Ehsan, is this test failure still a problem for Fission? The tests disabled for Fission in comment 6 have since been re-enabled by bug 1590696.

I am not sure, but I think this test is not failed anymore?
By the way, I found that bug 1613002 might be also related to Fission.

Comment 18

[(no longer active)]

(In reply to Chris Peterson [:cpeterson] from comment #16)

Kershaw or Ehsan, is this test failure still a problem for Fission? The tests disabled for Fission in comment 6 have since been re-enabled by bug 1590696.

Ah interesting, I was wondering if there is a bug on file for those tests being disabled. Sorry that I couldn't find this bug. While I can't say for sure that this bug isn't affecting anything else it surely doesn't seem to be affecting those tests any more, so perhaps we should close this one and let bug 1613002 track the other failure we're seeing?

Comment 19

[Chris Peterson [:cpeterson]]

(In reply to Kershaw Chang [:kershaw] from comment #17)

By the way, I found that bug 1613002 might be also related to Fission.

(In reply to :ehsan akhgari from comment #18)

Ah interesting, I was wondering if there is a bug on file for those tests being disabled. Sorry that I couldn't find this bug. While I can't say for sure that this bug isn't affecting anything else it surely doesn't seem to be affecting those tests any more, so perhaps we should close this one and let bug 1613002 track the other failure we're seeing?

Thanks. Bug 1613002 had only two intermittent failures in the last week. It probably doesn't need to block Fission, but I'll track it for Fission in case it becomes a bigger problem.