Open Bug 1783408 Opened 3 years ago Updated 13 days ago

Intermittent browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | single tracking bug

Categories

(WebExtensions :: General, defect, P5)

Product:
WebExtensions
Component:
General
Type:
defect

Tracking

(Not tracked)

Status:
REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

Attachments

(1 obsolete file)

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

[task 2022-08-05T09:59:35.043Z] 09:59:35     INFO - TEST-PASS | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | Expected key to must be in actual extra. Actual keys: [addonId,addonVersion,from,to]. - true == true - 
[task 2022-08-05T09:59:35.046Z] 09:59:35     INFO - TEST-PASS | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | extra[to] must match in event addonsSearchDetection#etld_change#webrequest. - "mochi.test" matches "mochi.test" - 
[task 2022-08-05T09:59:35.046Z] 09:59:35     INFO - Leaving test bound test_onBeforeRequest
[task 2022-08-05T09:59:35.047Z] 09:59:35     INFO - Entering test bound test_onBeforeRequest_url_not_monitored
[task 2022-08-05T09:59:35.048Z] 09:59:35     INFO - Extension loaded
[task 2022-08-05T09:59:35.050Z] 09:59:35     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://example.com/search?q=babar" line: 0}]
[task 2022-08-05T09:59:35.051Z] 09:59:35     INFO - Buffered messages logged at 09:59:33
[task 2022-08-05T09:59:35.053Z] 09:59:35     INFO - Leaving test bound test_onBeforeRequest_url_not_monitored
[task 2022-08-05T09:59:35.053Z] 09:59:35     INFO - Entering test bound test_onHeadersReceived
[task 2022-08-05T09:59:35.056Z] 09:59:35     INFO - Extension loaded
[task 2022-08-05T09:59:35.056Z] 09:59:35     INFO - Buffered messages logged at 09:59:34
[task 2022-08-05T09:59:35.060Z] 09:59:35     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "http://mochi.test:8888/" line: 0}]
[task 2022-08-05T09:59:35.060Z] 09:59:35     INFO - Buffered messages finished
[task 2022-08-05T09:59:35.064Z] 09:59:35     INFO - TEST-UNEXPECTED-FAIL | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | dynamic must be in snapshot. Has [parent]. - false == true - JS frame :: resource://testing-common/TelemetryTestUtils.jsm :: assertEvents :: line 142
[task 2022-08-05T09:59:35.064Z] 09:59:35     INFO - Stack trace:
[task 2022-08-05T09:59:35.064Z] 09:59:35     INFO - resource://testing-common/TelemetryTestUtils.jsm:assertEvents:142
[task 2022-08-05T09:59:35.065Z] 09:59:35     INFO - chrome://mochitests/content/browser/browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js:testClientSideRedirect:61
[task 2022-08-05T09:59:35.066Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 26 (7f14c0eccb70) [pid = 7725] [serial = 22] [outer = 0] [url = moz-extension://fb724fa2-ff8a-49bb-b4bc-4efd1f93ef64/_generated_background_page.html]
[task 2022-08-05T09:59:35.066Z] 09:59:35     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-08-05T09:59:35.070Z] 09:59:35     INFO - TEST-UNEXPECTED-FAIL | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | Uncaught exception in test - at resource://testing-common/TelemetryTestUtils.jsm:166 - TypeError: can't access property "map", snapshot is undefined
[task 2022-08-05T09:59:35.070Z] 09:59:35     INFO - Stack trace:
[task 2022-08-05T09:59:35.070Z] 09:59:35     INFO - assertEvents@resource://testing-common/TelemetryTestUtils.jsm:166:20
[task 2022-08-05T09:59:35.071Z] 09:59:35     INFO - testClientSideRedirect@chrome://mochitests/content/browser/browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js:61:22
[task 2022-08-05T09:59:35.072Z] 09:59:35     INFO - Leaving test bound test_onHeadersReceived
[task 2022-08-05T09:59:35.072Z] 09:59:35     INFO - Entering test bound test_onHeadersReceived_url_not_monitored
[task 2022-08-05T09:59:35.073Z] 09:59:35     INFO - Extension loaded
[task 2022-08-05T09:59:35.079Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 25 (7f14dcc91d90) [pid = 7725] [serial = 3] [outer = 0] [url = moz-extension://22391790-6483-4345-bcd1-101e624def89/_generated_background_page.html]
[task 2022-08-05T09:59:35.081Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 24 (7f14c0ecc600) [pid = 7725] [serial = 19] [outer = 0] [url = moz-extension://a5fd1d4a-5ae7-4c72-ae06-f7e46f110d8a/_generated_background_page.html]
[task 2022-08-05T09:59:35.083Z] 09:59:35     INFO - GECKO(7662) | [Child 7749: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (7f9d841919f0) [pid = 7749] [serial = 1] [outer = 0] [url = about:blank]
[task 2022-08-05T09:59:35.084Z] 09:59:35     INFO - GECKO(7662) | [Child 7941: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7fe301728400 == 0 [pid = 7941] [id = 0] [url = http://mochi.test:8888/]
[task 2022-08-05T09:59:35.085Z] 09:59:35     INFO - GECKO(7662) | [Child 7941: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7fe301791bc0) [pid = 7941] [serial = 1] [outer = 0] [url = http://mochi.test:8888/]
[task 2022-08-05T09:59:35.086Z] 09:59:35     INFO - GECKO(7662) | [Child 7941: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7fe2e6545c00) [pid = 7941] [serial = 3] [outer = 0] [url = http://mochi.test:8888/]
[task 2022-08-05T09:59:35.091Z] 09:59:35     INFO - GECKO(7662) | [Child 7941: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7fe2e6543400) [pid = 7941] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-08-05T09:59:35.092Z] 09:59:35     INFO - GECKO(7662) | [Child 7941, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-08-05T09:59:35.092Z] 09:59:35     INFO - GECKO(7662) | [Child 7941, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-08-05T09:59:35.093Z] 09:59:35     INFO - GECKO(7662) | [Child 7941, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4595
[task 2022-08-05T09:59:35.094Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f14c0e20000 == 6 [pid = 7725] [id = 9]
[task 2022-08-05T09:59:35.095Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 25 (7f14c0ecc600) [pid = 7725] [serial = 28] [outer = 0]
[task 2022-08-05T09:59:35.095Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 26 (7f14c0e20c00) [pid = 7725] [serial = 29] [outer = 7f14c0ecc600]
[task 2022-08-05T09:59:35.096Z] 09:59:35     INFO - GECKO(7662) | [Child 7725, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp:2822
[task 2022-08-05T09:59:35.098Z] 09:59:35     INFO - GECKO(7662) | [Child 7725: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 27 (7f14c0e1f400) [pid = 7725] [serial = 30] [outer = 7f14c0ecc600]
[task 2022-08-05T09:59:35.106Z] 09:59:35     INFO - GECKO(7662) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmph7u46p0f.mozrunner/runtests_leaks_tab_pid7994.log
[task 2022-08-05T09:59:35.107Z] 09:59:35     INFO - GECKO(7662) | [7994, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:339
[task 2022-08-05T09:59:35.146Z] 09:59:35     INFO - GECKO(7662) | [Child 7994, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:707
[task 2022-08-05T09:59:35.185Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f99b2728000 == 1 [pid = 7967] [id = 0]
[task 2022-08-05T09:59:35.188Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (7f99b27919f0) [pid = 7967] [serial = 1] [outer = 0]
[task 2022-08-05T09:59:35.191Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (7f99b2728400) [pid = 7967] [serial = 2] [outer = 7f99b27919f0]
[task 2022-08-05T09:59:35.231Z] 09:59:35     INFO - GECKO(7662) | [Child 7819, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-08-05T09:59:35.424Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (7f9997549400) [pid = 7967] [serial = 3] [outer = 7f99b27919f0]
[task 2022-08-05T09:59:35.533Z] 09:59:35     INFO - Console message: [JavaScript Warning: "This page is in Quirks Mode. Page layout may be impacted. For Standards Mode use “<!DOCTYPE html>”." {file: "https://example.com/search?q=babar" line: 0}]
[task 2022-08-05T09:59:35.620Z] 09:59:35     INFO - GECKO(7662) | [Child 7967, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-08-05T09:59:35.717Z] 09:59:35     INFO - GECKO(7662) | [Child 7725, Main Thread] WARNING: '!CanSend() || !mManager || !mManager->CanSend()', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorChild.cpp:44
[task 2022-08-05T09:59:35.758Z] 09:59:35     INFO - GECKO(7662) | [Parent 7662, IPDL Background] WARNING: IPC Connection Error: [Parent][PBackgroundParent] RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost: file /builds/worker/checkouts/gecko/ipc/glue/MessageChannel.cpp:1876
[task 2022-08-05T09:59:35.812Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 7f99b2728000 == 0 [pid = 7967] [id = 0] [url = https://example.com/search?q=babar]
[task 2022-08-05T09:59:35.834Z] 09:59:35     INFO - TEST-PASS | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | dynamic must be in snapshot. Has [parent,dynamic]. - true == true - 
[task 2022-08-05T09:59:35.838Z] 09:59:35     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-08-05T09:59:35.839Z] 09:59:35     INFO - TEST-UNEXPECTED-FAIL | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | After filtering we must have the expected number of events. - 1 == 0 - JS frame :: resource://testing-common/TelemetryTestUtils.jsm :: assertEvents :: line 181
[task 2022-08-05T09:59:35.839Z] 09:59:35     INFO - Stack trace:
[task 2022-08-05T09:59:35.839Z] 09:59:35     INFO - resource://testing-common/TelemetryTestUtils.jsm:assertEvents:181
[task 2022-08-05T09:59:35.839Z] 09:59:35     INFO - chrome://mochitests/content/browser/browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js:testClientSideRedirect:61
[task 2022-08-05T09:59:35.839Z] 09:59:35     INFO - Leaving test bound test_onHeadersReceived_url_not_monitored
[task 2022-08-05T09:59:35.843Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (7f99b27919f0) [pid = 7967] [serial = 1] [outer = 0] [url = https://example.com/search?q=babar]
[task 2022-08-05T09:59:35.845Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (7f9997549400) [pid = 7967] [serial = 3] [outer = 0] [url = https://example.com/search?q=babar]
[task 2022-08-05T09:59:35.846Z] 09:59:35     INFO - GECKO(7662) | [Child 7967: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (7f99b2728400) [pid = 7967] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-08-05T09:59:35.847Z] 09:59:35     INFO - GECKO(7662) | [Child 7967, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3359
[task 2022-08-05T09:59:35.863Z] 09:59:35     INFO - GECKO(7662) | [Child 7967, Main Thread] WARNING: NS_ENSURE_TRUE(InitStaticMembers()) failed: file /builds/worker/workspace/obj-build/dist/include/mozilla/Preferences.h:129
[task 2022-08-05T09:59:35.878Z] 09:59:35     INFO - GECKO(7662) | [Child 7967, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4595
[task 2022-08-05T09:59:35.963Z] 09:59:35     INFO - TEST-PASS | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | test search engine unregistered - 
[task 2022-08-05T09:59:35.982Z] 09:59:35     INFO - GECKO(7662) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2022-08-05T09:59:35.983Z] 09:59:35     INFO - GECKO(7662) | MEMORY STAT | vsize 11209MB | residentFast 441MB | heapAllocated 196MB
[task 2022-08-05T09:59:35.984Z] 09:59:35     INFO - TEST-OK | browser/extensions/search-detection/tests/browser/browser_client_side_redirection.js | took 5898ms
[task 2022-08-05T09:59:35.994Z] 09:59:35     INFO - GECKO(7662) | [Child 7749: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 7f9d68f72c00 == 1 [pid = 7749] [id = 1]
[task 2022-08-05T09:59:35.995Z] 09:59:35     INFO - GECKO(7662) | [Child 7749: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (7f9d841919f0) [pid = 7749] [serial = 5] [outer = 0]
[task 2022-08-05T09:59:35.998Z] 09:59:35     INFO - GECKO(7662) | [Child 7749: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 5 (7f9d68f73000) [pid = 7749] [serial = 6] [outer = 7f9d841919f0]
[task 2022-08-05T09:59:36.010Z] 09:59:36     INFO - GECKO(7662) | [Child 7819, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-08-05T09:59:36.055Z] 09:59:36     INFO - checking window state
[task 2022-08-05T09:59:36.121Z] 09:59:36     INFO - TEST-START | browser/extensions/search-detection/tests/browser/browser_extension_loaded.js

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

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=408279974&repo=elm

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 3 years ago → 2 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=419692199&repo=mozilla-central

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=439006704&repo=mozilla-central

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 2 years ago → 1 year ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=447613828&repo=try

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Attachment #9387042 - Attachment is obsolete: true

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

Status: REOPENED → RESOLVED
Closed: 1 year ago → 1 year ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=455017811&repo=mozilla-central

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 1 year ago → 1 year ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=472115560&repo=try

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 1 year ago → 2 months ago
Resolution: --- → INCOMPLETE

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=502100283&repo=autoland

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

Attachment

General

Creator:
Created:
Updated:
Size: