Closed Bug 1778803 Opened 3 years ago Closed 1 year ago

Intermittent devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | single tracking bug

Categories

(DevTools :: General, defect, P5)

defect

Tracking

(firefox128 fixed)

RESOLVED FIXED
128 Branch
Tracking Status
firefox128 --- fixed

People

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

References

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [stockwell needswork:owner])

Attachments

(1 file, 1 obsolete file)

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


[task 2022-07-08T22:35:24.030Z] 22:35:24     INFO - Buffered messages finished
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | Uncaught exception in test - at chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:1056 - Error: Failed waitFor():  
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - Failed condition: () =>
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO -     [...targets].every(
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO -       target =>
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO -         target == targetCommand.targetFront || target.targetType == TYPES.WORKER
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO -     ) 
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - Exception Message:  - timed out after 500 tries.
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - Stack trace:
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - waitFor@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:1056:11
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - async*@chrome://mochitests/content/browser/devtools/shared/commands/target/tests/browser_target_command_scope_flag.js:86:9
[task 2022-07-08T22:35:24.033Z] 22:35:24     INFO - Async*handleTask@chrome://mochikit/content/browser-test.js:989:26
[task 2022-07-08T22:35:24.034Z] 22:35:24     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1061:18
[task 2022-07-08T22:35:24.034Z] 22:35:24     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1196:14
[task 2022-07-08T22:35:24.034Z] 22:35:24     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:978:14
[task 2022-07-08T22:35:24.034Z] 22:35:24     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1041:13
[task 2022-07-08T22:35:24.034Z] 22:35:24     INFO - Leaving test bound 
[task 2022-07-08T22:35:24.035Z] 22:35:24     INFO - Removing tab.
[task 2022-07-08T22:35:24.035Z] 22:35:24     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2022-07-08T22:35:24.036Z] 22:35:24     INFO - Got event: 'TabClose' on [object XULElement].
[task 2022-07-08T22:35:24.036Z] 22:35:24     INFO - GECKO(8584) | [Child 8480, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-08T22:35:24.036Z] 22:35:24     INFO - Tab removed and finished closing
[task 2022-07-08T22:35:24.037Z] 22:35:24     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-07-08T22:35:24.038Z] 22:35:24     INFO - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2022-07-08T22:35:24.038Z] 22:35:24     INFO - Stack trace:
[task 2022-07-08T22:35:24.038Z] 22:35:24     INFO - chrome://mochikit/content/browser-test.js:test_ok:1401
[task 2022-07-08T22:35:24.038Z] 22:35:24     INFO - chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:cleanup:260
[task 2022-07-08T22:35:24.039Z] 22:35:24     INFO - GECKO(8584) | MEMORY STAT | vsize 2104240MB | vsizeMaxContiguous 66144135MB | residentFast 298MB | heapAllocated 101MB
[task 2022-07-08T22:35:24.039Z] 22:35:24     INFO - TEST-OK | devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | took 9507ms
[task 2022-07-08T22:35:24.041Z] 22:35:24     INFO - GECKO(8584) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_165731291569753\AppData\Local\Temp\tmpgh2v_io9.mozrunner\runtests_leaks_tab_pid7292.log
[task 2022-07-08T22:35:24.041Z] 22:35:24     INFO - GECKO(8584) | [7292, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:340
[task 2022-07-08T22:35:24.044Z] 22:35:24     INFO - GECKO(8584) | [Child 7028, Main Thread] WARNING: '!CanHandleWith(aPresContext)', file /builds/worker/checkouts/gecko/dom/events/IMEStateManager.cpp:498
[task 2022-07-08T22:35:24.055Z] 22:35:24     INFO - GECKO(8584) | [Child 8480: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (1a710d9c400) [pid = 8480] [serial = 2] [outer = 0] [url = about:blank]
[task 2022-07-08T22:35:24.055Z] 22:35:24     INFO - GECKO(8584) | [Child 8480: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 1a710d9c000 == 0 [pid = 8480] [id = 0] [url = data:text/html;charset=utf-8,%3Cdiv%20id%3D%22test%22%3E%3C%2Fdiv%3E]
[task 2022-07-08T22:35:24.060Z] 22:35:24     INFO - checking window state
[task 2022-07-08T22:35:24.071Z] 22:35:24     INFO - GECKO(8584) | JavaScript error: resource://devtools/shared/protocol/Front/FrontClassWithSpec.js, line 30: Error: Can not send request 'watchTargets' because front 'watcher' is already destroyed.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago3 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 3 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Attachment #9385599 - Attachment is obsolete: true

Update

There have been 40 total failures within the last 7 days:

  • 20 failures on Linux 18.04 x64 WebRender opt
  • 9 failures on Linux 18.04 x64 WebRender Shippable opt
  • 1 failure on Linux 18.04 x64 WebRender tsan opt
  • 6 failures on OS X 10.15 WebRender opt
  • 4 failures on Windows 11 x86 22H2 WebRender opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=450177351&repo=autoland&lineNumber=29077

[task 2024-03-09T11:46:37.459Z] 11:46:37     INFO - TEST-PASS | devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | The new tab process should be ignored and no target be created - 
[task 2024-03-09T11:46:37.459Z] 11:46:37     INFO - Re-enable multiprocess debugging
[task 2024-03-09T11:46:37.459Z] 11:46:37     INFO - Buffered messages finished
[task 2024-03-09T11:46:37.460Z] 11:46:37     INFO - TEST-UNEXPECTED-FAIL | devtools/shared/commands/target/tests/browser_target_command_scope_flag.js | Uncaught exception in test bound  - at chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:1094 - Error: Failed waitFor(): Wait for all targets we used to have before disable multiprocess debugging 
[task 2024-03-09T11:46:37.460Z] 11:46:37     INFO - Failed condition: () => targets.size == multiprocessTargetCount 
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - Exception Message: Wait for all targets we used to have before disable multiprocess debugging - timed out after 500 tries.
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - Stack trace:
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - waitFor@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:1094:11
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - async*@chrome://mochitests/content/browser/devtools/shared/commands/target/tests/browser_target_command_scope_flag.js:144:9
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - async*handleTask@chrome://mochikit/content/browser-test.js:1139:26
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - _runTaskBasedTest@chrome://mochikit/content/browser-test.js:1211:18
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1353:14
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1128:14
[task 2024-03-09T11:46:37.461Z] 11:46:37     INFO - SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1058:13
[task 2024-03-09T11:46:37.462Z] 11:46:37     INFO - Leaving test bound 
[task 2024-03-09T11:46:37.462Z] 11:46:37     INFO - Removing tab.

Jan, can you please take a look at this too?
Thank you.

Flags: needinfo?(odvarko)
Whiteboard: [stockwell needswork:owner]

Alex, any idea why this would start failing?

Flags: needinfo?(odvarko) → needinfo?(poirot.alex)

Update:
There have been 36 total failures in the last 7 days.
There are:

  • 23 failures on linux1804-64-qr opt
  • 12 failures on linux1804-64-shippable-qr opt
  • 1 failure on macosx1015-64-qr opt

Recent failure log.

Update:
There have been 37 total failures in the last 7 days.
There are:

  • 30 failures on linux1804-64-qr opt
  • 7 failures on linux1804-64-shippable-qr opt

Recent failure log.

Update

There have been 34 failures within the last 7 days:

  • 27 failures on Linux 18.04 x64 WebRender opt
  • 7 failures on Linux 18.04 x64 WebRender Shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=455249051&repo=autoland&lineNumber=18602

[task 2024-04-20T06:16:45.226Z] 06:16:45     INFO - TEST-PASS | devtools/client/framework/test/browser_toolbox_toggle.js | Toolbox opened on separate window - 
[task 2024-04-20T06:16:45.226Z] 06:16:45     INFO - Wait for focus on the toolbox window
[task 2024-04-20T06:16:45.227Z] 06:16:45     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked an inline style (style-src-attr) from being applied because it violates the following directive: “default-src chrome: resource:”" {file: "chrome://global/content/customElements.js" line: 499 column: 25 source: "display: none !important"}]
[task 2024-04-20T06:16:45.228Z] 06:16:45     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked an inline style (style-src-attr) from being applied because it violates the following directive: “default-src chrome: resource:”" {file: "chrome://global/content/customElements.js" line: 499}]
[task 2024-04-20T06:16:45.228Z] 06:16:45     INFO - Console message: [JavaScript Error: "Content-Security-Policy: The page’s settings blocked an inline style (style-src-attr) from being applied because it violates the following directive: “default-src chrome: resource:”" {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2024-04-20T06:16:45.229Z] 06:16:45     INFO - Buffered messages finished
[task 2024-04-20T06:16:45.229Z] 06:16:45     INFO - TEST-UNEXPECTED-FAIL | devtools/client/framework/test/browser_toolbox_toggle.js | Test timed out - 
[task 2024-04-20T06:16:45.230Z] 06:16:45     INFO - GECKO(4333) | Completed ShutdownLeaks collections in process 4333

It is always tricky to test the Browser Toolbox codepaths as you may have various targets
related to previous test/tasks which are being destroyed in middle of the test.
Here some target related to previous task were removed in middle of this assertion.

It is better to test for actual deterministic content we are expecting rather than counting targets.

Assignee: nobody → poirot.alex
Flags: needinfo?(poirot.alex)
Pushed by apoirot@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/05d64e7dcef3 [devtools] Fix browser_target_command_scope_flag.js intermittent. r=devtools-reviewers,nchevobbe
Status: REOPENED → RESOLVED
Closed: 2 years ago1 year ago
Resolution: --- → FIXED
Target Milestone: --- → 128 Branch
See Also: → 1897895
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: