Closed Bug 1962669 Opened 17 days ago Closed 14 days ago

[Late Beta] Perma browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | false == true - when Gecko 139 switches to Late Beta on 2025-05-09

Categories

(Firefox :: Search, defect, P1)

defect

Tracking

()

VERIFIED FIXED
140 Branch
Tracking Status
firefox-esr115 --- unaffected
firefox-esr128 --- unaffected
firefox137 --- unaffected
firefox138 --- unaffected
firefox139 + fixed
firefox140 --- verified

People

(Reporter: amarc, Assigned: mbeier)

References

(Regression)

Details

(Keywords: regression, Whiteboard: [sng])

Attachments

(2 files)

Central-as-beta-simulation

How to run these simulations

Failure log

  • Failure snippet:
[task 2025-04-25T11:09:46.865Z] 11:09:46     INFO - TEST-PASS | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | No search form event is recorded for searches - null == null - 
[task 2025-04-25T11:09:46.865Z] 11:09:46     INFO - Leaving test bound test_actualSearchSearchbar
[task 2025-04-25T11:09:46.865Z] 11:09:46     INFO - Entering test bound test_appProvidedUrlbar
[task 2025-04-25T11:09:46.865Z] 11:09:46     INFO - Buffered messages finished
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | false == true - 
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - Stack trace:
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - resource://testing-common/UrlbarTestUtils.sys.mjs:openSearchModeSwitcher:1383
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:test_appProvidedUrlbar:115
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochikit/content/browser-test.js:handleTask:1170
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1242
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1383
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1159
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2025-04-25T11:09:46.866Z] 11:09:46     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://www.example.com/search?q=foo" line: 0}]
[task 2025-04-25T11:09:52.699Z] 11:09:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:09:52.699Z] 11:09:52     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | Uncaught exception in test bound test_appProvidedUrlbar - at chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206 - Error: The element or the window did not become interactive
[task 2025-04-25T11:09:52.699Z] 11:09:52     INFO - Stack trace:
[task 2025-04-25T11:09:52.699Z] 11:09:52     INFO - promiseElementReadyForUserInput@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206:9
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - async*openSearchModeSwitcher@resource://testing-common/UrlbarTestUtils.sys.mjs:1384:27
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - test_appProvidedUrlbar@chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:115:37
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - handleTask@chrome://mochikit/content/browser-test.js:1170:26
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1242:18
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1383:14
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1159:14
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13
[task 2025-04-25T11:09:52.700Z] 11:09:52     INFO - Leaving test bound test_appProvidedUrlbar
[task 2025-04-25T11:09:52.701Z] 11:09:52     INFO - Entering test bound test_extensionUrlbar
[task 2025-04-25T11:09:52.706Z] 11:09:52     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:09:52.707Z] 11:09:52     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | false == true - 
[task 2025-04-25T11:09:52.707Z] 11:09:52     INFO - Stack trace:
[task 2025-04-25T11:09:52.707Z] 11:09:52     INFO - resource://testing-common/UrlbarTestUtils.sys.mjs:openSearchModeSwitcher:1383
[task 2025-04-25T11:09:52.707Z] 11:09:52     INFO - chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:test_extensionUrlbar:131
[task 2025-04-25T11:09:52.707Z] 11:09:52     INFO - chrome://mochikit/content/browser-test.js:handleTask:1170
[task 2025-04-25T11:09:52.708Z] 11:09:52     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1242
[task 2025-04-25T11:09:52.708Z] 11:09:52     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1383
[task 2025-04-25T11:09:52.708Z] 11:09:52     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1159
[task 2025-04-25T11:09:52.708Z] 11:09:52     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2025-04-25T11:09:58.725Z] 11:09:58     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:09:58.725Z] 11:09:58     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | Uncaught exception in test bound test_extensionUrlbar - at chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206 - Error: The element or the window did not become interactive
[task 2025-04-25T11:09:58.725Z] 11:09:58     INFO - Stack trace:
[task 2025-04-25T11:09:58.725Z] 11:09:58     INFO - promiseElementReadyForUserInput@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206:9
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - async*openSearchModeSwitcher@resource://testing-common/UrlbarTestUtils.sys.mjs:1384:27
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - test_extensionUrlbar@chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:131:37
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - handleTask@chrome://mochikit/content/browser-test.js:1170:26
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1242:18
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1383:14
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1159:14
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - Leaving test bound test_extensionUrlbar
[task 2025-04-25T11:09:58.726Z] 11:09:58     INFO - Entering test bound test_actualSearchUrlbar
[task 2025-04-25T11:09:58.782Z] 11:09:58     INFO - Waiting for the urlbar view to open
[task 2025-04-25T11:09:58.920Z] 11:09:58     INFO - Urlbar view opened
[task 2025-04-25T11:09:58.921Z] 11:09:58     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:09:58.924Z] 11:09:58     INFO - GECKO(2181) | console.warn: "No icon found for" "defaultEngine"
[task 2025-04-25T11:09:58.927Z] 11:09:58     INFO - GECKO(2181) | console.warn: "No icon found for" "second_engine"
[task 2025-04-25T11:09:58.995Z] 11:09:58     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:09:58.996Z] 11:09:58     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:09:59.067Z] 11:09:59     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | false == true - 
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - Stack trace:
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - resource://testing-common/UrlbarTestUtils.sys.mjs:openSearchModeSwitcher:1383
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:test_actualSearchUrlbar:151
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochikit/content/browser-test.js:handleTask:1170
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1242
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1383
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1159
[task 2025-04-25T11:09:59.068Z] 11:09:59     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2025-04-25T11:10:05.080Z] 11:10:05     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:10:05.081Z] 11:10:05     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | Uncaught exception in test bound test_actualSearchUrlbar - at chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206 - Error: The element or the window did not become interactive
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - Stack trace:
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - promiseElementReadyForUserInput@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:206:9
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - async*openSearchModeSwitcher@resource://testing-common/UrlbarTestUtils.sys.mjs:1384:27
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - test_actualSearchUrlbar@chrome://mochitests/content/browser/browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js:151:37
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - async*handleTask@chrome://mochikit/content/browser-test.js:1170:26
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1242:18
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - async*Tester_execTest@chrome://mochikit/content/browser-test.js:1383:14
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1159:14
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13
[task 2025-04-25T11:10:05.082Z] 11:10:05     INFO - Leaving test bound test_actualSearchUrlbar
[task 2025-04-25T11:10:05.253Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchEngineSelector: "Search configuration updated remotely"
[task 2025-04-25T11:10:05.255Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchEngineSelector: "Search configuration overrides updated remotely"
[task 2025-04-25T11:10:05.256Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "Reloading engines after idle due to configuration change"
[task 2025-04-25T11:10:05.256Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchSettings: "finalizing batch task"
[task 2025-04-25T11:10:05.260Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "Running maybeReloadEngines"
[task 2025-04-25T11:10:05.262Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchEngineSelector: "fetchEngineConfiguration en-US:US:default:::Firefox:139.0"
[task 2025-04-25T11:10:05.263Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchEngineSelector: "Using JavaScript based engine selector"
[task 2025-04-25T11:10:05.276Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchEngineSelector: "fetchEngineConfiguration: google,amazondotcom-us,bing,ddg,ebay,wikipedia"
[task 2025-04-25T11:10:05.285Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "Google"
[task 2025-04-25T11:10:05.285Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Google" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.294Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "Amazon.com"
[task 2025-04-25T11:10:05.295Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Amazon.com" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.304Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "Bing"
[task 2025-04-25T11:10:05.305Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Bing" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.313Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "DuckDuckGo"
[task 2025-04-25T11:10:05.313Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "DuckDuckGo" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.320Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "eBay"
[task 2025-04-25T11:10:05.321Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "eBay" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.327Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#addEngineToStore: Adding engine:" "Wikipedia (en)"
[task 2025-04-25T11:10:05.328Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Wikipedia (en)" "Verb:" "engine-added"
[task 2025-04-25T11:10:05.333Z] 11:10:05     INFO - GECKO(2181) | console.warn: "No icon found for" "defaultEngine"
[task 2025-04-25T11:10:05.342Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Google" "Verb:" "engine-default"
[task 2025-04-25T11:10:05.363Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Google" "Verb:" "engine-default-private"
[task 2025-04-25T11:10:05.375Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "defaultEngine" "Verb:" "engine-removed"
[task 2025-04-25T11:10:05.379Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.381Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.382Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.383Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.384Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.384Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.387Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Second Engine" "Verb:" "engine-removed"
[task 2025-04-25T11:10:05.402Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.417Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.418Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#buildSortedEngineList: using saved order"
[task 2025-04-25T11:10:05.419Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "#saveSortedEngineList"
[task 2025-04-25T11:10:05.421Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "maybeReloadEngines complete"
[task 2025-04-25T11:10:05.428Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.517Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.527Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.536Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.545Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.553Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.561Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.569Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.577Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:05.755Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.891Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.912Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.934Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.955Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:05.976Z] 11:10:05     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:06.005Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:06.031Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:06.423Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchSettings: "batchTask: Invalidating engine settings"
[task 2025-04-25T11:10:06.426Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchSettings: "_write: Writing to settings file."
[task 2025-04-25T11:10:06.428Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchSettings: "_write: settings file written to disk."
[task 2025-04-25T11:10:06.469Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "#saveSortedEngineList"
[task 2025-04-25T11:10:06.471Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchUtils: "NOTIFY: Engine:" "Foo" "Verb:" "engine-removed"
[task 2025-04-25T11:10:06.479Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:06.602Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "getEngines: getting all engines"
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | A promise chain failed to handle a rejection: popupshown listener on #searchmode-switcher-popup not removed before the end of test - stack: waitForEvent/</<@resource://testing-common/BrowserTestUtils.sys.mjs:1302:15
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - ensureDOMPromiseRejectionsProcessed@resource://testing-common/PromiseTestUtils.sys.mjs:115:17
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - nextTest@chrome://mochikit/content/browser-test.js:802:29
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - async*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1840:25
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - run@chrome://mochikit/content/browser-test.js:1760:9
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - Rejection date: Fri Apr 25 2025 11:10:06 GMT+0000 (Coordinated Universal Time) - false == true - 
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - Stack trace:
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - resource://testing-common/PromiseTestUtils.sys.mjs:assertNoUncaughtRejections:266
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:nextTest:803
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1840
[task 2025-04-25T11:10:06.613Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:run:1760
[task 2025-04-25T11:10:06.614Z] 11:10:06     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | A promise chain failed to handle a rejection: popupshown listener on #searchmode-switcher-popup not removed before the end of test - stack: waitForEvent/</<@resource://testing-common/BrowserTestUtils.sys.mjs:1302:15
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - ensureDOMPromiseRejectionsProcessed@resource://testing-common/PromiseTestUtils.sys.mjs:115:17
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - nextTest@chrome://mochikit/content/browser-test.js:802:29
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - async*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1840:25
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - run@chrome://mochikit/content/browser-test.js:1760:9
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - Rejection date: Fri Apr 25 2025 11:10:06 GMT+0000 (Coordinated Universal Time) - false == true - 
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - Stack trace:
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - resource://testing-common/PromiseTestUtils.sys.mjs:assertNoUncaughtRejections:266
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:nextTest:803
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1840
[task 2025-04-25T11:10:06.615Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:run:1760
[task 2025-04-25T11:10:06.616Z] 11:10:06     INFO - Not taking screenshot here: see the one that was previously logged
[task 2025-04-25T11:10:06.618Z] 11:10:06     INFO - TEST-UNEXPECTED-FAIL | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | A promise chain failed to handle a rejection: popupshown listener on #searchmode-switcher-popup not removed before the end of test - stack: waitForEvent/</<@resource://testing-common/BrowserTestUtils.sys.mjs:1302:15
[task 2025-04-25T11:10:06.618Z] 11:10:06     INFO - ensureDOMPromiseRejectionsProcessed@resource://testing-common/PromiseTestUtils.sys.mjs:115:17
[task 2025-04-25T11:10:06.619Z] 11:10:06     INFO - nextTest@chrome://mochikit/content/browser-test.js:802:29
[task 2025-04-25T11:10:06.619Z] 11:10:06     INFO - async*testScope/test_finish/<@chrome://mochikit/content/browser-test.js:1840:25
[task 2025-04-25T11:10:06.619Z] 11:10:06     INFO - run@chrome://mochikit/content/browser-test.js:1760:9
[task 2025-04-25T11:10:06.619Z] 11:10:06     INFO - Rejection date: Fri Apr 25 2025 11:10:06 GMT+0000 (Coordinated Universal Time) - false == true - 
[task 2025-04-25T11:10:06.619Z] 11:10:06     INFO - Stack trace:
[task 2025-04-25T11:10:06.620Z] 11:10:06     INFO - resource://testing-common/PromiseTestUtils.sys.mjs:assertNoUncaughtRejections:266
[task 2025-04-25T11:10:06.620Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:nextTest:803
[task 2025-04-25T11:10:06.620Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1840
[task 2025-04-25T11:10:06.620Z] 11:10:06     INFO - chrome://mochikit/content/browser-test.js:run:1760
[task 2025-04-25T11:10:06.629Z] 11:10:06     INFO - GECKO(2181) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 1302: uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test
[task 2025-04-25T11:10:06.630Z] 11:10:06     INFO - GECKO(2181) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 1302: uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test
[task 2025-04-25T11:10:06.630Z] 11:10:06     INFO - GECKO(2181) | JavaScript error: resource://testing-common/BrowserTestUtils.sys.mjs, line 1302: uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test
[task 2025-04-25T11:10:06.644Z] 11:10:06     INFO - Console message: [JavaScript Error: "uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test" {file: "resource://testing-common/BrowserTestUtils.sys.mjs" line: 1302}]
[task 2025-04-25T11:10:06.645Z] 11:10:06     INFO - Console message: [JavaScript Error: "uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test" {file: "resource://testing-common/BrowserTestUtils.sys.mjs" line: 1302}]
[task 2025-04-25T11:10:06.646Z] 11:10:06     INFO - Console message: [JavaScript Error: "uncaught exception: popupshown listener on #searchmode-switcher-popup not removed before the end of test" {file: "resource://testing-common/BrowserTestUtils.sys.mjs" line: 1302}]
[task 2025-04-25T11:10:06.662Z] 11:10:06     INFO - GECKO(2181) | console.debug: SearchService: "getVisibleEngines: getting all visible engines"
[task 2025-04-25T11:10:06.876Z] 11:10:06     INFO - GECKO(2181) | MEMORY STAT | vsize 120590951MB | residentFast 1708MB
[task 2025-04-25T11:10:06.878Z] 11:10:06     INFO - TEST-OK | browser/components/search/test/browser/telemetry/browser_search_telemetry_searchform.js | took 23663ms
[task 2025-04-25T11:10:07.018Z] 11:10:07     INFO - checking window state
[task 2025-04-25T11:10:07.158Z] 11:10:07     INFO - TEST-START | browser/components/search/test/browser/telemetry/browser_search_telemetry_shopping.js
[task 2025-04-25T11:10:07.618Z] 11:10:07     INFO - GECKO(2181) | console.debug: SearchSettings: "batchTask: Invalidating engine settings"
[task 2025-04-25T11:10:07.622Z] 11:10:07     INFO - GECKO(2181) | console.debug: SearchSettings: "_write: Writing to settings file."
[task 2025-04-25T11:10:07.625Z] 11:10:07     INFO - GECKO(2181) | console.debug: SearchSettings: "_write: settings file written to disk."
[task 2025-04-25T11:10:07.744Z] 11:10:07     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Impression:" "example:tagged:ff" "https://example.org/browser/browser/components/search/test/browser/telemetry/searchTelemetryAd_shopping.html?s=test&abc=ff"
[task 2025-04-25T11:10:07.908Z] 11:10:07     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Reported Impression:" ({impressionId:"ea8fccac-b338-40df-97e4-4940d26ff7de", provider:"example", tagged:true, partnerCode:"ff", source:"unknown", isShoppingPage:false, isPrivate:false, isSignedIn:false, shoppingTabDisplayed:true})
[task 2025-04-25T11:10:08.837Z] 11:10:08     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Counting ad:" ({type:"shopping_tab", adsLoaded:1, adsVisible:1, adsHidden:0})
[task 2025-04-25T11:10:09.228Z] 11:10:09     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Telemetry state:" ({adsReported:false, adImpressionsReported:true, impressionId:"ea8fccac-b338-40df-97e4-4940d26ff7de", urlToComponentMap:{}, impressionInfo:{provider:"example", tagged:true, partnerCode:"ff", source:"unknown", isShoppingPage:false, isPrivate:false, isSignedIn:false}, searchBoxSubmitted:false, categorizationInfo:null, adsClicked:0, adsHidden:0, adsLoaded:0, adsVisible:0, searchQuery:"test"})
[task 2025-04-25T11:10:09.229Z] 11:10:09     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Counting click:" ({impressionId:"ea8fccac-b338-40df-97e4-4940d26ff7de", type:"shopping_tab", URL:"https://example.org/search?q=something&page=shopping&foo=bar"})
[task 2025-04-25T11:10:10.130Z] 11:10:10     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Impression:" "example:tagged:ff" "https://example.org/browser/browser/components/search/test/browser/telemetry/searchTelemetryAd_shopping.html?s=test&abc=ff"
[task 2025-04-25T11:10:10.251Z] 11:10:10     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Reported Impression:" ({impressionId:"5cc0fcda-e139-48a2-a6a9-b26ce66984d1", provider:"example", tagged:true, partnerCode:"ff", source:"unknown", isShoppingPage:false, isPrivate:false, isSignedIn:false, shoppingTabDisplayed:true})
[task 2025-04-25T11:10:11.212Z] 11:10:11     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Counting ad:" ({type:"shopping_tab", adsLoaded:1, adsVisible:1, adsHidden:0})
[task 2025-04-25T11:10:11.599Z] 11:10:11     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Telemetry state:" ({adsReported:false, adImpressionsReported:true, impressionId:"5cc0fcda-e139-48a2-a6a9-b26ce66984d1", urlToComponentMap:{}, impressionInfo:{provider:"example", tagged:true, partnerCode:"ff", source:"unknown", isShoppingPage:false, isPrivate:false, isSignedIn:false}, searchBoxSubmitted:false, categorizationInfo:null, adsClicked:0, adsHidden:0, adsLoaded:0, adsVisible:0, searchQuery:"test"})
[task 2025-04-25T11:10:11.601Z] 11:10:11     INFO - GECKO(2181) | console.debug: SearchTelemetry: "Counting click:" ({impressionId:"5cc0fcda-e139-48a2-a6a9-b26ce66984d1", type:"shopping_tab", URL:"https://example.org/search?q=something&page=shopping&foo=bar"})
[task 2025-04-25T11:10:12.343Z] 11:10:12     INFO - GECKO(2181) | MEMORY STAT | vsize 120590953MB | residentFast 1739MB
[task 2025-04-25T11:10:12.345Z] 11:10:12     INFO - TEST-OK | browser/components/search/test/browser/telemetry/browser_search_telemetry_shopping.js | took 5187ms
Flags: needinfo?(mbeier)
Assignee: nobody → mbeier
Status: NEW → ASSIGNED
Pushed by mbeier@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/0ec7c78759c5 Manually enable scotchBonnet in browser_search_telemetry_searchform.js. r=search-reviewers,Standard8
Flags: needinfo?(mbeier)
Whiteboard: [sng]
Severity: -- → N/A
Priority: -- → P1
Status: ASSIGNED → RESOLVED
Closed: 14 days ago
Resolution: --- → FIXED
Target Milestone: --- → 140 Branch
Attachment #9484277 - Flags: approval-mozilla-beta?
Attachment #9484277 - Flags: approval-mozilla-beta? → approval-mozilla-beta+

Verified fixed in today's late beta simulation

Status: RESOLVED → VERIFIED
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: