1616134 - Intermittent devtools/client/netmonitor/test/browser_net_fission_switch_target.js | Request count of about:robots is correct - Got 1, expected 0

Status: RESOLVED INCOMPLETE

(DevTools :: Netmonitor, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-02-17T20:33:48.761Z] 20:33:48 INFO - TEST-START | devtools/client/netmonitor/test/browser_net_fission_switch_target.js
[task 2020-02-17T20:33:48.877Z] 20:33:48 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7fc0d411b800 == 2 [pid = 1379] [id = {f97d31f6-d0f3-4ac2-9eb5-4c0088f1f0ee}]
[task 2020-02-17T20:33:48.878Z] 20:33:48 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (0x7fc0d4160d40) [pid = 1379] [serial = 130] [outer = (nil)]
[task 2020-02-17T20:33:48.879Z] 20:33:48 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/workspace/build/src/layout/base/nsPresContext.cpp, line 847
[task 2020-02-17T20:33:48.880Z] 20:33:48 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (0x7fc0d4139c00) [pid = 1379] [serial = 131] [outer = 0x7fc0d4160d40]
[task 2020-02-17T20:33:49.018Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 30 (0x7f7248c517a0) [pid = 1230] [serial = 299] [outer = (nil)] [url = about:devtools-toolbox]
[task 2020-02-17T20:33:49.018Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 29 (0x7f7248dfb020) [pid = 1230] [serial = 302] [outer = (nil)] [url = chrome://devtools/content/netmonitor/index.html]
[task 2020-02-17T20:33:49.019Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 28 (0x7f726ebc4d40) [pid = 1230] [serial = 312] [outer = (nil)] [url = about:blank]
[task 2020-02-17T20:33:49.019Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 27 (0x7f7276d48200) [pid = 1230] [serial = 309] [outer = (nil)] [url = about:blank]
[task 2020-02-17T20:33:49.019Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 26 (0x7f726eb0b880) [pid = 1230] [serial = 317] [outer = (nil)] [url = about:blank]
[task 2020-02-17T20:33:49.197Z] 20:33:49 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 64
[task 2020-02-17T20:33:49.213Z] 20:33:49 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x7fc0d4423c00) [pid = 1379] [serial = 132] [outer = 0x7fc0d4160d40]
[task 2020-02-17T20:33:49.431Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f7245216800 == 8 [pid = 1230] [id = {0eb7d978-8ab2-4487-bdda-5cef7b2ea187}] [url = chrome://devtools/content/inspector/markup/markup.xhtml]
[task 2020-02-17T20:33:49.432Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f7245235000 == 7 [pid = 1230] [id = {c9678317-86fe-4f31-b5f7-cd8ec6bccc4c}] [url = chrome://devtools/content/inspector/index.xhtml]
[task 2020-02-17T20:33:49.434Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f7245202800 == 6 [pid = 1230] [id = {feb45ae4-c5d5-4cae-ae34-4867fe999293}] [url = about:devtools-toolbox]
[task 2020-02-17T20:33:49.434Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f7245204000 == 5 [pid = 1230] [id = {2e818434-abcf-4e9f-bb97-295db1ccba85}] [url = chrome://devtools/content/netmonitor/index.html]
[task 2020-02-17T20:33:49.443Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f7245202800 == 6 [pid = 1230] [id = {1655147e-ca5c-4eb4-a8c5-dbce14c1a72b}]
[task 2020-02-17T20:33:49.445Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 27 (0x7f7248c2ad40) [pid = 1230] [serial = 321] [outer = (nil)]
[task 2020-02-17T20:33:49.446Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 28 (0x7f7245909000) [pid = 1230] [serial = 322] [outer = 0x7f7248c2ad40]
[task 2020-02-17T20:33:49.506Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 29 (0x7f724590d800) [pid = 1230] [serial = 323] [outer = 0x7f7248c2ad40]
[task 2020-02-17T20:33:49.631Z] 20:33:49 INFO - GECKO(1230) | [Parent 1230, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/worker/workspace/build/src/dom/base/nsContentUtils.cpp, line 3784
[task 2020-02-17T20:33:49.973Z] 20:33:49 INFO - GECKO(1230) | [Child 1410: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f13c0618000 == 2 [pid = 1410] [id = {45a98c6a-42a6-43d9-9f78-c3af1552bfdd}] [url = http://example.com/browser/devtools/client/netmonitor/test/html_filter-test-page.html]
[task 2020-02-17T20:33:49.981Z] 20:33:49 INFO - GECKO(1230) | [Child 1437: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f0834480800 == 0 [pid = 1437] [id = {e481884e-72e3-4213-a92c-36ad8e45b568}] [url = http://example.com/browser/devtools/client/netmonitor/test/html_filter-test-page.html]
[task 2020-02-17T20:33:49.988Z] 20:33:49 INFO - GECKO(1230) | [Child 1410: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f13c061a000 == 1 [pid = 1410] [id = {85a5d83a-28ca-442b-98e0-7b56f0c522d1}] [url = about:blank]
[task 2020-02-17T20:33:50.004Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f7245204000 == 7 [pid = 1230] [id = {d9893a89-d567-46ae-a936-09c67272fa08}]
[task 2020-02-17T20:33:50.005Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 30 (0x7f7248dfca60) [pid = 1230] [serial = 324] [outer = (nil)]
[task 2020-02-17T20:33:50.006Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 31 (0x7f724bf7a400) [pid = 1230] [serial = 325] [outer = 0x7f7248dfca60]
[task 2020-02-17T20:33:50.186Z] 20:33:50 INFO - GECKO(1230) | [Child 1437: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (0x7f08341335c0) [pid = 1437] [serial = 145] [outer = (nil)] [url = http://example.com/browser/devtools/client/netmonitor/test/html_filter-test-page.html]
[task 2020-02-17T20:33:50.213Z] 20:33:50 INFO - GECKO(1230) | [Child 1410: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 8 (0x7f13c015c100) [pid = 1410] [serial = 101] [outer = (nil)] [url = about:blank]
[task 2020-02-17T20:33:50.214Z] 20:33:50 INFO - GECKO(1230) | [Child 1410: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 7 (0x7f13c015b5c0) [pid = 1410] [serial = 104] [outer = (nil)] [url = http://example.com/browser/devtools/client/netmonitor/test/html_filter-test-page.html]
[task 2020-02-17T20:33:50.590Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, nullptr) failed with result 0x804B000A: file /builds/worker/workspace/build/src/extensions/permissions/nsPermission.cpp, line 45
[task 2020-02-17T20:33:50.592Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230, Main Thread] WARNING: '!principal', file /builds/worker/workspace/build/src/netwerk/cookie/CookieSettings.cpp, line 142
[task 2020-02-17T20:33:50.592Z] 20:33:50 INFO - GECKO(1230) | [Parent 1230, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/workspace/build/src/toolkit/components/antitracking/StorageAccess.cpp, line 33
[task 2020-02-17T20:33:50.933Z] 20:33:50 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 64
[task 2020-02-17T20:33:50.934Z] 20:33:50 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 64
[task 2020-02-17T20:33:50.950Z] 20:33:50 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (0x7fc0d442e400) [pid = 1379] [serial = 133] [outer = 0x7fc0d4160d40]
[task 2020-02-17T20:33:51.755Z] 20:33:51 INFO - GECKO(1230) | console.error: "Task cancelled"
[task 2020-02-17T20:33:51.837Z] 20:33:51 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 64
[task 2020-02-17T20:33:51.838Z] 20:33:51 INFO - GECKO(1230) | [Child 1379, Main Thread] WARNING: Trying to request nsIHttpChannel from DocumentChannel, this is likely broken: file /builds/worker/workspace/build/src/netwerk/ipc/DocumentChannel.cpp, line 64
[task 2020-02-17T20:33:51.990Z] 20:33:51 INFO - GECKO(1230) | [Child 1379: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 8 (0x7fc0d442c000) [pid = 1379] [serial = 134] [outer = 0x7fc0d4160d40]
[task 2020-02-17T20:33:52.236Z] 20:33:52 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f7245aa8800 == 8 [pid = 1230] [id = {d89a90c8-4876-41e8-88aa-fc71469f4285}]
[task 2020-02-17T20:33:52.237Z] 20:33:52 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 32 (0x7f7248c8b980) [pid = 1230] [serial = 326] [outer = (nil)]
[task 2020-02-17T20:33:52.241Z] 20:33:52 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 33 (0x7f726cf7a800) [pid = 1230] [serial = 327] [outer = 0x7f7248c8b980]
[task 2020-02-17T20:33:52.524Z] 20:33:52 INFO - TEST-INFO | started process screentopng
[task 2020-02-17T20:33:52.782Z] 20:33:52 INFO - TEST-INFO | screentopng: exit 0
[task 2020-02-17T20:33:52.784Z] 20:33:52 INFO - Buffered messages logged at 20:33:48
[task 2020-02-17T20:33:52.785Z] 20:33:52 INFO - Entering test bound
[task 2020-02-17T20:33:52.786Z] 20:33:52 INFO - Open a page that runs on the content process and the net monitor
[task 2020-02-17T20:33:52.787Z] 20:33:52 INFO - Initializing a network monitor pane.
[task 2020-02-17T20:33:52.788Z] 20:33:52 INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/netmonitor/test/html_custom-get-page.html
[task 2020-02-17T20:33:52.788Z] 20:33:52 INFO - Buffered messages logged at 20:33:49
[task 2020-02-17T20:33:52.788Z] 20:33:52 INFO - Tab added and finished loading
[task 2020-02-17T20:33:52.788Z] 20:33:52 INFO - Net tab added successfully: http://example.com/browser/devtools/client/netmonitor/test/html_custom-get-page.html
[task 2020-02-17T20:33:52.788Z] 20:33:52 INFO - Buffered messages logged at 20:33:50
[task 2020-02-17T20:33:52.789Z] 20:33:52 INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2020-02-17T20:33:52.789Z] 20:33:52 INFO - Network monitor pane shown successfully.
[task 2020-02-17T20:33:52.789Z] 20:33:52 INFO - Disabling cache and reloading page.
[task 2020-02-17T20:33:52.789Z] 20:33:52 INFO - Buffered messages logged at 20:33:51
[task 2020-02-17T20:33:52.789Z] 20:33:52 INFO - Request server0.conn57.netEvent4 for http://example.com/browser/devtools/client/netmonitor/test/html_custom-get-page.html not yet done, keep waiting...
[task 2020-02-17T20:33:52.790Z] 20:33:52 INFO - Console message: [JavaScript Warning: "Relative positioning of table rows and row groups is now supported. This site may need to be updated because it may depend on this feature having no effect." {file: "resource://devtools/client/netmonitor/src/components/request-list/RequestListHeader.js" line: 450}]
[task 2020-02-17T20:33:52.790Z] 20:33:52 INFO - Got marker: dom-interactive
[task 2020-02-17T20:33:52.791Z] 20:33:52 INFO - Got marker: dom-complete
[task 2020-02-17T20:33:52.791Z] 20:33:52 INFO - Got two timeline markers, done waiting
[task 2020-02-17T20:33:52.792Z] 20:33:52 INFO - Request server0.conn57.netEvent4 for http://example.com/browser/devtools/client/netmonitor/test/html_custom-get-page.html done
[task 2020-02-17T20:33:52.792Z] 20:33:52 INFO - All requests finished
[task 2020-02-17T20:33:52.793Z] 20:33:52 INFO - Cache disabled when the current and all future toolboxes are open.
[task 2020-02-17T20:33:52.794Z] 20:33:52 INFO - TEST-PASS | devtools/client/netmonitor/test/browser_net_fission_switch_target.js | Request to reconfigure the tab was recorded. -
[task 2020-02-17T20:33:52.795Z] 20:33:52 INFO - Clearing requests in the console client.
[task 2020-02-17T20:33:52.795Z] 20:33:52 INFO - Clearing requests in the UI.
[task 2020-02-17T20:33:52.796Z] 20:33:52 INFO - Reload the page to show the network event
[task 2020-02-17T20:33:52.797Z] 20:33:52 INFO - > Network event progress: NetworkEvent: 1/1, PayloadReady: 0/1, got NetMonitor:NetworkEvent for server0.conn57.netEvent23
[task 2020-02-17T20:33:52.798Z] 20:33:52 INFO - Buffered messages logged at 20:33:52
[task 2020-02-17T20:33:52.798Z] 20:33:52 INFO - > Network event progress: NetworkEvent: 1/1, PayloadReady: 1/1, got NetMonitor:PayloadReady for server0.conn57.netEvent23
[task 2020-02-17T20:33:52.798Z] 20:33:52 INFO - Navigate to a page that runs on parent process
[task 2020-02-17T20:33:52.799Z] 20:33:52 INFO - Load document "about:robots"
[task 2020-02-17T20:33:52.800Z] 20:33:52 INFO - Waiting for page to be loaded…
[task 2020-02-17T20:33:52.800Z] 20:33:52 INFO - → page loaded
[task 2020-02-17T20:33:52.801Z] 20:33:52 INFO - Waiting for netmonitor to be reloaded…
[task 2020-02-17T20:33:52.801Z] 20:33:52 INFO - Waiting for netmonitor updates after page reload
[task 2020-02-17T20:33:52.802Z] 20:33:52 INFO - → panel reloaded
[task 2020-02-17T20:33:52.802Z] 20:33:52 INFO - Waiting for target 'navigate' event…
[task 2020-02-17T20:33:52.803Z] 20:33:52 INFO - → 'navigate' emitted
[task 2020-02-17T20:33:52.803Z] 20:33:52 INFO - Buffered messages finished
[task 2020-02-17T20:33:52.805Z] 20:33:52 INFO - TEST-UNEXPECTED-FAIL | devtools/client/netmonitor/test/browser_net_fission_switch_target.js | Request count of about:robots is correct - Got 1, expected 0
[task 2020-02-17T20:33:52.805Z] 20:33:52 INFO - Stack trace:
[task 2020-02-17T20:33:52.805Z] 20:33:52 INFO - chrome://mochikit/content/browser-test.js:test_is:1320
[task 2020-02-17T20:33:52.806Z] 20:33:52 INFO - chrome://mochitests/content/browser/devtools/client/netmonitor/test/browser_net_fission_switch_target.js:null:34
[task 2020-02-17T20:33:52.806Z] 20:33:52 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1062
[task 2020-02-17T20:33:52.807Z] 20:33:52 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1097
[task 2020-02-17T20:33:52.807Z] 20:33:52 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:925
[task 2020-02-17T20:33:52.808Z] 20:33:52 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:914
[task 2020-02-17T20:33:52.808Z] 20:33:52 INFO - Return to a page that runs on content process again
[task 2020-02-17T20:33:52.809Z] 20:33:52 INFO - GECKO(1230) | console.warn: "Error while detaching the browsing context target front:" (new Error("Protocol error (noSuchActor): No such actor for ID: server0.conn57.child1/frameTarget1", "resource://devtools/shared/protocol/Front.js", 276))
[task 2020-02-17T20:33:52.809Z] 20:33:52 INFO - GECKO(1230) | [Parent 1230: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 34 (0x7f7248db3000) [pid = 1230] [serial = 328] [outer = 0x7f7248c8b980]
[task 2020-02-17T20:33:52.901Z] 20:33:52 INFO - GECKO(1230) | console.error: "Task cancelled"
[task 2020-02-17T20:33:52.902Z] 20:33:52 INFO - Load document "http://example.com/browser/devtools/client/netmonitor/test/html_custom-get-page.html"
[task 2020-02-17T20:33:53.018Z] 20:33:53 INFO - GECKO(1230) | [Parent 1230, Main Thread] ###!!! ASSERTION: Wrong event target!: 'this == fl->GetBrowserChildMessageManager()', file /builds/worker/workspace/build/src/dom/base/InProcessBrowserChildMessageManager.cpp, line 260

Comment 1

[Intermittent Failures Robot]

8 failures in 4045 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4
• mozilla-central: 2
• try: 2

Platform breakdown:

• linux1804-64: 6
• linux1804-64-asan: 1
• windows10-64: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 3

Platform breakdown:

• linux1804-64: 3

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 6

Platform breakdown:

• linux1804-64: 6

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 2

Platform breakdown:

• linux1804-64: 2

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

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1

Platform breakdown:

• linux1804-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1616134&startday=2020-04-06&endday=2020-04-12&tree=all

Comment 6

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.