Closed Bug 1695639 Opened 3 years ago Closed 3 years ago

When running RemoteProtocol tests Firefox downloads and installs updates even when turned off via prefs

Categories

(Toolkit :: Application Update, defect)

defect

Tracking

()

RESOLVED FIXED
88 Branch
Tracking Status
firefox88 --- fixed

People

(Reporter: whimboo, Assigned: whimboo)

References

Details

Attachments

(2 files)

Similar to what we already did for Marionette (bug 1508726) there needs to be a check for the Remote Agent:

https://searchfox.org/mozilla-central/rev/644e42ded761d4f3ce108fa776197730a9a2c535/toolkit/mozapps/update/UpdateService.jsm#3576-3589

When tests as run eg. via Puppeteer or other clients and utilizing our partial CDP implementation updates of Firefox should not be checked, downloaded or installed.

It should be done similar to:

https://searchfox.org/mozilla-central/rev/644e42ded761d4f3ce108fa776197730a9a2c535/browser/base/content/browser.js#8164-8165

Use the preference "app.update.disabledForTesting" to enforce
that no update checks are performed when the Remote Agent is
active.

Assignee: nobody → hskupin
Status: NEW → ASSIGNED
Pushed by hskupin@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/d345b8a1d9ec
[remote] Enforce disabling of update checks. r=remote-protocol-reviewers,jdescottes
https://hg.mozilla.org/integration/autoland/rev/a54388a30704
Prevent application updates when Remote Agent is enabled. r=application-update-reviewers,bytesized

Backed out 2 changesets (bug 1695639) for remote crashes.

Push with failure: https://treeherder.mozilla.org/jobs?repo=autoland&group_state=expanded&selectedTaskRun=V5YUQRhOR8SM9VL42n-_Bw.0&fromchange=106794cdd13b311c712c149dd40b8aba19414ad6&searchStr=os%2Cx%2C10.14%2Cwebrender%2Cdebug%2Cmochitests%2Ctest-macosx1014-64-qr%2Fdebug-mochitest-remote-e10s%2Cremote&tochange=dbdb08503b9b3941f13796a97a584c2f20fc72f3

Backout link: https://hg.mozilla.org/integration/autoland/rev/dbdb08503b9b3941f13796a97a584c2f20fc72f3

Failure log: https://treeherder.mozilla.org/logviewer?job_id=331814392&repo=autoland&lineNumber=19580

[task 2021-03-02T22:12:00.766Z] 22:12:00     INFO - TEST-START | remote/cdp/test/browser/runtime/browser_remoteObjects.js
[task 2021-03-02T22:12:00.766Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x1286b2400 == 11 [pid = 1696] [id = 81]
[task 2021-03-02T22:12:00.766Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 26 (0x1170b2200) [pid = 1696] [serial = 237] [outer = 0x0]
[task 2021-03-02T22:12:00.766Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 27 (0x12890e000) [pid = 1696] [serial = 238] [outer = 0x1170b2200]
[task 2021-03-02T22:12:00.766Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 28 (0x12a5a5400) [pid = 1696] [serial = 239] [outer = 0x1170b2200]
[task 2021-03-02T22:12:00.860Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, nullptr) failed with result 0x804B000A (NS_ERROR_MALFORMED_URI): file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:46
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696, Main Thread] WARNING: NS_ENSURE_TRUE(principal) failed: file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:58
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, nullptr) failed with result 0x804B000A (NS_ERROR_MALFORMED_URI): file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:46
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Parent 1696, Main Thread] WARNING: NS_ENSURE_TRUE(principal) failed: file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:58
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x10e2ef400 == 2 [pid = 1701] [id = 5]
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (0x10e6b6200) [pid = 1701] [serial = 16] [outer = 0x0]
[task 2021-03-02T22:12:00.861Z] 22:12:00     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x10e68e800) [pid = 1701] [serial = 17] [outer = 0x10e6b6200]
[task 2021-03-02T22:12:00.882Z] 22:12:00     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x10e697800) [pid = 1701] [serial = 18] [outer = 0x10e6b6200]
[task 2021-03-02T22:12:01.815Z] 22:12:01     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x11989b400 == 10 [pid = 1696] [id = 79] [url = about:blank]
[task 2021-03-02T22:12:01.815Z] 22:12:01     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x119899800 == 9 [pid = 1696] [id = 76] [url = about:blank]
[task 2021-03-02T22:12:01.815Z] 22:12:01     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x111285c00 == 8 [pid = 1696] [id = 77] [url = about:blank]
[task 2021-03-02T22:12:01.815Z] 22:12:01     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x117607800 == 7 [pid = 1696] [id = 78] [url = about:blank]
[task 2021-03-02T22:12:01.817Z] 22:12:01     INFO - GECKO(1696) | 1614723121813	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":1,"method":"Target.setDiscoverTargets","params":{"discover":true}}
[task 2021-03-02T22:12:01.817Z] 22:12:01     INFO - GECKO(1696) | 1614723121813	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetCreated","params":{"targetInfo":{"targetId":"c854223d-dc44-4d48-84f3-18054ed3a515","type":"page","title":"","url":"about:blank","attached":false,"browserContextId":null}}}
[task 2021-03-02T22:12:01.817Z] 22:12:01     INFO - GECKO(1696) | 1614723121814	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetCreated","params":{"targetInfo":{"targetId":"bf17d339-cb31-a943-83cf-beb84a11b982","type":"browser","attached":false}}}
[task 2021-03-02T22:12:01.824Z] 22:12:01     INFO - GECKO(1696) | 1614723121814	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetCreated","params":{"targetInfo":{"targetId":"e6c4df00-5510-a346-9fc9-473c7d1083e1","type":"page","title":"","url":"about:blank","attached":true,"browserContextId":null}}}
[task 2021-03-02T22:12:01.824Z] 22:12:01     INFO - GECKO(1696) | 1614723121815	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":1,"result":{}}
[task 2021-03-02T22:12:01.833Z] 22:12:01     INFO - GECKO(1696) | 1614723121817	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":2,"method":"Runtime.enable","params":{}}
[task 2021-03-02T22:12:01.891Z] 22:12:01     INFO - GECKO(1696) | 1614723121868	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":2,"result":{}}
[task 2021-03-02T22:12:01.891Z] 22:12:01     INFO - GECKO(1696) | 1614723121868	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Runtime.executionContextCreated","params":{"context":{"id":1,"origin":"about:blank","name":"","auxData":{"isDefault":true,"frameId":"282","type":"default"}}}}
[task 2021-03-02T22:12:01.892Z] 22:12:01     INFO - GECKO(1696) | 1614723121871	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":3,"method":"Runtime.evaluate","params":{"contextId":1,"expression":"({ foo: 42 })"}}
[task 2021-03-02T22:12:01.907Z] 22:12:01     INFO - GECKO(1696) | 1614723121901	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":3,"result":{"result":{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3","type":"object"}}}
[task 2021-03-02T22:12:01.907Z] 22:12:01     INFO - GECKO(1696) | 1614723121903	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":4,"method":"Runtime.callFunctionOn","params":{"executionContextId":1,"functionDeclaration":"obj => JSON.stringify(obj)","arguments":[{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3"}]}}
[task 2021-03-02T22:12:01.907Z] 22:12:01     INFO - GECKO(1696) | 1614723121905	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":4,"result":{"result":{"type":"string","value":"{\"foo\":42}"}}}
[task 2021-03-02T22:12:01.912Z] 22:12:01     INFO - GECKO(1696) | 1614723121907	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":5,"method":"Runtime.callFunctionOn","params":{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3","functionDeclaration":"function () { return this.foo; }"}}
[task 2021-03-02T22:12:01.912Z] 22:12:01     INFO - GECKO(1696) | 1614723121908	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":5,"result":{"result":{"type":"number","value":42}}}
[task 2021-03-02T22:12:01.914Z] 22:12:01     INFO - GECKO(1696) | 1614723121910	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":6,"method":"Runtime.releaseObject","params":{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3"}}
[task 2021-03-02T22:12:01.916Z] 22:12:01     INFO - GECKO(1696) | 1614723121912	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":6,"result":{}}
[task 2021-03-02T22:12:01.916Z] 22:12:01     INFO - GECKO(1696) | 1614723121913	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":7,"method":"Runtime.callFunctionOn","params":{"executionContextId":1,"functionDeclaration":"() => {}","arguments":[{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3"}]}}
[task 2021-03-02T22:12:01.923Z] 22:12:01     INFO - GECKO(1696) | 1614723121915	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":7,"error":{"message":"Could not find object with given id","data":"_fromCallArgument@chrome://remote/content/cdp/domain ... /cdp/domains/DomainCache.jsm:101:25\nreceiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.jsm:84:45\n"}}
[task 2021-03-02T22:12:01.923Z] 22:12:01     INFO - GECKO(1696) | 1614723121917	RemoteAgent	TRACE	(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca})-> {"id":8,"method":"Runtime.callFunctionOn","params":{"objectId":"8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3","functionDeclaration":"() => {}"}}
[task 2021-03-02T22:12:01.925Z] 22:12:01     INFO - GECKO(1696) | 1614723121918	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"id":8,"error":{"message":"Unable to get the context for object with id: 8f0e3fd7-fbfa-924b-9b6a-49e9babdb6c3","data":"callF ... /cdp/domains/DomainCache.jsm:101:25\nreceiveMessage@chrome://remote/content/cdp/sessions/ContentProcessSession.jsm:84:45\n"}}
[task 2021-03-02T22:12:01.953Z] 22:12:01     INFO - GECKO(1696) | 1614723121931	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetDestroyed","params":{"targetId":"e6c4df00-5510-a346-9fc9-473c7d1083e1"}}
[task 2021-03-02T22:12:01.957Z] 22:12:01     INFO - GECKO(1696) | 1614723121949	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetDestroyed","params":{"targetId":"c854223d-dc44-4d48-84f3-18054ed3a515"}}
[task 2021-03-02T22:12:01.957Z] 22:12:01     INFO - GECKO(1696) | 1614723121949	RemoteAgent	TRACE	<-(connection {2b45204e-8d25-6b4c-adae-5a489289a4ca}) {"method":"Target.targetDestroyed","params":{"targetId":"bf17d339-cb31-a943-83cf-beb84a11b982"}}
[task 2021-03-02T22:12:01.981Z] 22:12:01     INFO - GECKO(1696) | MEMORY STAT | vsize 7925MB | residentFast 431MB | heapAllocated 122MB
[task 2021-03-02T22:12:01.981Z] 22:12:01     INFO - TEST-OK | remote/cdp/test/browser/runtime/browser_remoteObjects.js | took 1225ms
[task 2021-03-02T22:12:01.985Z] 22:12:01     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x117a18400 == 4 [pid = 1698] [id = 36]
[task 2021-03-02T22:12:01.985Z] 22:12:01     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 9 (0x11e58cac0) [pid = 1698] [serial = 111] [outer = 0x0]
[task 2021-03-02T22:12:01.985Z] 22:12:01     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 10 (0x11e5a0c00) [pid = 1698] [serial = 112] [outer = 0x11e58cac0]
[task 2021-03-02T22:12:02.015Z] 22:12:02     INFO - checking window state
[task 2021-03-02T22:12:02.038Z] 22:12:02     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 29 (0x128907800) [pid = 1696] [serial = 240] [outer = 0x10eb81200]
[task 2021-03-02T22:12:02.039Z] 22:12:02     INFO - GECKO(1696) | [Child 1699, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80040111 (NS_ERROR_NOT_AVAILABLE): file /builds/worker/checkouts/gecko/caps/BasePrincipal.cpp:1349
[task 2021-03-02T22:12:02.098Z] 22:12:02     INFO - GECKO(1696) | [Parent 1696, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4251
[task 2021-03-02T22:12:02.174Z] 22:12:02     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x104c12400 == 1 [pid = 1700] [id = 39] [url = about:blank]
[task 2021-03-02T22:12:02.178Z] 22:12:02     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x104c04000 == 0 [pid = 1700] [id = 40] [url = about:blank]
[task 2021-03-02T22:12:02.179Z] 22:12:02     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0x104321e40) [pid = 1700] [serial = 118] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.179Z] 22:12:02     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (0x10b3e6c00) [pid = 1700] [serial = 119] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.219Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (0x10730ec00) [pid = 1701] [serial = 14] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.225Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (0x10e68e800) [pid = 1701] [serial = 17] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.226Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x10e2ef400 == 1 [pid = 1701] [id = 5] [url = about:blank]
[task 2021-03-02T22:12:02.226Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x107309400 == 0 [pid = 1701] [id = 4] [url = about:blank]
[task 2021-03-02T22:12:02.226Z] 22:12:02     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0x10b373040) [pid = 1700] [serial = 120] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.286Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0x107221e40) [pid = 1701] [serial = 13] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.286Z] 22:12:02     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (0x10e6b6200) [pid = 1701] [serial = 16] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.348Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x117a11000 == 3 [pid = 1698] [id = 34] [url = http://example.com/browser/remote/cdp/test/browser/runtime/doc_console_events.html]
[task 2021-03-02T22:12:02.348Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x11e1e9000 == 2 [pid = 1698] [id = 35] [url = about:blank]
[task 2021-03-02T22:12:02.348Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x117a02c00 == 1 [pid = 1698] [id = 33] [url = about:blank]
[task 2021-03-02T22:12:02.381Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 9 (0x11e59e400) [pid = 1698] [serial = 108] [outer = 0x0] [url = http://example.com/browser/remote/cdp/test/browser/runtime/doc_console_events.html]
[task 2021-03-02T22:12:02.381Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (0x11e5aa800) [pid = 1698] [serial = 110] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.381Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (0x11e1e2400) [pid = 1698] [serial = 106] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.382Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 6 (0x11e5a9800) [pid = 1698] [serial = 104] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.382Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 5 (0x11e5ab400) [pid = 1698] [serial = 107] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.382Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 4 (0x11e58c040) [pid = 1698] [serial = 105] [outer = 0x0] [url = http://example.com/browser/remote/cdp/test/browser/runtime/doc_console_events.html]
[task 2021-03-02T22:12:02.382Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0x117121e40) [pid = 1698] [serial = 102] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.382Z] 22:12:02     INFO - GECKO(1696) | [Child 1698: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (0x11e58c580) [pid = 1698] [serial = 109] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:02.415Z] 22:12:02     INFO - GECKO(1696) | [Child 1699: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x109ae1400 == 0 [pid = 1699] [id = 0] [url = about:newtab]
[task 2021-03-02T22:12:02.415Z] 22:12:02     INFO - GECKO(1696) | [Child 1699: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0x11e373040) [pid = 1699] [serial = 1] [outer = 0x0] [url = about:newtab]
[task 2021-03-02T22:12:02.415Z] 22:12:02     INFO - GECKO(1696) | [Child 1699: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0x11e3af000) [pid = 1699] [serial = 3] [outer = 0x0] [url = about:newtab]
[task 2021-03-02T22:12:03.231Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x1286b2400 == 6 [pid = 1696] [id = 81] [url = about:blank]
[task 2021-03-02T22:12:03.241Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x117608c00 == 5 [pid = 1696] [id = 80] [url = about:blank]
[task 2021-03-02T22:12:03.914Z] 22:12:03     INFO - GECKO(1696) | [Child 1702, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm:757
[task 2021-03-02T22:12:03.916Z] 22:12:03     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0x10e690800) [pid = 1701] [serial = 15] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.916Z] 22:12:03     INFO - GECKO(1696) | [Child 1701: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0x10e697800) [pid = 1701] [serial = 18] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.931Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 28 (0x11989f400) [pid = 1696] [serial = 232] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.932Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 27 (0x11989a800) [pid = 1696] [serial = 229] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.932Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 26 (0x11708cac0) [pid = 1696] [serial = 228] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.932Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 25 (0x119897c00) [pid = 1696] [serial = 226] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.932Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 24 (0x11989a000) [pid = 1696] [serial = 227] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.932Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 23 (0x12be5be40) [pid = 1696] [serial = 225] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.933Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 22 (0x11989a400) [pid = 1696] [serial = 223] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.933Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 21 (0x12af62c00) [pid = 1696] [serial = 224] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.933Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 20 (0x12be5bac0) [pid = 1696] [serial = 222] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.933Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 19 (0x11989f800) [pid = 1696] [serial = 235] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.934Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 18 (0x12890e000) [pid = 1696] [serial = 238] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.934Z] 22:12:03     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 17 (0x11989cc00) [pid = 1696] [serial = 230] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.934Z] 22:12:03     INFO - GECKO(1696) | [Child 1700: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0x104c0ec00) [pid = 1700] [serial = 121] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:03.934Z] 22:12:03     INFO - GECKO(1696) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-03-02T22:12:03.958Z] 22:12:03     INFO - GECKO(1696) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-03-02T22:12:03.965Z] 22:12:03     INFO - GECKO(1696) | [Child 1702, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3365
[task 2021-03-02T22:12:03.981Z] 22:12:03     INFO - GECKO(1696) | [Child 1702, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4377
[task 2021-03-02T22:12:05.327Z] 22:12:05     INFO - GECKO(1696) | Completed ShutdownLeaks collections in process 1699
[task 2021-03-02T22:12:05.331Z] 22:12:05     INFO - GECKO(1696) | Completed ShutdownLeaks collections in process 1700
[task 2021-03-02T22:12:05.331Z] 22:12:05     INFO - GECKO(1696) | Completed ShutdownLeaks collections in process 1701
[task 2021-03-02T22:12:05.374Z] 22:12:05     INFO - GECKO(1696) | Completed ShutdownLeaks collections in process 1698
[task 2021-03-02T22:12:05.581Z] 22:12:05     INFO - GECKO(1696) | Completed ShutdownLeaks collections in process 1697
[task 2021-03-02T22:12:05.775Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 16 (0x12b1ab800) [pid = 1696] [serial = 8] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.775Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 15 (0x1198a0800) [pid = 1696] [serial = 233] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.782Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 14 (0x1198a2400) [pid = 1696] [serial = 236] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.782Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 13 (0x12a5a5400) [pid = 1696] [serial = 239] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.782Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 12 (0x11708c3c0) [pid = 1696] [serial = 231] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.782Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 11 (0x1170b2200) [pid = 1696] [serial = 237] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:05.782Z] 22:12:05     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 10 (0x11708cc80) [pid = 1696] [serial = 234] [outer = 0x0] [url = about:blank]
[task 2021-03-02T22:12:06.316Z] 22:12:06     INFO - GECKO(1696) | [Parent 1696: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 11 (0x1112c3800) [pid = 1696] [serial = 241] [outer = 0x10eb81200]
[task 2021-03-02T22:12:06.357Z] 22:12:06     INFO - GECKO(1696) | FATAL ERROR: Non-local network connections are disabled and a connection attempt to aus5.mozilla.org (35.244.181.201) was made.
[task 2021-03-02T22:12:06.357Z] 22:12:06     INFO - GECKO(1696) | You should only access hostnames available via the test networking proxy (if running mochitests) or from a test-specific httpd.js server (if running xpcshell tests). Browser services should be disabled or redirected to a local server.
[task 2021-03-02T22:12:06.358Z] 22:12:06     INFO - GECKO(1696) | Hit MOZ_CRASH(Attempting to connect to non-local address!) at /builds/worker/checkouts/gecko/netwerk/base/nsSocketTransport2.cpp:1260
[task 2021-03-02T22:12:06.358Z] 22:12:06     INFO -  Initializing stack-fixing for the first stack frame, this may take a while...
[task 2021-03-02T22:12:14.407Z] 22:12:14     INFO - GECKO(1696) | #01: mozilla::net::nsSocketTransport::OnSocketEvent(unsigned int, nsresult, nsISupports*) [netwerk/base/nsSocketTransport2.cpp:2004]
[task 2021-03-02T22:12:14.407Z] 22:12:14     INFO - GECKO(1696) | #02: mozilla::net::nsSocketEvent::Run() [netwerk/base/nsSocketTransport2.cpp:95]
[task 2021-03-02T22:12:14.407Z] 22:12:14     INFO - GECKO(1696) | #03: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1152]
[task 2021-03-02T22:12:14.408Z] 22:12:14     INFO - GECKO(1696) | #04: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:548]
[task 2021-03-02T22:12:14.408Z] 22:12:14     INFO - GECKO(1696) | #05: mozilla::net::nsSocketTransportService::Run() [netwerk/base/nsSocketTransportService2.cpp:1200]
[task 2021-03-02T22:12:14.417Z] 22:12:14     INFO - GECKO(1696) | #06: {virtual override thunk({offset(-32)}, mozilla::net::nsSocketTransportService::Run())} [/Users/cltbld/tasks/task_1614721439/build/application/Firefox NightlyDebug.app/Contents/MacOS/XUL + 0x38114d]
[task 2021-03-02T22:12:14.417Z] 22:12:14     INFO - GECKO(1696) | #07: nsThread::ProcessNextEvent(bool, bool*) [xpcom/threads/nsThread.cpp:1152]
[task 2021-03-02T22:12:14.418Z] 22:12:14     INFO - GECKO(1696) | #08: NS_ProcessNextEvent(nsIThread*, bool) [xpcom/threads/nsThreadUtils.cpp:548]
[task 2021-03-02T22:12:14.418Z] 22:12:14     INFO - GECKO(1696) | #09: mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [ipc/glue/MessagePump.cpp:303]
[task 2021-03-02T22:12:14.418Z] 22:12:14     INFO - GECKO(1696) | #10: MessageLoop::Run() [ipc/chromium/src/base/message_loop.cc:311]
[task 2021-03-02T22:12:14.418Z] 22:12:14     INFO - GECKO(1696) | #11: nsThread::ThreadFunc(void*) [xpcom/threads/nsThread.cpp:393]
[task 2021-03-02T22:12:14.620Z] 22:12:14     INFO - GECKO(1696) | #12: _pt_root [nsprpub/pr/src/pthreads/ptthread.c:204]
[task 2021-03-02T22:12:14.630Z] 22:12:14     INFO - GECKO(1696) | #13: _pthread_body [/usr/lib/system/libsystem_pthread.dylib + 0x32eb]
[task 2021-03-02T22:12:14.630Z] 22:12:14     INFO - GECKO(1696) | #14: _pthread_start [/usr/lib/system/libsystem_pthread.dylib + 0x6249]
[task 2021-03-02T22:12:14.630Z] 22:12:14     INFO - GECKO(1696) | Exiting due to channel error.
[task 2021-03-02T22:12:14.630Z] 22:12:14     INFO - GECKO(1696) | Exiting due to channel error.
[task 2021-03-02T22:12:14.630Z] 22:12:14     INFO - GECKO(1696) | Exiting due to channel error.
[task 2021-03-02T22:12:14.631Z] 22:12:14     INFO - GECKO(1696) | Exiting due to channel error.
[task 2021-03-02T22:12:14.631Z] 22:12:14     INFO - GECKO(1696) | Exiting due to channel error.
[task 2021-03-02T22:12:14.691Z] 22:12:14     INFO - TEST-INFO | Main app process: exit 1
[task 2021-03-02T22:12:14.691Z] 22:12:14     INFO - TEST-INFO | Confirming we saw 171 DOCSHELL created and 162 destroyed log strings.
[task 2021-03-02T22:12:14.691Z] 22:12:14     INFO - TEST-INFO | Confirming we saw 507 DOMWINDOW created and 488 destroyed log strings.
[task 2021-03-02T22:12:14.691Z] 22:12:14     INFO - Buffered messages finished
[task 2021-03-02T22:12:14.692Z] 22:12:14    ERROR - TEST-UNEXPECTED-FAIL | Last test finished | application terminated with exit code 1
[task 2021-03-02T22:12:14.692Z] 22:12:14     INFO - runtests.py | Application ran for: 0:02:43.254716
[task 2021-03-02T22:12:14.692Z] 22:12:14     INFO - zombiecheck | Reading PID log: /var/folders/6c/fkm733q9365bk94qgfwkx6dh000017/T/tmpJRMHqDpidlog
[task 2021-03-02T22:12:14.692Z] 22:12:14     INFO - ==> process 1696 launched child process 1697
[task 2021-03-02T22:12:14.692Z] 22:12:14     INFO - ==> process 1696 launched child process 1698
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - ==> process 1696 launched child process 1699
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - ==> process 1696 launched child process 1700
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - ==> process 1696 launched child process 1701
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - ==> process 1696 launched child process 1702
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1697
[task 2021-03-02T22:12:14.693Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1698
[task 2021-03-02T22:12:14.694Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1699
[task 2021-03-02T22:12:14.694Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1700
[task 2021-03-02T22:12:14.694Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1701
[task 2021-03-02T22:12:14.694Z] 22:12:14     INFO - zombiecheck | Checking for orphan process with PID: 1702
[task 2021-03-02T22:12:14.694Z] 22:12:14     INFO - mozcrash Copy/paste: /Users/cltbld/tasks/task_1614721439/fetches/minidump_stackwalk/minidump_stackwalk /var/folders/6c/fkm733q9365bk94qgfwkx6dh000017/T/tmpZq6Ky6.mozrunner/minidumps/B08165AB-643C-42DD-869B-14E361AECCEC.dmp /Users/cltbld/tasks/task_1614721439/build/symbols
[task 2021-03-02T22:12:21.957Z] 22:12:21     INFO - mozcrash Saved minidump as /Users/cltbld/tasks/task_1614721439/build/blobber_upload_dir/B08165AB-643C-42DD-869B-14E361AECCEC.dmp
[task 2021-03-02T22:12:21.957Z] 22:12:21     INFO - mozcrash Saved app info as /Users/cltbld/tasks/task_1614721439/build/blobber_upload_dir/B08165AB-643C-42DD-869B-14E361AECCEC.extra
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - PROCESS-CRASH | Last test finished | application crashed [@ mozilla::net::nsSocketTransport::InitiateSocket()]
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - Mozilla crash reason: MOZ_CRASH(Attempting to connect to non-local address!)
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - Crash dump filename: /var/folders/6c/fkm733q9365bk94qgfwkx6dh000017/T/tmpZq6Ky6.mozrunner/minidumps/B08165AB-643C-42DD-869B-14E361AECCEC.dmp
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - Operating system: Mac OS X
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO -                   10.14.5 18F132
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - CPU: amd64
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO -      family 6 model 69 stepping 1
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO -      4 CPUs
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - 
[task 2021-03-02T22:12:22.193Z] 22:12:22     INFO - GPU: UNKNOWN
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - 
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - Crash reason:  EXC_BAD_ACCESS / KERN_INVALID_ADDRESS
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - Crash address: 0x0
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - Process uptime: 155 seconds
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - 
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO - Thread 4 (crashed)
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -  0  XUL!mozilla::net::nsSocketTransport::InitiateSocket() [nsSocketTransport2.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 1260 + 0x29]
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     rax = 0x0000000123aae0bc   rdx = 0x0000000000000000
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     rcx = 0x000000010e91e450   rbx = 0x000000010eb5f8b0
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     rsi = 0x00000000000120a8   rdi = 0x00007fffb350a028
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     rbp = 0x000070000289c8c0   rsp = 0x000070000289c580
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -      r8 = 0x00000000000130a8    r9 = 0x00007fffb350a048
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     r10 = 0x0000000000000000   r11 = 0x00007fffb350a040
[task 2021-03-02T22:12:22.194Z] 22:12:22     INFO -     r12 = 0x0000000111281400   r13 = 0x0000000111281610
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     r14 = 0x000070000289c7a0   r15 = 0x0000000111281520
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rip = 0x000000011a176d01
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     Found by: given as instruction pointer in context
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -  1  XUL!mozilla::net::nsSocketTransport::OnSocketEvent(unsigned int, nsresult, nsISupports*) [nsSocketTransport2.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 2004 + 0x16]
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rbp = 0x000070000289c900   rsp = 0x000070000289c8d0
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rip = 0x000000011a1790de
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -  2  XUL!mozilla::net::nsSocketEvent::Run() [nsSocketTransport2.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 94 + 0x18]
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rbp = 0x000070000289c910   rsp = 0x000070000289c910
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rip = 0x000000011a19c21f
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -  3  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 1152 + 0x16]
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rbp = 0x000070000289ca30   rsp = 0x000070000289c920
[task 2021-03-02T22:12:22.195Z] 22:12:22     INFO -     rip = 0x0000000119fa8b54
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -  4  XUL!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 548 + 0xd]
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rbp = 0x000070000289ca60   rsp = 0x000070000289ca40
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rip = 0x0000000119faf35c
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -  5  XUL!mozilla::net::nsSocketTransportService::Run() [nsSocketTransportService2.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 1199 + 0xe]
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rbp = 0x000070000289cb10   rsp = 0x000070000289ca70
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rip = 0x000000011a1831d3
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -  6  XUL!{virtual override thunk({offset(-32)}, mozilla::net::nsSocketTransportService::Run())} + 0xd
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rbp = 0x000070000289cb20   rsp = 0x000070000289cb20
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rip = 0x000000011a18414d
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -  7  XUL!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 1152 + 0x16]
[task 2021-03-02T22:12:22.196Z] 22:12:22     INFO -     rbp = 0x000070000289cc40   rsp = 0x000070000289cb30
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rip = 0x0000000119fa8b54
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -  8  XUL!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 548 + 0xd]
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rbp = 0x000070000289cc70   rsp = 0x000070000289cc50
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rip = 0x0000000119faf35c
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -  9  XUL!mozilla::ipc::MessagePumpForNonMainThreads::Run(base::MessagePump::Delegate*) [MessagePump.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 302 + 0xa]
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rbp = 0x000070000289ccc0   rsp = 0x000070000289cc80
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rip = 0x000000011a7f9021
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO - 10  XUL!MessageLoop::Run() [message_loop.cc:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 310 + 0x5]
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rbp = 0x000070000289ccf0   rsp = 0x000070000289ccd0
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     rip = 0x000000011a78409e
[task 2021-03-02T22:12:22.197Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO - 11  XUL!nsThread::ThreadFunc(void*) [nsThread.cpp:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 391 + 0x8]
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rbp = 0x000070000289ced0   rsp = 0x000070000289cd00
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rip = 0x0000000119fa5022
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO - 12  libnss3.dylib!_pt_root [ptthread.c:a54388a3070498ac8fcbb7e566e5dc98ed1096d1 : 201 + 0xa]
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rbp = 0x000070000289cf10   rsp = 0x000070000289cee0
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rip = 0x000000010ed7bd41
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO - 13  libsystem_pthread.dylib!_pthread_body + 0x7e
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rbp = 0x000070000289cf30   rsp = 0x000070000289cf20
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rip = 0x00007fff7cd962eb
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO - 14  libsystem_pthread.dylib!_pthread_start + 0x42
[task 2021-03-02T22:12:22.198Z] 22:12:22     INFO -     rbp = 0x000070000289cf50   rsp = 0x000070000289cf40
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     rip = 0x00007fff7cd99249
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO - 15  libsystem_pthread.dylib!thread_start + 0xd
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     rbp = 0x000070000289cf78   rsp = 0x000070000289cf60
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     rip = 0x00007fff7cd9540d
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     Found by: previous frame's frame pointer
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO - 16  libnss3.dylib + 0x17bc10
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     rsp = 0x000070000289d090   rip = 0x000000010ed7bc10
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO -     Found by: stack scanning
[task 2021-03-02T22:12:22.199Z] 22:12:22     INFO - 
...
...
...
Flags: needinfo?(hskupin)

That is strange. With the patch landed I can see FATAL ERROR: Non-local network connections are disabled and a connection attempt to aus5.mozilla.org (35.244.181.201) was made. But the patch explicitly disables update checks when the Remote Agent is active.

It seems to always happen during or right after the test remote/cdp/test/browser/runtime/browser_remoteObjects.js, and that only on Mac/Linux and WebRender debug. On other platforms and non-WebRender opt/debug builds it works fine.

I'll run some investigations today.

When enabling the app.update.log I can see a single update check that is denied by policy as expected:
https://treeherder.mozilla.org/logviewer?job_id=331859547&repo=try&lineNumber=12459-12461

That check is actually 7 minutes before the forced crash of Firefox Nightly. And in-between Firefox got restarted. Sadly it's not visible which URL Firefox actually tried to access but most likely it's for the update check.

Oh, the problem is actually with the first patch by adding app.update.disabledForTesting to RecommendedPreferences. Right now the Remote Agent doesn't keep track of which preferences have actually been altered, but resets them all.

That means app.update.disabledForTesting will be false after the first shutdown of Firefox and by keeping the current profile. And that would allow the updater service to check for updates again. I will file a bug to get this fixed before landing this patch again.

Flags: needinfo?(hskupin)
Depends on: 1696160
Pushed by hskupin@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/c83697849aa7
[remote] Enforce disabling of update checks. r=remote-protocol-reviewers,jdescottes
https://hg.mozilla.org/integration/autoland/rev/fa3dec8f1191
Prevent application updates when Remote Agent is enabled. r=application-update-reviewers,bytesized
Status: ASSIGNED → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 88 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: