Closed Bug 1565823 Opened 6 years ago Closed 6 years ago

Intermittent browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | A promise chain failed to handle a rejection: No such actor for ID: server1.conn0.child24/netEvent20

Categories

(WebExtensions :: Untriaged, defect, P5)

Product:
WebExtensions
Component:
Untriaged
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [test isolation])

Filed by: nerli [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=256352777&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/JfKWBQw_TnO-8ntM-u5D0Q/runs/0/artifacts/public/logs/live_backing.log

[task 2019-07-13T13:22:24.490Z] 13:22:24 INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js
[task 2019-07-13T13:22:26.109Z] 13:22:26 INFO - GECKO(4396) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
[task 2019-07-13T13:22:26.165Z] 13:22:26 INFO - GECKO(4396) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2019-07-13T13:22:26.316Z] 13:22:26 INFO - GECKO(4396) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2019-07-13T13:22:26.326Z] 13:22:26 INFO - GECKO(4396) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2019-07-13T13:22:27.664Z] 13:22:27 INFO - GECKO(4396) | JavaScript error: resource://devtools/server/actors/network-monitor/stack-trace-collector.js, line 90: NS_NOINTERFACE: Component returned failure code: 0x80004002 (NS_NOINTERFACE) [nsISupports.QueryInterface]
[task 2019-07-13T13:22:27.730Z] 13:22:27 INFO - GECKO(4396) | JavaScript error: , line 0: uncaught exception: Object
[task 2019-07-13T13:22:27.732Z] 13:22:27 INFO - GECKO(4396) | JavaScript error: resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js, line 615: Error: Error while calling method getEventTimings: No such actor for ID: server1.conn0.child24/netEvent20
[task 2019-07-13T13:22:28.847Z] 13:22:28 INFO - GECKO(4396) | console.warn: "Error while detaching the browsing context target front: undefined"
[task 2019-07-13T13:22:29.147Z] 13:22:29 INFO - TEST-INFO | started process screentopng
[task 2019-07-13T13:22:29.804Z] 13:22:29 INFO - TEST-INFO | screentopng: exit 0
[task 2019-07-13T13:22:29.807Z] 13:22:29 INFO - Buffered messages logged at 13:22:24
[task 2019-07-13T13:22:29.809Z] 13:22:29 INFO - Entering test bound test_addon_debugging_netmonitor_panel
[task 2019-07-13T13:22:29.810Z] 13:22:29 INFO - Extension loaded
[task 2019-07-13T13:22:29.812Z] 13:22:29 INFO - Console message: [JavaScript Error: "uncaught exception: Object" {file: "resource://testing-common/PromiseTestUtils.jsm" line: 112}]
[task 2019-07-13T13:22:29.815Z] 13:22:29 INFO - Buffered messages logged at 13:22:26
[task 2019-07-13T13:22:29.817Z] 13:22:29 INFO - Console message: Webconsole context has changed
[task 2019-07-13T13:22:29.818Z] 13:22:29 INFO - Buffered messages logged at 13:22:27
[task 2019-07-13T13:22:29.821Z] 13:22:29 INFO - Console message: [JavaScript Warning: "Relative positioning of table rows and row groups is now supported. This site may need to be updated because it may depend on this feature having no effect." {file: "resource://devtools/client/netmonitor/src/components/RequestListHeader.js" line: 440}]
[task 2019-07-13T13:22:29.823Z] 13:22:29 INFO - Console message: [JavaScript Error: "NS_NOINTERFACE: Component returned failure code: 0x80004002 (NS_NOINTERFACE) [nsISupports.QueryInterface]" {file: "resource://devtools/server/actors/network-monitor/stack-trace-collector.js" line: 90}]
[task 2019-07-13T13:22:29.825Z] 13:22:29 INFO - Console message: [JavaScript Error: "uncaught exception: Object"]
[task 2019-07-13T13:22:29.827Z] 13:22:29 INFO - Console message: [JavaScript Error: "Error: Error while calling method getEventTimings: No such actor for ID: server1.conn0.child24/netEvent20" {file: "resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js" line: 615}]
[task 2019-07-13T13:22:29.829Z] 13:22:29 INFO - Buffered messages logged at 13:22:28
[task 2019-07-13T13:22:29.831Z] 13:22:29 INFO - Addon Debugging Netmonitor panel collected requests: [{"id":"server1.conn0.child24/netEvent52","startedMillis":1563024147672,"method":"GET","url":"http://mochi.test:8888/?test_netmonitor=1","isXHR":true,"cause":{"type":"fetch","loadingDocumentUri":"moz-extension://db40b578-09e2-4cd6-b1ec-1f5c22a9599b/_generated_background_page.html","stacktraceAvailable":true},"isThirdPartyTrackingResource":false,"referrerPolicy":"no-referrer-when-downgrade","channelId":18880676233221,"urlDetails":{"baseNameWithQuery":"/?test_netmonitor=1","host":"mochi.test:8888","scheme":"http","unicodeUrl":"http://mochi.test:8888/?test_netmonitor=1","isLocal":null,"url":"http://mochi.test:8888/?test_netmonitor=1"},"requestHeadersAvailable":true,"requestCookiesAvailable":true,"httpVersion":"HTTP/1.1","remoteAddress":"127.0.0.1","remotePort":8888,"status":"200","statusText":"OK","headersSize":155,"securityState":"insecure","isRacing":false,"securityInfoAvailable":true,"responseHeadersAvailable":true,"responseCookiesAvailable":true,"totalTime":41,"eventTimingsAvailable":false,"contentSize":15481,"transferredSize":15636,"mimeType":"text/html; charset=utf-8","responseContentAvailable":true,"eventTimings":{"timings":{"blocked":0,"dns":0,"connect":0,"ssl":0,"send":0,"wait":36,"receive":5},"totalTime":41,"offsets":{"blocked":0,"dns":0,"connect":0,"ssl":0,"send":0,"wait":0,"receive":36},"from":"server1.conn0.child24/netEvent52"}}]
[task 2019-07-13T13:22:29.833Z] 13:22:29 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | Got one request logged - Expected: 1, Actual: 1 -
[task 2019-07-13T13:22:29.835Z] 13:22:29 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | Got a GET request - Expected: GET, Actual: GET -
[task 2019-07-13T13:22:29.837Z] 13:22:29 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | Got the expected request url - Expected: http://mochi.test:8888/?test_netmonitor=1, Actual: http://mochi.test:8888/?test_netmonitor=1 -
[task 2019-07-13T13:22:29.839Z] 13:22:29 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | netmonitor_request_logged -
[task 2019-07-13T13:22:29.841Z] 13:22:29 INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | test result correct -
[task 2019-07-13T13:22:29.843Z] 13:22:29 INFO - Buffered messages logged at 13:22:29
[task 2019-07-13T13:22:29.845Z] 13:22:29 INFO - Addon Toolbox closed
[task 2019-07-13T13:22:29.847Z] 13:22:29 INFO - Buffered messages finished
[task 2019-07-13T13:22:29.859Z] 13:22:29 INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_addon_debugging_netmonitor.js | A promise chain failed to handle a rejection: No such actor for ID: server1.conn0.child24/netEvent20 - stack: listenerJson@resource://devtools/shared/client/debugger-client.js:342:11
[task 2019-07-13T13:22:29.862Z] 13:22:29 INFO - emit@resource://devtools/shared/event-emitter.js:190:24
[task 2019-07-13T13:22:29.864Z] 13:22:29 INFO - emit@resource://devtools/shared/event-emitter.js:271:18
[task 2019-07-13T13:22:29.866Z] 13:22:29 INFO - emitReply@resource://devtools/shared/client/debugger-client.js:621:45
[task 2019-07-13T13:22:29.871Z] 13:22:29 INFO - DevTools RDP*request@resource://devtools/shared/client/debugger-client.js:333:21
[task 2019-07-13T13:22:29.873Z] 13:22:29 INFO - getEventTimings@resource://devtools/shared/fronts/webconsole.js:412:25
[task 2019-07-13T13:22:29.875Z] 13:22:29 INFO - _requestData/response<@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:610:48
[task 2019-07-13T13:22:29.878Z] 13:22:29 INFO - _requestData@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:605:26
[task 2019-07-13T13:22:29.880Z] 13:22:29 INFO - requestData@resource://devtools/client/netmonitor/src/connector/firefox-data-provider.js:549:20
[task 2019-07-13T13:22:29.882Z] 13:22:29 INFO - requestData@resource://devtools/client/netmonitor/src/connector/firefox-connector.js:445:30
[task 2019-07-13T13:22:29.884Z] 13:22:29 INFO - requestData@resource://devtools/client/netmonitor/src/connector/index.js:120:27
[task 2019-07-13T13:22:29.886Z] 13:22:29 INFO - fetchNetworkUpdatePacket/<@resource://devtools/client/netmonitor/src/utils/request-utils.js:102:7
[task 2019-07-13T13:22:29.889Z] 13:22:29 INFO - fetchNetworkUpdatePacket@resource://devtools/client/netmonitor/src/utils/request-utils.js:92:15
[task 2019-07-13T13:22:29.891Z] 13:22:29 INFO - componentDidMount@resource://devtools/client/netmonitor/src/components/RequestListColumnWaterfall.js:41:5
[task 2019-07-13T13:22:29.893Z] 13:22:29 INFO - commitLifeCycles@resource://devtools/client/shared/vendor/react-dom.js:11391:22
[task 2019-07-13T13:22:29.895Z] 13:22:29 INFO - commitAllLifeCycles@resource://devtools/client/shared/vendor/react-dom.js:12348:7
[task 2019-07-13T13:22:29.897Z] 13:22:29 INFO - commitRoot@resource://devtools/client/shared/vendor/react-dom.js:12492:9
[task 2019-07-13T13:22:29.899Z] 13:22:29 INFO - completeRoot@resource://devtools/client/shared/vendor/react-dom.js:13417:34
[task 2019-07-13T13:22:29.902Z] 13:22:29 INFO - performWorkOnRoot@resource://devtools/client/shared/vendor/react-dom.js:13362:9
[task 2019-07-13T13:22:29.904Z] 13:22:29 INFO - performWork@resource://devtools/client/shared/vendor/react-dom.js:13281:7
[task 2019-07-13T13:22:29.906Z] 13:22:29 INFO - performSyncWork@resource://devtools/client/shared/vendor/react-dom.js:13253:3
[task 2019-07-13T13:22:29.908Z] 13:22:29 INFO - requestWork@resource://devtools/client/shared/vendor/react-dom.js:13153:5
[task 2019-07-13T13:22:29.911Z] 13:22:29 INFO - scheduleWork$1@resource://devtools/client/shared/vendor/react-dom.js:13022:11
[task 2019-07-13T13:22:29.913Z] 13:22:29 INFO - enqueueSetState@resource://devtools/client/shared/vendor/react-dom.js:8845:5
[task 2019-07-13T13:22:29.915Z] 13:22:29 INFO - Component.prototype.setState@resource://devtools/client/shared/vendor/react.js:406:16
[task 2019-07-13T13:22:29.917Z] 13:22:29 INFO - onStateChange@resource://devtools/client/shared/vendor/react-redux.js:1412:16
[task 2019-07-13T13:22:29.919Z] 13:22:29 INFO - notify@resource://devtools/client/shared/vendor/react-redux.js:1159:21
[task 2019-07-13T13:22:29.921Z] 13:22:29 INFO - notifyNestedSubs@resource://devtools/client/shared/vendor/react-redux.js:1198:20
[task 2019-07-13T13:22:29.924Z] 13:22:29 INFO - onStateChange@resource://devtools/client/shared/vendor/react-redux.js:1409:16
[task 2019-07-13T13:22:29.926Z] 13:22:29 INFO - dispatch@resource://devtools/client/shared/vendor/redux.js:416:7
[task 2019-07-13T13:22:29.928Z] 13:22:29 INFO - eventTelemetryMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/event-telemetry.js:30:17
[task 2019-07-13T13:22:29.930Z] 13:22:29 INFO - throttlingMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/throttling.js:18:17
[task 2019-07-13T13:22:29.933Z] 13:22:29 INFO - recordingMiddleware/</</<@resource://devtools/client/netmonitor/src/middleware/recording.js:20:17
[task 2019-07-13T13:22:29.935Z] 13:22:29 INFO - flushActions@resource://devtools/client/netmonitor/src/middleware/batching.js:88:7
[task 2019-07-13T13:22:29.937Z] 13:22:29 INFO - DelayedTask/this._promise</this.runTask@resource://devtools/client/netmonitor/src/middleware/batching.js:107:9
[task 2019-07-13T13:22:29.942Z] 13:22:29 INFO - notify@resource://gre/modules/Timer.jsm:62:17
[task 2019-07-13T13:22:29.943Z] 13:22:29 INFO - Rejection date: Sat Jul 13 2019 13:22:27 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 263
[task 2019-07-13T13:22:29.943Z] 13:22:29 INFO - Stack trace:
[task 2019-07-13T13:22:29.943Z] 13:22:29 INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:263
[task 2019-07-13T13:22:29.943Z] 13:22:29 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1377
[task 2019-07-13T13:22:29.944Z] 13:22:29 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1381
[task 2019-07-13T13:22:29.944Z] 13:22:29 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1209
[task 2019-07-13T13:22:29.944Z] 13:22:29 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
[task 2019-07-13T13:22:29.944Z] 13:22:29 INFO - Not taking screenshot here: see the one that was previously logged

Whiteboard: [test isolation]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

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