Closed Bug 1599694 Opened 5 years ago Closed 4 years ago

Intermittent devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js | Test timed out -

Categories

(DevTools :: Console, defect, P5)

defect

Tracking

(firefox72 fixed)

RESOLVED FIXED
Firefox 72
Tracking Status
firefox72 --- fixed

People

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

Details

(Keywords: intermittent-failure)

Attachments

(1 file)

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


[task 2019-11-27T07:02:15.610Z] 07:02:15 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js | Object inspector key is sorted as expected (10) -
[task 2019-11-27T07:02:15.610Z] 07:02:15 INFO - Testing command: [new Int32Array(new ArrayBuffer(80))]
[task 2019-11-27T07:02:15.610Z] 07:02:15 INFO - Wait for a new .result message with an object inspector to be displayed
[task 2019-11-27T07:02:15.610Z] 07:02:15 INFO - Buffered messages logged at 07:00:18
[task 2019-11-27T07:02:15.611Z] 07:02:15 INFO - Expand object inspector
[task 2019-11-27T07:02:15.611Z] 07:02:15 INFO - Buffered messages finished
[task 2019-11-27T07:02:15.612Z] 07:02:15 INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js | Test timed out -
[task 2019-11-27T07:02:15.779Z] 07:02:15 INFO - GECKO(1897) | shouldLoadURI: about:blank
[task 2019-11-27T07:02:15.977Z] 07:02:15 INFO - GECKO(1897) | console.error: "Error in enumIndexedProperties" (new Error("Connection closed, pending request to server0.conn237.child1/obj83, type enumProperties failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:214:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\nenumProperties@resource://devtools/shared/fronts/object.js:104:18\nenumIndexedProperties@resource://devtools/client/shared/components/reps/reps.js:4101:40\nloadItemProperties@resource://devtools/client/shared/components/reps/reps.js:3975:19\n485/nodeLoadProperties/<@resource://devtools/client/shared/components/reps/reps.js:7977:32\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\ndispatch@resource://devtools/client/shared/vendor/redux.js:755:18\n485/nodeExpand/<@resource://devtools/client/shared/components/reps/reps.js:7944:13\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\nbindActionCreator/<@resource://devtools/client/shared/vendor/redux.js:644:12\nsetExpanded@resource://devtools/client/shared/components/reps/reps.js:7774:17\nonExpand@resource://devtools/client/shared/components/reps/reps.js:7854:30\nonClick@resource://devtools/client/shared/components/reps/reps.js:1175:24\ninvokeGuardedCallbackImpl@resource://devtools/client/shared/vendor/react-dom.js:74:10\ninvokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:111:29\ninvokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:125:25\nexecuteDispatch@resource://devtools/client/shared/vendor/react-dom.js:346:42\nexecuteDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:362:22\nexecuteDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:462:29\nexecuteDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:470:10\nforEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:444:8\nrunEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:598:21\nrunExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:606:19\nhandleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4272:30\nbatchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15752:12\nbatchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:1882:12\ndispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4351:19\ninteractiveUpdates$1/<@resource://devtools/client/shared/vendor/react-dom.js:15803:14\nunstable_runWithPriority@resource://devtools/client/shared/vendor/react.js:617:12\ninteractiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15802:12\ninteractiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:1901:10\ndispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4328:21\ntestKeyOrder@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:129:30\nasync*@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:93:11\nAsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1069:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1104:11\nnextTest/<@chrome://mochikit/content/browser-test.js:932:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67\n", "resource://devtools/shared/protocol/Front.js", 68))
[task 2019-11-27T07:02:15.982Z] 07:02:15 INFO - GECKO(1897) | console.error: "Error in enumNonIndexedProperties" (new Error("Connection closed, pending request to server0.conn237.child1/obj83, type enumProperties failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:214:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\nenumProperties@resource://devtools/shared/fronts/object.js:104:18\nenumNonIndexedProperties@resource://devtools/client/shared/components/reps/reps.js:4114:40\nloadItemProperties@resource://devtools/client/shared/components/reps/reps.js:3979:19\n485/nodeLoadProperties/<@resource://devtools/client/shared/components/reps/reps.js:7977:32\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\ndispatch@resource://devtools/client/shared/vendor/redux.js:755:18\n485/nodeExpand/<@resource://devtools/client/shared/components/reps/reps.js:7944:13\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\nbindActionCreator/<@resource://devtools/client/shared/vendor/redux.js:644:12\nsetExpanded@resource://devtools/client/shared/components/reps/reps.js:7774:17\nonExpand@resource://devtools/client/shared/components/reps/reps.js:7854:30\nonClick@resource://devtools/client/shared/components/reps/reps.js:1175:24\ninvokeGuardedCallbackImpl@resource://devtools/client/shared/vendor/react-dom.js:74:10\ninvokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:111:29\ninvokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:125:25\nexecuteDispatch@resource://devtools/client/shared/vendor/react-dom.js:346:42\nexecuteDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:362:22\nexecuteDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:462:29\nexecuteDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:470:10\nforEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:444:8\nrunEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:598:21\nrunExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:606:19\nhandleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4272:30\nbatchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15752:12\nbatchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:1882:12\ndispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4351:19\ninteractiveUpdates$1/<@resource://devtools/client/shared/vendor/react-dom.js:15803:14\nunstable_runWithPriority@resource://devtools/client/shared/vendor/react.js:617:12\ninteractiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15802:12\ninteractiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:1901:10\ndispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4328:21\ntestKeyOrder@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:129:30\nasync
@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:93:11\nAsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1069:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1104:11\nnextTest/<@chrome://mochikit/content/browser-test.js:932:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67\n", "resource://devtools/shared/protocol/Front.js", 68))
[task 2019-11-27T07:02:15.982Z] 07:02:15 INFO - GECKO(1897) | console.error: "Error in enumSymbols" (new Error("Connection closed, pending request to server0.conn237.child1/obj83, type enumSymbols failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:214:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\nenumSymbols@resource://devtools/shared/fronts/object.js:133:18\nenumSymbols@resource://devtools/client/shared/components/reps/reps.js:4138:40\nloadItemProperties@resource://devtools/client/shared/components/reps/reps.js:3991:19\n485/nodeLoadProperties/<@resource://devtools/client/shared/components/reps/reps.js:7977:32\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\ndispatch@resource://devtools/client/shared/vendor/redux.js:755:18\n485/nodeExpand/<@resource://devtools/client/shared/components/reps/reps.js:7944:13\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\nbindActionCreator/<@resource://devtools/client/shared/vendor/redux.js:644:12\nsetExpanded@resource://devtools/client/shared/components/reps/reps.js:7774:17\nonExpand@resource://devtools/client/shared/components/reps/reps.js:7854:30\nonClick@resource://devtools/client/shared/components/reps/reps.js:1175:24\ninvokeGuardedCallbackImpl@resource://devtools/client/shared/vendor/react-dom.js:74:10\ninvokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:111:29\ninvokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:125:25\nexecuteDispatch@resource://devtools/client/shared/vendor/react-dom.js:346:42\nexecuteDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:362:22\nexecuteDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:462:29\nexecuteDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:470:10\nforEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:444:8\nrunEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:598:21\nrunExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:606:19\nhandleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4272:30\nbatchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15752:12\nbatchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:1882:12\ndispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4351:19\ninteractiveUpdates$1/<@resource://devtools/client/shared/vendor/react-dom.js:15803:14\nunstable_runWithPriority@resource://devtools/client/shared/vendor/react.js:617:12\ninteractiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15802:12\ninteractiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:1901:10\ndispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4328:21\ntestKeyOrder@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:129:30\nasync
@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:93:11\nAsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1069:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1104:11\nnextTest/<@chrome://mochikit/content/browser-test.js:932:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67\n", "resource://devtools/shared/protocol/Front.js", 68))
[task 2019-11-27T07:02:17.898Z] 07:02:17 INFO - GECKO(1897) | console.error: (new Error("Connection closed, pending request to server0.conn237.child1/obj83, type prototype failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:214:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\ngetPrototype@resource://devtools/shared/fronts/object.js:159:18\ngetPrototype@resource://devtools/client/shared/components/reps/reps.js:4153:22\nloadItemProperties@resource://devtools/client/shared/components/reps/reps.js:3987:19\n485/nodeLoadProperties/<@resource://devtools/client/shared/components/reps/reps.js:7977:32\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\ndispatch@resource://devtools/client/shared/vendor/redux.js:755:18\n485/nodeExpand/<@resource://devtools/client/shared/components/reps/reps.js:7944:13\nthunkWithOptions/</<@resource://devtools/client/shared/redux/middleware/thunk-with-options.js:16:9\nbindActionCreator/<@resource://devtools/client/shared/vendor/redux.js:644:12\nsetExpanded@resource://devtools/client/shared/components/reps/reps.js:7774:17\nonExpand@resource://devtools/client/shared/components/reps/reps.js:7854:30\nonClick@resource://devtools/client/shared/components/reps/reps.js:1175:24\ninvokeGuardedCallbackImpl@resource://devtools/client/shared/vendor/react-dom.js:74:10\ninvokeGuardedCallback@resource://devtools/client/shared/vendor/react-dom.js:111:29\ninvokeGuardedCallbackAndCatchFirstError@resource://devtools/client/shared/vendor/react-dom.js:125:25\nexecuteDispatch@resource://devtools/client/shared/vendor/react-dom.js:346:42\nexecuteDispatchesInOrder@resource://devtools/client/shared/vendor/react-dom.js:362:22\nexecuteDispatchesAndRelease@resource://devtools/client/shared/vendor/react-dom.js:462:29\nexecuteDispatchesAndReleaseTopLevel@resource://devtools/client/shared/vendor/react-dom.js:470:10\nforEachAccumulated@resource://devtools/client/shared/vendor/react-dom.js:444:8\nrunEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:598:21\nrunExtractedEventsInBatch@resource://devtools/client/shared/vendor/react-dom.js:606:19\nhandleTopLevel@resource://devtools/client/shared/vendor/react-dom.js:4272:30\nbatchedUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15752:12\nbatchedUpdates@resource://devtools/client/shared/vendor/react-dom.js:1882:12\ndispatchEvent@resource://devtools/client/shared/vendor/react-dom.js:4351:19\ninteractiveUpdates$1/<@resource://devtools/client/shared/vendor/react-dom.js:15803:14\nunstable_runWithPriority@resource://devtools/client/shared/vendor/react.js:617:12\ninteractiveUpdates$1@resource://devtools/client/shared/vendor/react-dom.js:15802:12\ninteractiveUpdates@resource://devtools/client/shared/vendor/react-dom.js:1901:10\ndispatchInteractiveEvent@resource://devtools/client/shared/vendor/react-dom.js:4328:21\ntestKeyOrder@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:129:30\nasync
@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js:93:11\nAsync*Tester_execTest/<@chrome://mochikit/content/browser-test.js:1069:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1104:11\nnextTest/<@chrome://mochikit/content/browser-test.js:932:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67\n", "resource://devtools/shared/protocol/Front.js", 68))
[task 2019-11-27T07:02:17.905Z] 07:02:17 INFO - Removing tab.
[task 2019-11-27T07:02:17.906Z] 07:02:17 INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-11-27T07:02:18.144Z] 07:02:18 INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-11-27T07:02:18.342Z] 07:02:18 INFO - Tab removed and finished closing
[task 2019-11-27T07:02:18.944Z] 07:02:18 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js | The main process DebuggerServer has no pending connection when the test ends -
[task 2019-11-27T07:02:18.978Z] 07:02:18 INFO - GECKO(1897) | MEMORY STAT | vsize 20977790MB | residentFast 3655MB
[task 2019-11-27T07:02:18.978Z] 07:02:18 INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_object_inspector_key_sorting.js | took 181207ms
[task 2019-11-27T07:02:19.066Z] 07:02:19 INFO - GECKO(1897) | about:blank
[task 2019-11-27T07:02:19.208Z] 07:02:19 INFO - GECKO(1897) | about:blank
[task 2019-11-27T07:02:19.422Z] 07:02:19 INFO - GECKO(1897) | about:blank
[task 2019-11-27T07:02:19.454Z] 07:02:19 INFO - GECKO(1897) | about:blank
[task 2019-11-27T07:02:19.475Z] 07:02:19 INFO - checking window state

The test is sometimes failing because there's a pending
connection to the server while the connection is closed.
My guess is that somehow the test could have been checking
other nodes instead of the current evaluated on to wait
for a node to be fully expanded.
The fix made here is to make sure that we only have one
node displayed when testing the object inspector.

Assignee: nobody → nchevobbe
Pushed by nchevobbe@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/cbbdca95f0ec
Fix browser_webconsole_object_inspector_key_sorting intermittent. r=Honza.
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → Firefox 72
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: