1726044 - Intermittent browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Uncaught exception - Waiting for search mode to be restored - timed out after 50 tries.

Status: RESOLVED INCOMPLETE

(Firefox :: Address Bar, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-08-16T19:33:30.441Z] 19:33:30     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js
[task 2021-08-16T19:33:34.463Z] 19:33:34     INFO - GECKO(1576) | JavaScript error: resource:///actors/ContentSearchParent.jsm, line 664: TypeError: can't access property "addEventListener", browser is null
[task 2021-08-16T19:33:34.466Z] 19:33:34     INFO - GECKO(1576) | JavaScript error: resource:///actors/ContentSearchParent.jsm, line 664: TypeError: can't access property "addEventListener", browser is null
[task 2021-08-16T19:33:42.019Z] 19:33:42     INFO - GECKO(1576) | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Failed to connect WebRenderBridgeChild. (t=797.266) |[C1][GFX1-]: Failed to connect WebRenderBridgeChild. (t=941.117) [GFX1-]: Failed to connect WebRenderBridgeChild.
[task 2021-08-16T19:33:42.286Z] 19:33:42     INFO - GECKO(1576) | JavaScript error: resource:///actors/ContentSearchParent.jsm, line 664: TypeError: can't access property "addEventListener", browser is null
[task 2021-08-16T19:33:42.287Z] 19:33:42     INFO - GECKO(1576) | JavaScript error: resource:///actors/ContentSearchParent.jsm, line 664: TypeError: can't access property "addEventListener", browser is null
[task 2021-08-16T19:33:56.190Z] 19:33:56     INFO - TEST-INFO | started process screentopng
[task 2021-08-16T19:33:56.486Z] 19:33:56     INFO - TEST-INFO | screentopng: exit 0
[task 2021-08-16T19:33:56.486Z] 19:33:56     INFO - Buffered messages logged at 19:33:30
[task 2021-08-16T19:33:56.488Z] 19:33:56     INFO - Entering test bound initialPageOnRestore
[task 2021-08-16T19:33:56.488Z] 19:33:56     INFO - Buffered messages logged at 19:33:32
[task 2021-08-16T19:33:56.489Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Tab at index 0 is correct - "about:newtab" == "about:newtab" - 
[task 2021-08-16T19:33:56.490Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: about:newtab is or is not in gInitialPages as expected - true == true - 
[task 2021-08-16T19:33:56.490Z] 19:33:56     INFO - Buffered messages logged at 19:33:33
[task 2021-08-16T19:33:56.491Z] 19:33:56     INFO - Awaiting for the urlbar panel to open
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - Urlbar panel opened
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - Enter Search Mode {"source":1}
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Found one-off button for search mode - {"source":1,"_inheritedElements":null,"initializedAttributeInheritance":true} == true - 
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2021-08-16T19:33:56.492Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - true == true - 
[task 2021-08-16T19:33:56.493Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode should exist as expected - true == true - 
[task 2021-08-16T19:33:56.495Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected searchMode - {"source":1,"isPreview":false,"entry":"oneoff"} deepEqual {"source":1,"entry":"oneoff","isPreview":false} - 
[task 2021-08-16T19:33:56.495Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2021-08-16T19:33:56.498Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.499Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.499Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is active - {"args":null,"id":"urlbar-placeholder-search-mode-other-bookmarks"} deepEqual {"id":"urlbar-placeholder-search-mode-other-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.500Z] 19:33:56     INFO - Buffered messages logged at 19:33:34
[task 2021-08-16T19:33:56.500Z] 19:33:56     INFO - Console message: [JavaScript Error: "TypeError: can't access property "addEventListener", browser is null" {file: "resource:///actors/ContentSearchParent.jsm" line: 664}]
[task 2021-08-16T19:33:56.500Z] 19:33:56     INFO - receiveMessage@resource:///actors/ContentSearchParent.jsm:664:5
[task 2021-08-16T19:33:56.500Z] 19:33:56     INFO - 
[task 2021-08-16T19:33:56.505Z] 19:33:56     INFO - Console message: [JavaScript Error: "TypeError: can't access property "addEventListener", browser is null" {file: "resource:///actors/ContentSearchParent.jsm" line: 664}]
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - receiveMessage@resource:///actors/ContentSearchParent.jsm:664:5
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - 
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - Console message: [JavaScript Warning: "Layout was forced before the page was fully loaded. If stylesheets are not yet loaded this may cause a flash of unstyled content." {file: "about:newtab" line: 0}]
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - Buffered messages logged at 19:33:36
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Initially selected tab in restored window is correct - "about:newtab" == "about:newtab" - 
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - Buffered messages logged at 19:33:37
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - true == true - 
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode should exist as expected - true == true - 
[task 2021-08-16T19:33:56.519Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected searchMode - {"source":1,"isPreview":false,"entry":"oneoff"} deepEqual {"source":1,"entry":"oneoff","isPreview":false} - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is active - {"args":null,"id":"urlbar-placeholder-search-mode-other-bookmarks"} deepEqual {"id":"urlbar-placeholder-search-mode-other-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Search string should be restored - "test browser_sessionStore.js" == "test browser_sessionStore.js" - 
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - Buffered messages logged at 19:33:42
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - Console message: [JavaScript Error: "TypeError: can't access property "addEventListener", browser is null" {file: "resource:///actors/ContentSearchParent.jsm" line: 664}]
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - receiveMessage@resource:///actors/ContentSearchParent.jsm:664:5
[task 2021-08-16T19:33:56.520Z] 19:33:56     INFO - 
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Console message: [JavaScript Error: "TypeError: can't access property "addEventListener", browser is null" {file: "resource:///actors/ContentSearchParent.jsm" line: 664}]
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - receiveMessage@resource:///actors/ContentSearchParent.jsm:664:5
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - 
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Leaving test bound initialPageOnRestore
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Entering test bound switchToInitialPage
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Buffered messages logged at 19:33:45
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Tab at index 1 is correct - "about:newtab" == "about:newtab" - 
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: about:newtab is or is not in gInitialPages as expected - true == true - 
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Awaiting for the urlbar panel to open
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Urlbar panel opened
[task 2021-08-16T19:33:56.521Z] 19:33:56     INFO - Buffered messages logged at 19:33:46
[task 2021-08-16T19:33:56.523Z] 19:33:56     INFO - Enter Search Mode {"source":1}
[task 2021-08-16T19:33:56.523Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2021-08-16T19:33:56.523Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Found one-off button for search mode - {"source":1,"_inheritedElements":null,"initializedAttributeInheritance":true} == true - 
[task 2021-08-16T19:33:56.523Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2021-08-16T19:33:56.530Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - true == true - 
[task 2021-08-16T19:33:56.531Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode should exist as expected - true == true - 
[task 2021-08-16T19:33:56.534Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected searchMode - {"source":1,"isPreview":false,"entry":"oneoff"} deepEqual {"source":1,"entry":"oneoff","isPreview":false} - 
[task 2021-08-16T19:33:56.534Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2021-08-16T19:33:56.535Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.537Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected l10n - {"args":null,"id":"urlbar-search-mode-bookmarks"} deepEqual {"id":"urlbar-search-mode-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.538Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is active - {"args":null,"id":"urlbar-placeholder-search-mode-other-bookmarks"} deepEqual {"id":"urlbar-placeholder-search-mode-other-bookmarks","args":null} - 
[task 2021-08-16T19:33:56.538Z] 19:33:56     INFO - Buffered messages logged at 19:33:47
[task 2021-08-16T19:33:56.539Z] 19:33:56     INFO - Console message: [JavaScript Warning: "Layout was forced before the page was fully loaded. If stylesheets are not yet loaded this may cause a flash of unstyled content." {file: "about:newtab" line: 0}]
[task 2021-08-16T19:33:56.539Z] 19:33:56     INFO - Buffered messages logged at 19:33:50
[task 2021-08-16T19:33:56.540Z] 19:33:56     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Initially selected tab in restored window is correct - "http://example.com/" == "http://example.com/" - 
[task 2021-08-16T19:33:56.540Z] 19:33:56     INFO - Buffered messages finished
[task 2021-08-16T19:33:56.541Z] 19:33:56     INFO - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Uncaught exception - Waiting for search mode to be restored - timed out after 50 tries.
[task 2021-08-16T19:33:56.541Z] 19:33:56     INFO - Leaving test bound switchToInitialPage
[task 2021-08-16T19:33:56.542Z] 19:33:56     INFO - Entering test bound nonInitialPageOnRestore
[task 2021-08-16T19:33:59.747Z] 19:33:59     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Tab at index 0 is correct - "http://example.com/" == "http://example.com/" - 
[task 2021-08-16T19:33:59.755Z] 19:33:59     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: http://example.com/ is or is not in gInitialPages as expected - false == false - 
[task 2021-08-16T19:34:00.015Z] 19:34:00     INFO - Awaiting for the urlbar panel to open
[task 2021-08-16T19:34:00.158Z] 19:34:00     INFO - Urlbar panel opened
[task 2021-08-16T19:34:00.431Z] 19:34:00     INFO - Enter Search Mode {"source":1}
[task 2021-08-16T19:34:00.437Z] 19:34:00     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
<...>
[task 2021-08-16T19:35:05.234Z] 19:35:05     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Search string should be duplicated/restored - "test browser_sessionStore.js" == "test browser_sessionStore.js" - 
[task 2021-08-16T19:35:05.380Z] 19:35:05     INFO - Leaving test bound duplicateTabs
[task 2021-08-16T19:35:05.515Z] 19:35:05     INFO - GECKO(1576) | MEMORY STAT | vsize 130553063MB | residentFast 4082MB
[task 2021-08-16T19:35:05.517Z] 19:35:05     INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | took 95076ms
[task 2021-08-16T19:35:05.624Z] 19:35:05     INFO - checking window state
[task 2021-08-16T19:35:05.627Z] 19:35:05     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-16T19:35:05.628Z] 19:35:05     INFO - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Found an unexpected browser window at the end of test run - 
[task 2021-08-16T19:35:05.841Z] 19:35:05     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_searchMode_setURI.js

Comment 1

[Intermittent Failures Robot]

1 failures in 2899 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-tsan-qr: 1
  • opt: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2

Platform and build breakdown:

• linux1804-64-tsan-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1726044&startday=2021-08-30&endday=2021-09-05&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-tsan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1726044&startday=2021-09-13&endday=2021-09-19&tree=all

Comment 4

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

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