Closed Bug 1671045 Opened 5 years ago Closed 5 years ago

Intermittent TV browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Tracking

()

Status:

RESOLVED FIXED

Milestone:

84 Branch

Iteration:

84.1 - Oct 19 - Nov 01

Tracking Flags:

Tracking

Status

firefox-esr78

---

unaffected

firefox81

---

unaffected

firefox82

---

unaffected

firefox83

---

fixed

firefox84

---

fixed

People

(Reporter: intermittent-bug-filer, Assigned: adw)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Attachments

(1 file)

Bug 1671045 - Fix intermittent in browser_searchMode_sessionStore.js by requesting a longer timeout and disabling on Mac debug. 5 years ago Drew Willcoxon :adw 47 bytes, text/x-phabricator-request		Details \| Review

Treeherder Bug Filer

Reporter

Description

•

5 years ago

treeherder

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=318505181&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/DypQTOTHRRKOBFa145Qe9g/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/DypQTOTHRRKOBFa145Qe9g/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2020-10-13T17:13:02.856Z] 17:13:02     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js
[task 2020-10-13T17:15:24.772Z] 17:15:24     INFO - TEST-INFO | started process screencapture
[task 2020-10-13T17:15:24.881Z] 17:15:24     INFO - TEST-INFO | screencapture: exit 0
[task 2020-10-13T17:15:24.881Z] 17:15:24     INFO - <snipped 115 output lines - if you need more context, please use SimpleTest.requestCompleteLog() in your test>
[task 2020-10-13T17:15:24.881Z] 17:15:24     INFO - Buffered messages logged at 17:14:19
[task 2020-10-13T17:15:24.881Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - Buffered messages logged at 17:14:22
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.882Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.883Z] 17:15:24     INFO - Buffered messages logged at 17:14:24
[task 2020-10-13T17:15:24.883Z] 17:15:24     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 2020-10-13T17:15:24.883Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.883Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.884Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.884Z] 17:15:24     INFO - Buffered messages logged at 17:14:25
[task 2020-10-13T17:15:24.886Z] 17:15:24     INFO - Leaving test bound initialPageOnRestore_exit
[task 2020-10-13T17:15:24.886Z] 17:15:24     INFO - Entering test bound switchToInitialPage_exit
[task 2020-10-13T17:15:24.887Z] 17:15:24     INFO - Buffered messages logged at 17:14:27
[task 2020-10-13T17:15:24.887Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.887Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.887Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.887Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.888Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.888Z] 17:15:24     INFO - Buffered messages logged at 17:14:33
[task 2020-10-13T17:15:24.888Z] 17:15:24     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 2020-10-13T17:15:24.888Z] 17:15:24     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 2020-10-13T17:15:24.888Z] 17:15:24     INFO - Awaiting for the urlbar panel to open
[task 2020-10-13T17:15:24.889Z] 17:15:24     INFO - Buffered messages logged at 17:14:34
[task 2020-10-13T17:15:24.889Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2020-10-13T17:15:24.889Z] 17:15:24     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 2020-10-13T17:15:24.890Z] 17:15:24     INFO - Buffered messages logged at 17:14:35
[task 2020-10-13T17:15:24.890Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2020-10-13T17:15:24.890Z] 17:15:24     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 2020-10-13T17:15:24.890Z] 17:15:24     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 2020-10-13T17:15:24.891Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2020-10-13T17:15:24.894Z] 17:15:24     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 2020-10-13T17:15:24.894Z] 17:15:24     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 2020-10-13T17:15:24.894Z] 17:15:24     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 2020-10-13T17:15:24.894Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar value hasn't changed. - "test browser_sessionStore.js" == "test browser_sessionStore.js" - 
[task 2020-10-13T17:15:24.894Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.895Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.895Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.895Z] 17:15:24     INFO - Buffered messages logged at 17:14:39
[task 2020-10-13T17:15:24.895Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.895Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.896Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.896Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.897Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.897Z] 17:15:24     INFO - Buffered messages logged at 17:14:43
[task 2020-10-13T17:15:24.898Z] 17:15:24     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 2020-10-13T17:15:24.899Z] 17:15:24     INFO - Buffered messages logged at 17:14:44
[task 2020-10-13T17:15:24.899Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.899Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.899Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Buffered messages logged at 17:14:45
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Leaving test bound switchToInitialPage_exit
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Entering test bound nonInitialPageOnRestore_exit
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Buffered messages logged at 17:14:47
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.902Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.903Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.903Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.903Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.903Z] 17:15:24     INFO - Buffered messages logged at 17:14:52
[task 2020-10-13T17:15:24.903Z] 17:15:24     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 2020-10-13T17:15:24.903Z] 17:15:24     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 2020-10-13T17:15:24.903Z] 17:15:24     INFO - Buffered messages logged at 17:14:53
[task 2020-10-13T17:15:24.904Z] 17:15:24     INFO - Awaiting for the urlbar panel to open
[task 2020-10-13T17:15:24.904Z] 17:15:24     INFO - Buffered messages logged at 17:14:54
[task 2020-10-13T17:15:24.904Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2020-10-13T17:15:24.904Z] 17:15:24     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 2020-10-13T17:15:24.904Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2020-10-13T17:15:24.904Z] 17:15:24     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 2020-10-13T17:15:24.908Z] 17:15:24     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 2020-10-13T17:15:24.908Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2020-10-13T17:15:24.908Z] 17:15:24     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 2020-10-13T17:15:24.908Z] 17:15:24     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 2020-10-13T17:15:24.909Z] 17:15:24     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 2020-10-13T17:15:24.909Z] 17:15:24     INFO - Buffered messages logged at 17:14:55
[task 2020-10-13T17:15:24.909Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar value hasn't changed. - "test browser_sessionStore.js" == "test browser_sessionStore.js" - 
[task 2020-10-13T17:15:24.909Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.909Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.909Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Buffered messages logged at 17:14:58
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Buffered messages logged at 17:15:00
[task 2020-10-13T17:15:24.910Z] 17:15:24     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 2020-10-13T17:15:24.910Z] 17:15:24     INFO - Buffered messages logged at 17:15:01
[task 2020-10-13T17:15:24.910Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - Buffered messages logged at 17:15:02
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - Leaving test bound nonInitialPageOnRestore_exit
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - Entering test bound switchToNonInitialPage_exit
[task 2020-10-13T17:15:24.911Z] 17:15:24     INFO - Buffered messages logged at 17:15:04
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - Buffered messages logged at 17:15:09
[task 2020-10-13T17:15:24.912Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: Tab at index 1 is correct - "http://example.com/" == "http://example.com/" - 
[task 2020-10-13T17:15:24.915Z] 17:15:24     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 2020-10-13T17:15:24.916Z] 17:15:24     INFO - Buffered messages logged at 17:15:10
[task 2020-10-13T17:15:24.916Z] 17:15:24     INFO - Awaiting for the urlbar panel to open
[task 2020-10-13T17:15:24.916Z] 17:15:24     INFO - Buffered messages logged at 17:15:11
[task 2020-10-13T17:15:24.916Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2020-10-13T17:15:24.916Z] 17:15:24     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 2020-10-13T17:15:24.916Z] 17:15:24     INFO - Buffered messages logged at 17:15:12
[task 2020-10-13T17:15:24.917Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2020-10-13T17:15:24.917Z] 17:15:24     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 2020-10-13T17:15:24.917Z] 17:15:24     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 2020-10-13T17:15:24.917Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2020-10-13T17:15:24.918Z] 17:15:24     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 2020-10-13T17:15:24.918Z] 17:15:24     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 2020-10-13T17:15:24.919Z] 17:15:24     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 2020-10-13T17:15:24.919Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar value hasn't changed. - "test browser_sessionStore.js" == "test browser_sessionStore.js" - 
[task 2020-10-13T17:15:24.919Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.919Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.919Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.920Z] 17:15:24     INFO - Buffered messages logged at 17:15:15
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - Version: 2.1 INTEL-12.9.22
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - Vendor: Intel Inc.
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - Renderer: Intel Iris OpenGL Engine
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - FBO Texture Target: TEXTURE_2D
[task 2020-10-13T17:15:24.922Z] 17:15:24     INFO - Buffered messages logged at 17:15:17
[task 2020-10-13T17:15:24.922Z] 17:15:24     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 2020-10-13T17:15:24.923Z] 17:15:24     INFO - Buffered messages logged at 17:15:19
[task 2020-10-13T17:15:24.923Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar should never be in search mode without the corresponding attribute. - false == false - 
[task 2020-10-13T17:15:24.923Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | gURLBar.searchMode not expected - true == true - 
[task 2020-10-13T17:15:24.923Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected placeholder l10n when search mode is inactive - {"args":{"name":"Google"},"id":"urlbar-placeholder-with-name"} deepEqual {"id":"urlbar-placeholder-with-name","args":{"name":"Google"}} - 
[task 2020-10-13T17:15:24.923Z] 17:15:24     INFO - Buffered messages logged at 17:15:21
[task 2020-10-13T17:15:24.923Z] 17:15:24     INFO - Leaving test bound switchToNonInitialPage_exit
[task 2020-10-13T17:15:24.924Z] 17:15:24     INFO - Entering test bound duplicateTabs
[task 2020-10-13T17:15:24.924Z] 17:15:24     INFO - Awaiting for the urlbar panel to open
[task 2020-10-13T17:15:24.924Z] 17:15:24     INFO - Buffered messages logged at 17:15:22
[task 2020-10-13T17:15:24.924Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | One-offs are visible - true == true - 
[task 2020-10-13T17:15:24.924Z] 17:15:24     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 2020-10-13T17:15:24.924Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Urlbar view is still open. - true == true - 
[task 2020-10-13T17:15:24.930Z] 17:15:24     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 2020-10-13T17:15:24.930Z] 17:15:24     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 2020-10-13T17:15:24.930Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2020-10-13T17:15:24.931Z] 17:15:24     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 2020-10-13T17:15:24.931Z] 17:15:24     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 2020-10-13T17:15:24.931Z] 17:15:24     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 2020-10-13T17:15:24.931Z] 17:15:24     INFO - Buffered messages logged at 17:15:23
[task 2020-10-13T17:15:24.931Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Sanity check: The duplicated tab is now the selected tab - [object XULElement] == [object XULElement] - 
[task 2020-10-13T17:15:24.931Z] 17:15:24     INFO - Buffered messages logged at 17:15:24
[task 2020-10-13T17:15:24.931Z] 17:15:24     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 2020-10-13T17:15:24.931Z] 17:15:24     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 2020-10-13T17:15:24.931Z] 17:15:24     INFO - TEST-PASS | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | Expected result source should have a name - "bookmarks" == true - 
[task 2020-10-13T17:15:24.932Z] 17:15:24     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 2020-10-13T17:15:24.932Z] 17:15:24     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 2020-10-13T17:15:24.932Z] 17:15:24     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 2020-10-13T17:15:24.932Z] 17:15:24     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 2020-10-13T17:15:24.932Z] 17:15:24     INFO - Leaving test bound duplicateTabs
[task 2020-10-13T17:15:24.932Z] 17:15:24     INFO - Buffered messages finished
[task 2020-10-13T17:15:24.932Z] 17:15:24     INFO - TEST-UNEXPECTED-FAIL | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - 
[task 2020-10-13T17:15:24.932Z] 17:15:24     INFO - GECKO(1500) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2020-10-13T17:15:24.932Z] 17:15:24     INFO - GECKO(1500) | MEMORY STAT | vsize 7719MB | residentFast 357MB | heapAllocated 144MB
[task 2020-10-13T17:15:24.932Z] 17:15:24     INFO - TEST-OK | browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | took 141927ms
...```

Bogdan Tara[:bogdan_tara | bogdant]

Updated

•

5 years ago

Summary: Intermittent browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. - → Intermittent TV browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

BugBot [:suhaib / :marco]

Comment 1

•

5 years ago

Set release status flags based on info from the regressing bug 1659203

status-firefox81: --- → unaffected

status-firefox82: --- → unaffected

status-firefox83: --- → affected

status-firefox-esr78: --- → unaffected

Pascal Chevrel (relman team) -> :pascalc|PTO until Sept 2

Updated

•

5 years ago

status-firefox83: affected → fix-optional

Drew Willcoxon :adw

Assignee

Updated

•

5 years ago

Updated

•

5 years ago

Assignee: nobody → adw

Status: NEW → ASSIGNED

Iteration: --- → 84.1 - Oct 19 - Nov 01

Points: --- → 2

Drew Willcoxon :adw

Assignee

Comment 3

•

5 years ago

Attached file Bug 1671045 - Fix intermittent in browser_searchMode_sessionStore.js by requesting a longer timeout and disabling on Mac debug. — Details

This test times out on macOS 10.14 opt and debug. Logs show that the test
finishes properly but it exceeds the timeout threshold, so it appears that it
just takes too long. Increasing the timeout threshold fixes the problem on opt,
but it reveals another problem on debug where the watchdog process kills the
main process because its shutdown lasts too long. This happens during step 3 of
test-verify, which is "Run each test 10 times in one browser, in chaos mode."
Around the time that the crash happens, logs show that there are "2047 DOMWINDOW
created and 2037 destroyed log strings." The test opens, closes, and reopens
many windows -- with chaos mode on top of that -- so it's possible that debug
window instrumentation or just the debug nature of the build itself, plus slow
machines, causes all the window opening and closing to perform very poorly and
take a long time.

This patch increases the timeout, which fixes opt, and disables the test
entirely on debug -- and to reiterate, it's Mac only. Maybe the test could open
and close tabs instead of windows in order to test session store, but I'm not
sure it's worth rewriting.

Here's a successful try run with an earlier version of this patch that did not
disable the test on debug, but it shows that opt is green:

https://treeherder.mozilla.org/#/jobs?repo=try&revision=7ab33a9225b9edf0cb8a95d556f9b76c7fc69470

And here's a run without the patch that shows opt is always orange:

https://treeherder.mozilla.org/#/jobs?repo=try&revision=1e02bfc26ecb67f503cb24a180536e8c220226d5

Pulsebot

Comment 4

•

5 years ago

Pushed by dwillcoxon@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/2769479fb1a2 Fix intermittent in browser_searchMode_sessionStore.js by requesting a longer timeout and disabling on Mac debug. r=mak

Razvan Maries

Comment 5

•

5 years ago

bugherder

https://hg.mozilla.org/mozilla-central/rev/2769479fb1a2

Status: ASSIGNED → RESOLVED

Closed: 5 years ago

status-firefox84: --- → fixed

Resolution: --- → FIXED

Target Milestone: --- → 84 Branch

Ryan VanderMeulen [:RyanVM]

Comment 6

•

5 years ago

bugherder uplift

https://hg.mozilla.org/releases/mozilla-beta/rev/05b62f06c82f

status-firefox83: fix-optional → fixed

BMO Automation

Updated

•

5 years ago

Has Regression Range: --- → yes

Dão Gottwald [:dao]

Updated

•

1 year ago

Bugzilla

Intermittent TV browser/components/urlbar/tests/browser/browser_searchMode_sessionStore.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -

Categories

(Firefox :: Address Bar, defect, P5)

Tracking

()

People

(Reporter: intermittent-bug-filer, Assigned: adw)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Crash Data

Security

(public)

User Story

Attachments

(1 file)

Description

Updated

Comment 1

Updated

Updated

Comment 2

Updated

Comment 3

Comment 4

Comment 5

Comment 6

Updated

Updated

Attachment

General

Description

File Name

Content Type