Closed Bug 1531407 Opened 1 year ago Closed 1 year ago

Intermittent devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | A promise chain failed to handle a rejection: Connection closed, pending request to server1.conn3.child37/highlighter26, type showBoxModel failed

Categories

(DevTools :: about:debugging, defect, P5)

defect

Tracking

(firefox-esr60 unaffected, firefox66 unaffected, firefox67 wontfix, firefox68 fixed)

RESOLVED FIXED
Firefox 68
Tracking Status
firefox-esr60 --- unaffected
firefox66 --- unaffected
firefox67 --- wontfix
firefox68 --- fixed

People

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

Details

(Keywords: intermittent-failure, regression, Whiteboard: [stockwell unknown])

Attachments

(1 file)

#[markdown(off)]
Filed by: csabou [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=231016891&repo=mozilla-central

https://queue.taskcluster.net/v1/task/WVq9OBVGSxWZnp223a7HKg/runs/0/artifacts/public/logs/live_backing.log

15:19:09 INFO - TEST-PASS | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | Addon toolbox closed -
15:19:09 INFO - Remove the temporary extension with name: 'test-devtools-webextension'
15:19:09 INFO - Wait until the debug target item disappears
15:19:09 INFO - Buffered messages logged at 15:18:52
15:19:09 INFO - Removing tab.
15:19:09 INFO - Waiting for event: 'TabClose' on [object XULElement].
15:19:09 INFO - Got event: 'TabClose' on [object XULElement].
15:19:09 INFO - Tab removed and finished closing
15:19:09 INFO - Buffered messages finished
15:19:09 INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | A promise chain failed to handle a rejection: Connection closed, pending request to server1.conn3.child37/highlighter26, type showBoxModel failed
15:19:09 INFO -
15:19:09 INFO - Request stack:
15:19:09 INFO - request@resource://devtools/shared/protocol.js:1386:14
15:19:09 INFO - generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol.js:1510:19
15:19:09 INFO - highlight@resource://devtools/shared/fronts/highlighters.js:73:16
15:19:09 INFO - async*onHighlightFrame@resource://devtools/client/framework/toolbox.js:2463:24
15:19:09 INFO - async*highlightFrame@resource://devtools/client/framework/components/ToolboxToolbar.js:281:13
15:19:09 INFO - notifyHighlightedChildChange@resource://devtools/client/shared/components/menu/MenuList.js:61:18
15:19:09 INFO - onMouseOverOrFocus@resource://devtools/client/shared/components/menu/MenuList.js:49:10
15:19:09 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:77:10
15:19:09 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:107:27
15:19:09 INFO - invokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:121:43
15:19:09 INFO - executeDispatch@resource://devtools/client/shared/vendor/react-dom.js:399:19
15:19:09 INFO - executeDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:418:5
15:19:09 INFO - executeDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:516:5
15:19:09 INFO - executeDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:527:10
15:19:09 INFO - forEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:497:8
15:19:09 INFO - runEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:658:5
15:19:09 INFO - runExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:667:3
15:19:09 INFO - handleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4262:5
15:19:09 INFO - batchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13458:12
15:19:09 INFO - batchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:2022:12
15:19:09 INFO - dispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4341:5
15:19:09 INFO - interactiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13513:12
15:19:09 INFO - interactiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:2041:10
15:19:09 INFO - dispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4318:3
15:19:09 INFO - focus@resource://devtools/client/shared/widgets/tooltip/HTMLTooltip.js:878:24
15:19:09 INFO - onClick@resource://devtools/client/shared/components/menu/MenuButton.js:303:24
15:19:09 INFO - Async*invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:77:10
15:19:09 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:107:27
15:19:09 INFO - invokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:121:43
15:19:09 INFO - executeDispatch@resource://devtools/client/shared/vendor/react-dom.js:399:19
15:19:09 INFO - executeDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:418:5
15:19:09 INFO - executeDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:516:5
15:19:09 INFO - executeDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:527:10
15:19:09 INFO - forEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:497:8
15:19:09 INFO - runEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:658:5
15:19:09 INFO - runExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:667:3
15:19:09 INFO - handleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4262:5
15:19:09 INFO - batchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13458:12
15:19:09 INFO - batchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:2022:12
15:19:09 INFO - dispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4341:5
15:19:09 INFO - interactiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13513:12
15:19:09 INFO - interactiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:2041:10
15:19:09 INFO - dispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4318:3
15:19:09 INFO - toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:202:11
15:19:09 INFO - - stack: destroy@resource://devtools/shared/protocol.js:1299:23
15:19:09 INFO - destroy@resource://devtools/shared/protocol.js:946:17
15:19:09 INFO - destroy@resource://devtools/shared/protocol.js:1301:11
15:19:09 INFO - destroy@resource://devtools/shared/fronts/inspector.js:486:11
15:19:09 INFO - destroyInspector/this._destroyingInspector<@resource://devtools/client/framework/toolbox.js:2870:29
15:19:09 INFO - Async*destroyInspector@resource://devtools/client/framework/toolbox.js:2876:18
15:19:09 INFO - _destroyToolbox@resource://devtools/client/framework/toolbox.js:2977:27
15:19:09 INFO - async*destroy@resource://devtools/client/framework/toolbox.js:2907:28
15:19:09 INFO - closeToolbox@resource://devtools/client/framework/toolbox.js:2891:16
15:19:09 INFO - Async*toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:228:21
15:19:09 INFO - setTimeout handler*setTimeoutIfNeeded/this.throttledDispatchPromise<@resource://devtools/client/webconsole/webconsole-wrapper.js:566:7
15:19:09 INFO - setTimeoutIfNeeded@resource://devtools/client/webconsole/webconsole-wrapper.js:565:37
15:19:09 INFO - batchedMessageAdd@resource://devtools/client/webconsole/webconsole-wrapper.js:538:10
15:19:09 INFO - dispatchMessageAdd@resource://devtools/client/webconsole/webconsole-wrapper.js:390:10
15:19:09 INFO - _executeResultCallback@resource://devtools/client/webconsole/components/JSTerm.js:564:40
15:19:09 INFO - async*execute@resource://devtools/client/webconsole/components/JSTerm.js:631:17
15:19:09 INFO - async*toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:226:20
15:19:09 INFO - setTimeout handler*SimpleTest_setTimeoutShim@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:684:43
15:19:09 INFO - wait/<@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:392:5
15:19:09 INFO - wait@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:391:10
15:19:09 INFO - toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:223:71
15:19:09 INFO - Rejection date: Thu Feb 28 2019 15:18:46 GMT+0000 (Greenwich Mean Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 257
15:19:09 INFO - Stack trace:
15:19:09 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:257
15:19:09 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1130
15:19:09 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1134
15:19:09 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:995
15:19:09 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
15:19:09 INFO - Leaving test bound testWebExtensionsToolboxWebConsole
15:19:09 INFO - GECKO(10344) | --DOMWINDOW == 33 (000001AD14EBE400) [pid = 2412] [serial = 61] [outer = 0000000000000000] [url = about:debugging]
15:19:09 INFO - GECKO(10344) | --DOCSHELL 000001AD13FB5000 == 12 [pid = 2412] [id = {c7ac12b4-a4b9-4e19-8387-78371be725a0}]
15:19:09 INFO - TEST-FAIL | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | Assertion count 1 is greater than expected range 0-0 assertions. -
15:19:09 INFO - GECKO(10344) | MEMORY STAT | vsize 2103548MB | vsizeMaxContiguous 66583150MB | residentFast 511MB | heapAllocated 138MB
15:19:09 INFO - TEST-OK | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | took 28953ms
15:19:09 INFO - GECKO(10344) | DLL blocklist was unable to intercept AppInit DLLs.
15:19:09 INFO - GECKO(10344) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\task_1551366496\appdata\local\temp\tmpg5tk1i.mozrunner\runtests_leaks_tab_pid8884.log
15:19:09 INFO - checking window state
15:19:09 INFO - GECKO(10344) | [Parent 2412, Main Thread] WARNING: '!parent', file z:/build/build/src/netwerk/ipc/NeckoParent.cpp, line 95

There are 29 total failures on windows10-64-ccov in the last 7 days.
Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=241594189&repo=mozilla-central&lineNumber=2103

11:59:02 INFO - TEST-START | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js
11:59:51 INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js | A promise chain failed to handle a rejection: Connection closed, pending request to server1.conn7.child24/highlighter22, type showBoxModel failed
11:59:51 INFO -
11:59:51 INFO - Request stack:
11:59:51 INFO - request@resource://devtools/shared/protocol.js:1386:14
11:59:51 INFO - generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol.js:1510:19
11:59:51 INFO - highlight@resource://devtools/shared/fronts/highlighters.js:73:16
11:59:51 INFO - onHighlightFrame@resource://devtools/client/framework/toolbox.js:2511:24
11:59:51 INFO - asynchighlightFrame@resource://devtools/client/framework/components/ToolboxToolbar.js:282:13
11:59:51 INFO - notifyHighlightedChildChange@resource://devtools/client/shared/components/menu/MenuList.js:61:18
11:59:51 INFO - onMouseOverOrFocus@resource://devtools/client/shared/components/menu/MenuList.js:49:10
11:59:51 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:77:10
11:59:51 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:107:27
11:59:51 INFO - invokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:121:43
11:59:51 INFO - executeDispatch@resource://devtools/client/shared/vendor/react-dom.js:399:19
11:59:51 INFO - executeDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:418:5
11:59:51 INFO - executeDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:516:5
11:59:51 INFO - executeDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:527:10
11:59:51 INFO - forEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:497:8
11:59:51 INFO - runEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:658:5
11:59:51 INFO - runExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:667:3
11:59:51 INFO - handleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4262:5
11:59:51 INFO - batchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13458:12
11:59:51 INFO - batchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:2022:12
11:59:51 INFO - dispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4341:5
11:59:51 INFO - interactiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13513:12
11:59:51 INFO - interactiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:2041:10
11:59:51 INFO - dispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4318:3
11:59:51 INFO - focus@resource://devtools/client/shared/widgets/tooltip/HTMLTooltip.js:878:24
11:59:51 INFO - onClick@resource://devtools/client/shared/components/menu/MenuButton.js:303:24
11:59:51 INFO - Async
invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:77:10
11:59:51 INFO - invokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:107:27
11:59:51 INFO - invokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:121:43
11:59:51 INFO - executeDispatch@resource://devtools/client/shared/vendor/react-dom.js:399:19
11:59:51 INFO - executeDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:418:5
11:59:51 INFO - executeDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:516:5
11:59:51 INFO - executeDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:527:10
11:59:51 INFO - forEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:497:8
11:59:51 INFO - runEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:658:5
11:59:51 INFO - runExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:667:3
11:59:51 INFO - handleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4262:5
11:59:51 INFO - batchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13458:12
11:59:51 INFO - batchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:2022:12
11:59:51 INFO - dispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4341:5
11:59:51 INFO - interactiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:13513:12
11:59:51 INFO - interactiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:2041:10
11:59:51 INFO - dispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4318:3
11:59:51 INFO - toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:200:11
11:59:51 INFO - asynctoolboxTestScript@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:171:6
11:59:51 INFO - testWebExtensionsToolboxWebConsole@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:123:3
11:59:51 INFO - Async
Tester_execTest/<@chrome://mochikit/content/browser-test.js:1116:34
11:59:51 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1144:12
11:59:51 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1005:14
11:59:51 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:803:59
11:59:51 INFO - - stack: destroy@resource://devtools/shared/protocol.js:1299:23
11:59:51 INFO - destroy@resource://devtools/shared/protocol.js:946:17
11:59:51 INFO - destroy@resource://devtools/shared/protocol.js:1301:11
11:59:51 INFO - destroy@resource://devtools/shared/fronts/inspector.js:486:11
11:59:51 INFO - destroyInspector/this._destroyingInspector<@resource://devtools/client/framework/toolbox.js:2918:29
11:59:51 INFO - AsyncdestroyInspector@resource://devtools/client/framework/toolbox.js:2924:18
11:59:51 INFO - _destroyToolbox@resource://devtools/client/framework/toolbox.js:3032:27
11:59:51 INFO - destroy@resource://devtools/client/framework/toolbox.js:2962:28
11:59:51 INFO - _endRemoveTab@chrome://browser/content/tabbrowser.js:3142:13
11:59:51 INFO - removeTab@chrome://browser/content/tabbrowser.js:2840:12
11:59:51 INFO - removeTab@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:192:12
11:59:51 INFO - toolboxTestScript/<@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:226:13
11:59:51 INFO - async
toolboxTestScript@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:171:6
11:59:51 INFO - testWebExtensionsToolboxWebConsole@chrome://mochitests/content/browser/devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_addons_debug_popup.js:123:3
11:59:51 INFO - Async*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1116:34
11:59:51 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1144:12
11:59:51 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1005:14
11:59:51 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:803:59
11:59:51 INFO - Rejection date: Sat Apr 20 2019 11:59:26 GMT+0000 (Greenwich Mean Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 257

It appears that this test is no longer perma failing. Most recent run: https://treeherder.mozilla.org/#/jobs?repo=mozilla-central&searchStr=windows%2C10%2Cx64%2Cccov%2Cdebug%2Cmochitests%2Cwith%2Ce10s%2Ctest-windows10-64-ccov%2Fdebug-mochitest-devtools-chrome-e10s-5%2Cm-e10s%28dt5%29&revision=b8f49a14c458f56a6a08e4c177671108e386be3a&selectedJob=240502198

Julian, could you please assign this to someone?

Flags: needinfo?(jdescottes)
Whiteboard: [stockwell needswork:owner]
Assignee: nobody → jdescottes
Status: NEW → ASSIGNED
Flags: needinfo?(jdescottes)

I suspect an inspector request doesn't have time to finish and triggers the intermittent. Not sure how to trigger win debug ccov jobs to verify though.

Pushed by jdescottes@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/eaed19c250e9
Wait for debugger-client requests to settle in browser_aboutdebugging_addons_debug_popup.js r=daisuke
Status: ASSIGNED → RESOLVED
Closed: 1 year ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 68
You need to log in before you can comment on or make changes to this bug.