Closed Bug 1579636 Opened 6 years ago Closed 5 years ago

Intermittent devtools/client/webconsole/test/browser/browser_webconsole_sandbox_update_after_navigation.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but

Categories

(DevTools :: Console, defect, P5)

Product:
DevTools
Component:
Console
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression)

Filed by: rgurzau [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=265504710&repo=mozilla-inbound
Full log: https://queue.taskcluster.net/v1/task/KdR7cjXTTeOxw8SnkBStew/runs/0/artifacts/public/logs/live_backing.log

[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Matched a message with text: "http://example.org/browser/devtools/client/webconsole/test/browser/test-console.html", all messages received.
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:57:22
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_sandbox_update_after_navigation.js | no permission denied errors -
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Waiting for messages-cleared event due to navigation
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:57:26
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Messages cleared after navigation; checking location
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:57:32
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Matched a message with text: "http://example.com/browser/devtools/client/webconsole/test/browser/test-console.html", all messages received.
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_sandbox_update_after_navigation.js | no permission denied errors -
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Leaving test bound
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:59:32
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Removing tab.
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:59:33
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Tab removed and finished closing
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages logged at 10:59:35
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 112}]
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - Buffered messages finished
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_sandbox_update_after_navigation.js | This test exceeded the timeout threshold. It should be rewritten or split up. If that's not possible, use requestLongerTimeout(N), but only as a last resort. -
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - GECKO(2894) | MEMORY STAT | vsize 20977779MB | residentFast 3721MB
[task 2019-09-07T10:59:35.919Z] 10:59:35 INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_sandbox_update_after_navigation.js | took 508381ms
[task 2019-09-07T10:59:36.956Z] 10:59:36 INFO - checking window state
[task 2019-09-07T10:59:37.828Z] 10:59:37 INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_script_errordoc_urls.js
[task 2019-09-07T10:59:58.011Z] 10:59:57 INFO - GECKO(2894) | JavaScript error: data:text/html;charset=utf8,<script>'use strict'; (Object.freeze({name: 'Elsa', score: 157})).score = 0;</script>, line 1: TypeError: "score" is read-only
[task 2019-09-07T11:00:04.271Z] 11:00:04 INFO - GECKO(2894) | JavaScript warning: data:text/html;charset=utf8,<script>function a() { return; 1 + 1; };</script>, line 1: unreachable code after return statement
[task 2019-09-07T11:00:09.472Z] 11:00:09 INFO - GECKO(2894) | console.log: "getSources failed. Connection may have closed: Error: Connection closed, pending request to server0.conn253.child1/thread20, type sources failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:176:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\ngetSources@resource://devtools/shared/fronts/thread.js:205:34\nSourceMapURLService.prototype._getLoadingPromise/this._loadingPromise<@resource://devtools/client/framework/source-map-url-service.js:77:56\nasyncSourceMapURLService.prototype._getLoadingPromise@resource://devtools/client/framework/source-map-url-service.js:94:7\nSourceMapURLService.prototype.originalPositionFor@resource://devtools/client/framework/source-map-url-service.js:266:14\nSourceMapURLService.prototype._callOneCallback@resource://devtools/client/framework/source-map-url-service.js:315:38\nSourceMapURLService.prototype.subscribe@resource://devtools/client/framework/source-map-url-service.js:378:10\ncomponentWillMount@resource://devtools/client/shared/components/Frame.js:79:70\ncallComponentWillMount@resource://devtools/client/shared/vendor/react-dom.js:8286:14\nmountClassInstance@resource://devtools/client/shared/vendor/react-dom.js:8345:27\nupdateClassComponent@resource://devtools/client/shared/vendor/react-dom.js:10593:23\nbeginWork@resource://devtools/client/shared/vendor/react-dom.js:11419:16\nperformUnitOfWork@resource://devtools/client/shared/vendor/react-dom.js:14702:12\nworkLoop@resource://devtools/client/shared/vendor/react-dom.js:14720:24\nrenderRoot@resource://devtools/client/shared/vendor/react-dom.js:14803:15\nperformWorkOnRoot@resource://devtools/client/shared/vendor/react-dom.js:15655:17\nperformWork@resource://devtools/client/shared/vendor/react-dom.js:15567:24\nperformSyncWork@resource://devtools/client/shared/vendor/react-dom.js:15541:14\nrequestWork@resource://devtools/client/shared/vendor/react-dom.js:15410:5\nscheduleWork@resource://devtools/client/shared/vendor/react-dom.js:15224:16\nenqueueSetState@resource://devtools/client/shared/vendor/react-dom.js:8192:17\nComponent.prototype.setState@resource://devtools/client/shared/vendor/react.js:328:16\nonStateChange@resource://devtools/client/shared/vendor/react-redux.js:1412:16\nnotify@resource://devtools/client/shared/vendor/react-redux.js:1159:21\nnotifyNestedSubs@resource://devtools/client/shared/vendor/react-redux.js:1198:20\nonStateChange@resource://devtools/client/shared/vendor/react-redux.js:1409:16\ndispatch@resource://devtools/client/shared/vendor/redux.js:416:7\neventTelemetryMiddleware/</<@resource://devtools/client/webconsole/middleware/event-telemetry.js:22:21\nhistoryPersistenceMiddleware/</<@resource://devtools/client/webconsole/middleware/history-persistence.js:37:21\nthunk/</<@resource://devtools/client/webconsole/middleware/thunk.js:14:9\nsetTimeoutIfNeeded/this.throttledDispatchPromise</<@resource://devtools/client/webconsole/webconsole-wrapper.js:703:15\nsetTimeout handlersetTimeoutIfNeeded/this.throttledDispatchPromise<@resource://devtools/client/webconsole/webconsole-wrapper.js:693:17\nsetTimeoutIfNeeded@resource://devtools/client/webconsole/webconsole-wrapper.js:692:37\nbatchedMessageAdd@resource://devtools/client/webconsole/webconsole-wrapper.js:654:10\ndispatchMessageAdd@resource://devtools/client/webconsole/webconsole-wrapper.js:506:10\ndispatchMessageAdd@resource://devtools/client/webconsole/webconsole-connection-proxy.js:336:31\n_onPageError@resource://devtools/client/webconsole/webconsole-connection-proxy.js:221:10\nemit@resource://devtools/shared/event-emitter.js:190:24\nemit@resource://devtools/shared/event-emitter.js:271:18\nonPacket@resource://devtools/shared/protocol/Front.js:214:13\nonPacket@resource://devtools/shared/client/debugger-client.js:592:13\nsend/<@resource://devtools/shared/transport/local-transport.js:70:25\nexports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22\nDevToolsUtils.executeSoonexports.executeSoon@resource://devtools/shared/DevToolsUtils.js:62:21\nsend@resource://devtools/shared/transport/local-transport.js:58:21\nsend@resource://devtools/server/debugger-server-connection.js:89:20\nreceiveMessage@resource://devtools/shared/transport/child-transport.js:66:16\nMessageListener.receiveMessage_addListener@resource://devtools/shared/transport/child-transport.js:40:14\nready@resource://devtools/shared/transport/child-transport.js:57:10\nconnectToFrame/</onActorCreated<@resource://devtools/server/connectors/frame-connector.js:183:22\nexports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22\nMessageListener.receiveMessagetrackMessageManager@resource://devtools/server/connectors/frame-connector.js:55:12\nconnectToFrame/<@resource://devtools/server/connectors/frame-connector.js:283:5\nconnectToFrame@resource://devtools/server/connectors/frame-connector.js:41:10\nconnect@resource://devtools/server/actors/targets/frame-proxy.js:65:35\nasyncBrowserTabList.prototype._getActorForBrowser@resource://devtools/server/actors/webbrowser.js:368:16\nBrowserTabList.prototype.getTab@resource://devtools/server/actors/webbrowser.js:410:21\nonGetTab@resource://devtools/server/actors/root.js:364:35\nonPacket@resource://devtools/server/debugger-server-connection.js:378:58\nsend/<@resource://devtools/shared/transport/local-transport.js:70:25\nexports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22\nDevToolsUtils.executeSoonexports.executeSoon@resource://devtools/shared/DevToolsUtils.js:62:21\nsend@resource://devtools/shared/transport/local-transport.js:58:21\nsend@resource://devtools/shared/protocol/Front.js:160:30\nrequest@resource://devtools/shared/protocol/Front.js:178:10\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\ngetTab@resource://devtools/shared/fronts/root.js:329:30\ncreateTargetForTab@resource://devtools/client/framework/target.js:94:28\nasyncforTab@resource://devtools/client/framework/target.js:40:26\nopenToolboxForTab@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:455:38\nopenNewTabAndToolbox@chrome://mochitests/content/browser/devtools/client/shared/test/shared-head.js:487:10\nasync*openNewTabAndConsole@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/head.js:82:25\n@chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_script_errordoc_urls.js:33:21\nTester_execTest/<@chrome://mochikit/content/browser-test.js:1350:34\nTester_execTest@chrome://mochikit/content/browser-test.js:1385:11\nnextTest/<@chrome://mochikit/content/browser-test.js:1213:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67\n"
[task 2019-09-07T11:00:12.377Z] 11:00:12 INFO - GECKO(2894) | JavaScript error: resource://testing-common/PromiseTestUtils.jsm, line 112: uncaught exception: Object
[task 2019-09-07T11:00:12.377Z] 11:00:12 INFO - GECKO(2894) | MEMORY STAT | vsize 20977756MB | residentFast 3713MB
[task 2019-09-07T11:00:12.377Z] 11:00:12 INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_script_errordoc_urls.js | took 34591ms

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

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE

New occurrence: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=272571666&repo=autoland&lineNumber=5284

Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---

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

Status: REOPENED → RESOLVED
Closed: 6 years ago → 5 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.