1815135 - Intermittent browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js | single tracking bug

Status: RESOLVED INCOMPLETE

(WebExtensions :: Untriaged, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-02-05T19:33:43.026Z] 19:33:43     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js | Promise rejected, expecting rejection to match '"Invalid tab ID: 854"', got 'Error: Invalid tab ID: 854': getAllFrames rejected Promise should pass the expected error - 
[task 2023-02-05T19:33:43.026Z] 19:33:43     INFO - Buffered messages logged at 19:31:55
[task 2023-02-05T19:33:43.027Z] 19:33:43     INFO - Console message: [JavaScript Error: "Timeout while waiting for extension child to shutdown: "Generated extension" (ID: {0aac33ce-440e-4294-acba-2aaac5ae1f86}, moz-extension://90e5cc74-b085-4ed9-8a66-b59394779fb7/)" {file: "resource://gre/modules/Extension.jsm" line: 3408}]
[task 2023-02-05T19:33:43.027Z] 19:33:43     INFO - shutdown@resource://gre/modules/Extension.jsm:3408:10
[task 2023-02-05T19:33:43.027Z] 19:33:43     INFO - async*receiveMessage@resource://specialpowers/SpecialPowersParent.sys.mjs:1217:28
[task 2023-02-05T19:33:43.027Z] 19:33:43     INFO - JSActor query*unload@resource://specialpowers/SpecialPowersChild.sys.mjs:1960:19
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - containerIsolation_restricted@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js:168:19
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - Async*handleTask@chrome://mochikit/content/browser-test.js:1037:26
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1109:18
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1251:14
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1026:14
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1036:13
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - 
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - Buffered messages finished
[task 2023-02-05T19:33:43.028Z] 19:33:43     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js | Test timed out - 
[task 2023-02-05T19:33:43.029Z] 19:33:43     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js | Extension left running at test shutdown - 
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - Stack trace:
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - chrome://mochikit/content/browser-test.js:test_ok:1456
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:132
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - chrome://mochikit/content/browser-test.js:nextTest:611
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1344
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1284
[task 2023-02-05T19:33:43.030Z] 19:33:43     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1026
[task 2023-02-05T19:33:43.031Z] 19:33:43     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1036
[task 2023-02-05T19:33:50.864Z] 19:33:50     INFO - Console message: [JavaScript Error: "Timeout while waiting for extension child to shutdown: "Generated extension" (ID: {64579f8c-3d4c-4c27-b67c-930566fcfade}, moz-extension://16177741-fdc5-4147-98e9-7ed79f3c31b1/)" {file: "resource://gre/modules/Extension.jsm" line: 3408}]
[task 2023-02-05T19:33:50.865Z] 19:33:50     INFO - shutdown@resource://gre/modules/Extension.jsm:3408:10
[task 2023-02-05T19:33:50.865Z] 19:33:50     INFO - async*receiveMessage@resource://specialpowers/SpecialPowersParent.sys.mjs:1217:28
[task 2023-02-05T19:33:50.865Z] 19:33:50     INFO - JSActor query*unload@resource://specialpowers/SpecialPowersChild.sys.mjs:1960:19
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - ExtensionTestUtils.loadExtension/<@chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:133:23
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - nextTest@chrome://mochikit/content/browser-test.js:611:35
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - async*timeoutFn@chrome://mochikit/content/browser-test.js:1344:18
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1284:80
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1026:14
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1036:13
[task 2023-02-05T19:33:50.866Z] 19:33:50     INFO - 
[task 2023-02-05T19:40:00.873Z] 19:40:00     INFO - Buffered messages finished
[task 2023-02-05T19:40:00.873Z] 19:40:00    ERROR - TEST-UNEXPECTED-TIMEOUT | browser/components/extensions/test/browser/browser_ext_webNavigation_containerIsolation.js | application timed out after 370 seconds with no output
[task 2023-02-05T19:40:00.874Z] 19:40:00    ERROR - Force-terminating active process(es).
[task 2023-02-05T19:40:00.874Z] 19:40:00     INFO - Determining child pids from psutil...
[task 2023-02-05T19:40:00.883Z] 19:40:00     INFO - [1706, 1731, 1782, 1837, 1967, 2092, 2093, 2248, 4839, 13000, 13094, 13104, 13112]
[task 2023-02-05T19:40:00.884Z] 19:40:00     INFO - ==> process 1608 launched child process 1626
[task 2023-02-05T19:40:00.884Z] 19:40:00     INFO - ==> process 1608 launched child process 1706

Comment 1

[Intermittent Failures Robot]

1 failures in 3606 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=1815135&startday=2023-01-30&endday=2023-02-05&tree=all

Comment 2

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

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