Open Bug 1952376 Opened 8 months ago Updated 2 months ago

Intermittent devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | single tracking bug

Categories

(DevTools :: Debugger, defect, P5)

Product:
DevTools
Component:
Debugger
Type:
defect

Tracking

(firefox-esr128 unaffected, firefox136 unaffected, firefox137 unaffected, firefox138 affected)

Tracking Flags:
Tracking Status
firefox-esr128 --- unaffected
firefox136 --- unaffected
firefox137 --- unaffected
firefox138 --- affected

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression, test-verify-fail)

Filed by: agoloman [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=497857330&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/PBObJlwuR02pyoffdKdlOg/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/PBObJlwuR02pyoffdKdlOg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

[task 2025-03-06T20:13:08.567Z] 20:13:08     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | The source is still loading until we release the network request - 
[task 2025-03-06T20:13:08.567Z] 20:13:08     INFO - Wait for the source to be fully selected and loaded
[task 2025-03-06T20:13:08.568Z] 20:13:08     INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.sys.mjs" line: 249}]
[task 2025-03-06T20:13:08.568Z] 20:13:08     INFO - Buffered messages logged at 20:13:08
[task 2025-03-06T20:13:08.569Z] 20:13:08     INFO - Waiting for state change: selected source
[task 2025-03-06T20:13:08.569Z] 20:13:08     INFO - --> The state was immediately correct (should rather do an immediate assertion?)
[task 2025-03-06T20:13:08.570Z] 20:13:08     INFO - Buffered messages finished
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | undefined assertion name - Got "Error: Incorrect contents fetched, please reload.", expected "console.log(\"slow-loading-page:first-load\");"
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - Stack trace:
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochikit/content/browser-test.js:test_is:1654
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochitests/content/browser/devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js:testLoadingHtmlSource:580
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochikit/content/browser-test.js:handleTask:1170
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1242
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1383
[task 2025-03-06T20:13:08.571Z] 20:13:08     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1153
[task 2025-03-06T20:13:08.572Z] 20:13:08     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1058
[task 2025-03-06T20:13:08.572Z] 20:13:08     INFO - Leaving test bound testLoadingHtmlSource
[task 2025-03-06T20:13:09.724Z] 20:13:09     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 27 (18319c000) [pid = 1691] [serial = 83] [outer = 0] [url = about:blank]
[task 2025-03-06T20:13:09.826Z] 20:13:09     INFO - Removing tab.
[task 2025-03-06T20:13:09.826Z] 20:13:09     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:09.862Z] 20:13:09     INFO - Got event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:09.891Z] 20:13:09     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/worker/checkouts/gecko/editor/composer/nsEditingSession.cpp:1163
[task 2025-03-06T20:13:09.923Z] 20:13:09     INFO - Tab removed and finished closing
[task 2025-03-06T20:13:10.231Z] 20:13:10     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: Worker has already shut down!!!: file /builds/worker/checkouts/gecko/dom/workers/WorkerRunnable.cpp:178
[task 2025-03-06T20:13:10.256Z] 20:13:10     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 1824ed800 == 12 [pid = 1691] [id = 36] [url = chrome://devtools/content/debugger/index.html]
[task 2025-03-06T20:13:11.824Z] 20:13:11     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 26 (182eb1800) [pid = 1691] [serial = 88] [outer = 0] [url = about:blank]
[task 2025-03-06T20:13:11.851Z] 20:13:11     INFO - Removing tab.
[task 2025-03-06T20:13:11.851Z] 20:13:11     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:11.886Z] 20:13:11     INFO - Got event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:11.944Z] 20:13:11     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/worker/checkouts/gecko/editor/composer/nsEditingSession.cpp:1163
[task 2025-03-06T20:13:12.011Z] 20:13:12     INFO - Tab removed and finished closing
[task 2025-03-06T20:13:12.219Z] 20:13:12     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: '!embedder', file /builds/worker/checkouts/gecko/dom/ipc/WindowGlobalParent.cpp:308
[task 2025-03-06T20:13:12.219Z] 20:13:12     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: '!embedder', file /builds/worker/checkouts/gecko/dom/ipc/WindowGlobalParent.cpp:308
[task 2025-03-06T20:13:13.891Z] 20:13:13     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 183195400 == 11 [pid = 1691] [id = 34] [url = chrome://devtools/content/debugger/index.html]
[task 2025-03-06T20:13:13.899Z] 20:13:13     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 18319b800 == 10 [pid = 1691] [id = 33] [url = about:devtools-toolbox]
[task 2025-03-06T20:13:13.933Z] 20:13:13     INFO - Removing tab.
[task 2025-03-06T20:13:13.933Z] 20:13:13     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:13.952Z] 20:13:13     INFO - Got event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:14.001Z] 20:13:14     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/worker/checkouts/gecko/editor/composer/nsEditingSession.cpp:1163
[task 2025-03-06T20:13:14.044Z] 20:13:14     INFO - Tab removed and finished closing
[task 2025-03-06T20:13:14.320Z] 20:13:14     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: '!embedder', file /builds/worker/checkouts/gecko/dom/ipc/WindowGlobalParent.cpp:308
[task 2025-03-06T20:13:16.046Z] 20:13:16     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 18571d000 == 9 [pid = 1691] [id = 32] [url = chrome://devtools/content/debugger/index.html]
[task 2025-03-06T20:13:16.047Z] 20:13:16     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 185714400 == 8 [pid = 1691] [id = 31] [url = about:devtools-toolbox]
[task 2025-03-06T20:13:16.089Z] 20:13:16     INFO - Removing tab.
[task 2025-03-06T20:13:16.090Z] 20:13:16     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:16.128Z] 20:13:16     INFO - Got event: 'TabClose' on [object XULElement].
[task 2025-03-06T20:13:16.171Z] 20:13:16     INFO - GECKO(1691) | [Parent 1691, Main Thread] WARNING: NS_ENSURE_TRUE(mDoneSetup) failed: file /builds/worker/checkouts/gecko/editor/composer/nsEditingSession.cpp:1163
[task 2025-03-06T20:13:16.191Z] 20:13:16     INFO - Tab removed and finished closing
[task 2025-03-06T20:13:16.697Z] 20:13:16     INFO - GECKO(1691) | [Child 1921: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 118110400 == 0 [pid = 1921] [id = 0] [url = http://localhost:49907/slow-loading-page.html]
[task 2025-03-06T20:13:16.720Z] 20:13:16     INFO - GECKO(1691) | [Child 1921: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (10d01fa00) [pid = 1921] [serial = 1] [outer = 0] [url = http://localhost:49907/slow-loading-page.html]
[task 2025-03-06T20:13:16.729Z] 20:13:16     INFO - GECKO(1691) | [Child 1921: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (119d29800) [pid = 1921] [serial = 3] [outer = 0] [url = http://localhost:49907/slow-loading-page.html]
[task 2025-03-06T20:13:16.743Z] 20:13:16     INFO - GECKO(1691) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-03-06T20:13:16.770Z] 20:13:16     INFO - GECKO(1691) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-03-06T20:13:16.772Z] 20:13:16     INFO - GECKO(1691) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-03-06T20:13:16.777Z] 20:13:16     INFO - GECKO(1691) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-03-06T20:13:16.779Z] 20:13:16     INFO - GECKO(1691) | JavaScript error: , line 0: NotFoundError: No such JSProcessActor 'DevToolsProcess'
[task 2025-03-06T20:13:16.855Z] 20:13:16     INFO - GECKO(1691) | [Parent 1691: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 18571ac00 == 7 [pid = 1691] [id = 30] [url = chrome://devtools/content/debugger/index.html]
[task 2025-03-06T20:13:17.341Z] 20:13:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSProcessActor 'DevToolsProcess'"]
[task 2025-03-06T20:13:17.345Z] 20:13:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSProcessActor 'DevToolsProcess'"]
[task 2025-03-06T20:13:17.347Z] 20:13:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSProcessActor 'DevToolsProcess'"]
[task 2025-03-06T20:13:17.352Z] 20:13:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSProcessActor 'DevToolsProcess'"]
[task 2025-03-06T20:13:17.354Z] 20:13:17     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSProcessActor 'DevToolsProcess'"]
[task 2025-03-06T20:13:17.363Z] 20:13:17     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | The main process DevToolsServer has no pending connection when the test ends - 
<...>

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

:ochameau, since you are the author of the regressor, bug 1950654, could you take a look?

For more information, please visit BugBot documentation.

status-firefox136: --- → unaffected
status-firefox137: --- → unaffected
status-firefox138: --- → affected
status-firefox-esr128: --- → unaffected
Flags: needinfo?(poirot.alex)

Not an actual regression, test was just modified in Bug 1950654. Works fine locally.

Flags: needinfo?(poirot.alex)
Summary: Intermittent TV devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | undefined assertion name - Got "Error: Incorrect contents fetched, please reload.", expected "console.log(\"slow-loading-page:first-load\");" → Intermittent TV devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | single tracking bug
Summary: Intermittent TV devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | single tracking bug → Intermittent devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | single tracking bug
You need to log in before you can comment on or make changes to this bug.