1670154 - Intermittent docshell/test/browser/browser_uriFixupIntegration.js | Test timed out - | Found a browser window after previous test timed out

Status: RESOLVED INCOMPLETE

(Core :: DOM: Navigation, defect, P5)

Description

[Treeherder Bug Filer]

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

---

...
[task 2020-10-09T02:00:42.752Z] 02:00:42 INFO - TEST-PASS | docshell/test/browser/browser_uriFixupIntegration.js | New tab should have loaded with expected url. - "http://example.com/?private=foo+bar" == "http://example.com/?private=foo+bar" -
[task 2020-10-09T02:00:42.752Z] 02:00:42 INFO - Buffered messages logged at 01:59:21
[task 2020-10-09T02:00:42.754Z] 02:00:42 INFO - Console message: [JavaScript Error: "TypeError: can't access property "addEventListener", browser is null" {file: "resource:///actors/ContentSearchParent.jsm" line: 623}]
[task 2020-10-09T02:00:42.754Z] 02:00:42 INFO - receiveMessage@resource:///actors/ContentSearchParent.jsm:623:5
[task 2020-10-09T02:00:42.754Z] 02:00:42 INFO -
[task 2020-10-09T02:00:42.755Z] 02:00:42 INFO - Console message: [JavaScript Error: "AbortError: Actor 'AboutPrivateBrowsing' destroyed before query 'ShouldShowSearchBanner' was resolved"]
[task 2020-10-09T02:00:42.756Z] 02:00:42 INFO - Console message: [JavaScript Error: "AbortError: Actor 'AboutPrivateBrowsing' destroyed before query 'ShouldShowVPNPromo' was resolved"]
[task 2020-10-09T02:00:42.757Z] 02:00:42 INFO - Search brokenprotocol:somethingelse in a normal window
[task 2020-10-09T02:00:42.757Z] 02:00:42 INFO - Buffered messages logged at 01:59:22
[task 2020-10-09T02:00:42.758Z] 02:00:42 INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1210}]
[task 2020-10-09T02:00:42.758Z] 02:00:42 INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1210}]
[task 2020-10-09T02:00:42.758Z] 02:00:42 INFO - TEST-PASS | docshell/test/browser/browser_uriFixupIntegration.js | New tab should have loaded with expected url. - "http://example.com/?search=brokenprotocol%3Asomethingelse" == "http://example.com/?search=brokenprotocol%3Asomethingelse" -
[task 2020-10-09T02:00:42.760Z] 02:00:42 INFO - Buffered messages logged at 01:59:23
[task 2020-10-09T02:00:42.761Z] 02:00:42 INFO - Search brokenprotocol:somethingelse in a private window
[task 2020-10-09T02:00:42.761Z] 02:00:42 INFO - Buffered messages logged at 01:59:24
[task 2020-10-09T02:00:42.761Z] 02:00:42 INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“r” modifiers=“accel,alt” id=“key_toggleReaderMode”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1210}]
[task 2020-10-09T02:00:42.762Z] 02:00:42 INFO - Console message: [JavaScript Warning: "Key event not available on some keyboard layouts: key=“i” modifiers=“accel,alt,shift” id=“key_browserToolbox”" {file: "chrome://mochikit/content/tests/SimpleTest/EventUtils.js" line: 1210}]
[task 2020-10-09T02:00:42.762Z] 02:00:42 INFO - Buffered messages finished
[task 2020-10-09T02:00:42.762Z] 02:00:42 INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_uriFixupIntegration.js | Test timed out -
[task 2020-10-09T02:00:42.764Z] 02:00:42 INFO - GECKO(2666) | MEMORY STAT | vsize 3402MB | residentFast 393MB | heapAllocated 116MB
[task 2020-10-09T02:00:42.765Z] 02:00:42 INFO - TEST-OK | docshell/test/browser/browser_uriFixupIntegration.js | took 90134ms
[task 2020-10-09T02:00:42.768Z] 02:00:42 INFO - GECKO(2666) | [Child 3058: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f135f5ae400 == 1 [pid = 3058] [id = 20]
[task 2020-10-09T02:00:42.769Z] 02:00:42 INFO - GECKO(2666) | [Child 3058: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0x7f135ee5c430) [pid = 3058] [serial = 52] [outer = (nil)]
[task 2020-10-09T02:00:42.769Z] 02:00:42 INFO - GECKO(2666) | [Child 3058: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (0x7f135f5af800) [pid = 3058] [serial = 53] [outer = 0x7f135ee5c430]
[task 2020-10-09T02:00:42.770Z] 02:00:42 INFO - checking window state
[task 2020-10-09T02:00:42.770Z] 02:00:42 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-10-09T02:00:42.771Z] 02:00:42 INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_uriFixupIntegration.js | Found a browser window after previous test timed out -
[task 2020-10-09T02:00:42.771Z] 02:00:42 INFO - GECKO(2666) | must wait for focus
[task 2020-10-09T02:00:43.001Z] 02:00:43 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-10-09T02:00:43.001Z] 02:00:43 INFO - TEST-UNEXPECTED-FAIL | docshell/test/browser/browser_uriFixupIntegration.js | Uncaught exception received from previously timed out test -
[task 2020-10-09T02:00:43.041Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: 'NS_FAILED(targetPrincipal->GetAsciiOrigin(targetOrigin))', file /builds/worker/checkouts/gecko/toolkit/components/antitracking/AntiTrackingUtils.cpp:347
[task 2020-10-09T02:00:43.045Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 15 (0x7f8713f40800) [pid = 2666] [serial = 92] [outer = 0x7f8720a2ad40]
[task 2020-10-09T02:00:43.061Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: 'NS_FAILED(targetPrincipal->GetAsciiOrigin(targetOrigin))', file /builds/worker/checkouts/gecko/toolkit/components/antitracking/AntiTrackingUtils.cpp:347
[task 2020-10-09T02:00:43.108Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f871bf8f400 == 6 [pid = 2666] [id = 40] [url = about:blank]
[task 2020-10-09T02:00:43.144Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp:4278
[task 2020-10-09T02:00:43.184Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.189Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.189Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.189Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.189Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.189Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.190Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.190Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.190Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.190Z] 02:00:43 INFO - GECKO(2666) | [Parent 2666, Main Thread] WARNING: This lives in the child process: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:494
[task 2020-10-09T02:00:43.488Z] 02:00:43 INFO - GECKO(2666) | [Child 2910: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f32287af000 == 0 [pid = 2910] [id = 57] [url = about:blank]
[task 2020-10-09T02:00:43.710Z] 02:00:43 INFO - GECKO(2666) | [Child 2806: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f42eb929c00 == 0 [pid = 2806] [id = 46] [url = about:privatebrowsing]
[task 2020-10-09T02:00:43.710Z] 02:00:43 INFO - GECKO(2666) | [Child 2806: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0x7f42eb9de9a0) [pid = 2806] [serial = 107] [outer = (nil)] [url = about:privatebrowsing]
[task 2020-10-09T02:00:43.710Z] 02:00:43 INFO - GECKO(2666) | [Child 2806: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0x7f42eb51bc00) [pid = 2806] [serial = 109] [outer = (nil)] [url = about:privatebrowsing]
[task 2020-10-09T02:00:43.871Z] 02:00:43 INFO - GECKO(2666) | [Child 2884: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f6d197eac00 == 0 [pid = 2884] [id = 0] [url = about:newtab]
[task 2020-10-09T02:00:43.872Z] 02:00:43 INFO - GECKO(2666) | [Child 2884: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (0x7f6d2fc936f0) [pid = 2884] [serial = 1] [outer = (nil)] [url = about:newtab]
[task 2020-10-09T02:00:43.873Z] 02:00:43 INFO - GECKO(2666) | [Child 2884: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (0x7f6d19886000) [pid = 2884] [serial = 3] [outer = (nil)] [url = about:newtab]
[task 2020-10-09T02:00:44.479Z] 02:00:44 INFO - GECKO(2666) | [Parent 2666: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7f871554d400 == 5 [pid = 2666] [id = 39] [url = chrome://browser/content/browser.xhtml]
[task 2020-10-09T02:00:44.624Z] 02:00:44 INFO - GECKO(2666) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-10-09T02:00:44.660Z] 02:00:44 INFO - GECKO(2666) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-10-09T02:00:44.681Z] 02:00:44 INFO - GECKO(2666) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
...

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform breakdown:

• linux1804-64: 3

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• linux1804-64: 2

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform breakdown:

• linux1804-64: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1670154&startday=2020-10-19&endday=2020-10-25&tree=all

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1670154&startday=2020-10-26&endday=2020-11-01&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64: 1

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

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• try: 1

Platform breakdown:

• linux1804-64: 3

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

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6

Platform breakdown:

• linux1804-64: 6

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

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform breakdown:

• linux1804-64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2020-11-30&endday=2020-12-06&tree=all

Comment 9

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• linux1804-64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2020-12-07&endday=2020-12-13&tree=all

Comment 10

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

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-01-11&endday=2021-01-17&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• linux1804-64: 3
  • debug: 3
• linux1804-64-tsan: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-01-18&endday=2021-01-24&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• linux1804-64: 4
  • debug: 3
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-01-25&endday=2021-01-31&tree=all

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-02-01&endday=2021-02-07&tree=all

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• mozilla-release: 1

Platform and build breakdown:

• linux1804-64: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-02-15&endday=2021-02-21&tree=all

Comment 16

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-03-08&endday=2021-03-14&tree=all

Comment 17

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1670154&startday=2021-03-15&endday=2021-03-21&tree=all

Comment 18

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

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