1613002 - Intermittent GECKO(5942) | Assertion failure: mListener || mOnStartRequestCalled, at /builds/worker/workspace/build/src/netwerk/protocol/http/HttpChannelChild.cpp:693

Status: RESOLVED FIXED

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

Description

[Treeherder Bug Filer]

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=287374409&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/fAhzGV3_QdKDa_vM0A6x2A/runs/0/artifacts/public/logs/live_backing.log

---

[task 2020-02-03T22:54:51.621Z] 22:54:51 INFO - GECKO(5942) | [Child 6024, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 63
[task 2020-02-03T22:54:51.742Z] 22:54:51 INFO - GECKO(5942) | 1580770491737 Marionette DEBUG 1 <- [1,2,null,{"value":"[e-mail]"}]
[task 2020-02-03T22:54:51.778Z] 22:54:51 INFO - GECKO(5942) | 1580770491766 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmpOOAHSx.zip","temporary":false}]
[task 2020-02-03T22:54:51.940Z] 22:54:51 INFO - GECKO(5942) | 1580770491938 Marionette DEBUG 1 <- [1,3,null,{"value":"[e-mail]"}]
[task 2020-02-03T22:54:51.961Z] 22:54:51 INFO - GECKO(5942) | 1580770491947 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2020-02-03T22:54:51.961Z] 22:54:51 INFO - GECKO(5942) | 1580770491949 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2020-02-03T22:54:51.962Z] 22:54:51 INFO - GECKO(5942) | 1580770491953 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-02-03T22:54:51.962Z] 22:54:51 INFO - GECKO(5942) | 1580770491954 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2020-02-03T22:54:51.972Z] 22:54:51 INFO - GECKO(5942) | 1580770491967 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... %2Ftmp&cleanupCrashes=true","flavor":"mochitest"}],"filename":"tests/mochitest/runtests.py","sandbox":"default","line":1772}]
[task 2020-02-03T22:54:51.995Z] 22:54:51 INFO - GECKO(5942) | 1580770491994 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2020-02-03T22:54:52.078Z] 22:54:52 INFO - GECKO(5942) | [2020-02-03T22:54:52Z WARN rkv::backend::impl_safe::environment] Ignoring map_size=16777216
[task 2020-02-03T22:54:52.106Z] 22:54:52 INFO - GECKO(5942) | 1580770492097 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2020-02-03T22:54:52.134Z] 22:54:52 INFO - GECKO(5942) | 1580770492124 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2020-02-03T22:54:52.137Z] 22:54:52 INFO - GECKO(5942) | [Child 6024, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 63
[task 2020-02-03T22:54:52.138Z] 22:54:52 INFO - GECKO(5942) | [Child 6024, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 63
[task 2020-02-03T22:54:52.138Z] 22:54:52 INFO - GECKO(5942) | [Child 6024, Main Thread] WARNING: NS_ENSURE_TRUE(request) failed: file /builds/worker/workspace/build/src/netwerk/base/nsLoadGroup.cpp, line 584
[task 2020-02-03T22:54:52.301Z] 22:54:52 INFO - GECKO(5942) | 1580770492296 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2020-02-03T22:54:52.322Z] 22:54:52 INFO - GECKO(5942) | 1580770492320 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2020-02-03T22:54:52.485Z] 22:54:52 INFO - runtests.py | Waiting for browser...
[task 2020-02-03T22:54:52.626Z] 22:54:52 INFO - GECKO(5942) | 1580770492622 Marionette DEBUG Closed connection 1
[task 2020-02-03T22:54:52.662Z] 22:54:52 INFO - GECKO(5942) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmp863XiP.mozrunner/runtests_leaks_tab_pid6136.log
[task 2020-02-03T22:54:52.838Z] 22:54:52 INFO - GECKO(5942) | [Child 6136, Main Thread] WARNING: No CID found when attempting to map contract ID: file /builds/worker/workspace/build/src/xpcom/components/nsComponentManager.cpp, line 721

Comment 1

[Intermittent Failures Robot]

2 failures in 3364 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform breakdown:

• linux1804-64-qr: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1613002&startday=2020-02-03&endday=2020-02-09&tree=all

Comment 2

[Chris Peterson [:cpeterson]]

Kershaw says (bug 1572050 comment 17) this bug might be related to Fission.

This bug probably doesn't need to block Fission (there were only two intermittent failures in the last week), but I'll track it for Fission's mochitest milestone (M4.1) in case it becomes a bigger problem.

Comment 3

[Intermittent Failures Robot]

1 failures in 5233 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1613002&startday=2020-02-24&endday=2020-03-01&tree=all

Comment 4

[Matt Woodrow (:mattwoodrow)]

Attachment: Bug 1613002 - Fix process switch channel connection race. r?nika

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/65da8f2c8884
Fix process switch channel connection race. r=nika

Comment 6

[Cosmin Sabou [:CosminS]]

https://hg.mozilla.org/mozilla-central/rev/65da8f2c8884