1513739 - Intermittent devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_sidebar_usb_runtime_connect.js | A promise chain failed to handle a rejection: Connection closed, pending error from root, type getProcess failed - stack: _queueResponse/

Status: RESOLVED INCOMPLETE

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

Description

[Treeherder Bug Filer]

Filed by: aiakab [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=216684237&repo=autoland

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

22:30:56     INFO - TEST-START | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_sidebar_usb_runtime_connect.js
[task 2018-12-12T22:30:56.754Z] 22:30:56     INFO - GECKO(1085) | JavaScript error: resource://devtools/server/main.js, line 1192: Error: Connection closed, pending error from root, type getProcess failed
[task 2018-12-12T22:30:56.994Z] 22:30:56     INFO - GECKO(1085) | console.log: MOCKED METHOD addUSBRuntimesObserver with mock scanner
[task 2018-12-12T22:30:57.118Z] 22:30:57     INFO - GECKO(1085) | console.log: MOCKED METHOD removeUSBRuntimesObserver
[task 2018-12-12T22:30:57.134Z] 22:30:57     INFO - TEST-INFO | started process screentopng
[task 2018-12-12T22:30:57.842Z] 22:30:57     INFO - TEST-INFO | screentopng: exit 0
[task 2018-12-12T22:30:57.844Z] 22:30:57     INFO - Buffered messages logged at 22:30:56
[task 2018-12-12T22:30:57.846Z] 22:30:57     INFO - Entering test bound 
[task 2018-12-12T22:30:57.847Z] 22:30:57     INFO - Console message: [JavaScript Error: "Error: Connection closed, pending error from root, type getProcess failed" {file: "resource://devtools/server/main.js" line: 1192}]
[task 2018-12-12T22:30:57.848Z] 22:30:57     INFO - opening about:debugging
[task 2018-12-12T22:30:57.849Z] 22:30:57     INFO - Adding a new tab with URL: about:debugging
[task 2018-12-12T22:30:57.850Z] 22:30:57     INFO - Tab added and finished loading
[task 2018-12-12T22:30:57.852Z] 22:30:57     INFO - wait for the initial about:debugging requests to be successful
[task 2018-12-12T22:30:57.856Z] 22:30:57     INFO - Buffered messages logged at 22:30:57
[task 2018-12-12T22:30:57.865Z] 22:30:57     INFO - Wait until the USB sidebar item appears
[task 2018-12-12T22:30:57.868Z] 22:30:57     INFO - TEST-PASS | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_sidebar_usb_runtime_connect.js | Connect button is displayed for the USB runtime - 
[task 2018-12-12T22:30:57.870Z] 22:30:57     INFO - Click on the connect button and wait until it disappears
[task 2018-12-12T22:30:57.872Z] 22:30:57     INFO - Remove all USB runtimes
[task 2018-12-12T22:30:57.878Z] 22:30:57     INFO - Wait until the USB sidebar item disappears
[task 2018-12-12T22:30:57.880Z] 22:30:57     INFO - Removing tab.
[task 2018-12-12T22:30:57.886Z] 22:30:57     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2018-12-12T22:30:57.889Z] 22:30:57     INFO - Got event: 'TabClose' on [object XULElement].
[task 2018-12-12T22:30:57.891Z] 22:30:57     INFO - Tab removed and finished closing
[task 2018-12-12T22:30:57.895Z] 22:30:57     INFO - Buffered messages finished
[task 2018-12-12T22:30:57.898Z] 22:30:57     INFO - TEST-UNEXPECTED-FAIL | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_sidebar_usb_runtime_connect.js | A promise chain failed to handle a rejection: Connection closed, pending error from root, type getProcess failed - stack: _queueResponse/responsePromise<@resource://devtools/server/main.js:1192:15
[task 2018-12-12T22:30:57.900Z] 22:30:57     INFO - promise callback*_queueResponse@resource://devtools/server/main.js:1190:8
[task 2018-12-12T22:30:57.902Z] 22:30:57     INFO - onPacket@resource://devtools/server/main.js:1340:7
[task 2018-12-12T22:30:57.903Z] 22:30:57     INFO - send/<@resource://devtools/shared/transport/local-transport.js:64:11
[task 2018-12-12T22:30:57.905Z] 22:30:57     INFO - exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:109:14
[task 2018-12-12T22:30:57.907Z] 22:30:57     INFO - DevToolsUtils.executeSoon*exports.executeSoon@resource://devtools/shared/DevToolsUtils.js:57:21
[task 2018-12-12T22:30:57.909Z] 22:30:57     INFO - send@resource://devtools/shared/transport/local-transport.js:58:7
[task 2018-12-12T22:30:57.912Z] 22:30:57     INFO - send@resource://devtools/shared/protocol.js:1390:9
[task 2018-12-12T22:30:57.914Z] 22:30:57     INFO - request@resource://devtools/shared/protocol.js:1408:5
[task 2018-12-12T22:30:57.915Z] 22:30:57     INFO - generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol.js:1530:14
[task 2018-12-12T22:30:57.917Z] 22:30:57     INFO - getProcess@resource://devtools/shared/fronts/root.js:150:28
[task 2018-12-12T22:30:57.919Z] 22:30:57     INFO - async*listAllWorkers@resource://devtools/shared/fronts/root.js:71:29
[task 2018-12-12T22:30:57.920Z] 22:30:57     INFO - async*listWorkers@resource://devtools/client/aboutdebugging-new/src/modules/client-wrapper.js:120:46
[task 2018-12-12T22:30:57.922Z] 22:30:57     INFO - async*requestWorkers/<@resource://devtools/client/aboutdebugging-new/src/actions/debug-targets.js:201:17
[task 2018-12-12T22:30:57.924Z] 22:30:57     INFO - async*thunk/</<@resource://devtools/client/shared/redux/middleware/thunk.js:15:9
[task 2018-12-12T22:30:57.925Z] 22:30:57     INFO - dispatch@resource://devtools/client/shared/vendor/redux.js:755:18
[task 2018-12-12T22:30:57.927Z] 22:30:57     INFO - onWorkersUpdated@resource://devtools/client/aboutdebugging-new/src/middleware/debug-target-listener.js:25:5
[task 2018-12-12T22:30:57.929Z] 22:30:57     INFO - emit@resource://devtools/shared/event-emitter.js:178:15
[task 2018-12-12T22:30:57.931Z] 22:30:57     INFO - onPacket@resource://devtools/shared/protocol.js:1444:7
[task 2018-12-12T22:30:57.932Z] 22:30:57     INFO - onPacket@resource://devtools/shared/client/debugger-client.js:778:7
[task 2018-12-12T22:30:57.933Z] 22:30:57     INFO - send/<@resource://devtools/shared/transport/local-transport.js:64:11
[task 2018-12-12T22:30:57.935Z] 22:30:57     INFO - exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:109:14
[task 2018-12-12T22:30:57.936Z] 22:30:57     INFO - DevToolsUtils.executeSoon*exports.executeSoon@resource://devtools/shared/DevToolsUtils.js:57:21
[task 2018-12-12T22:30:57.938Z] 22:30:57     INFO - send@resource://devtools/shared/transport/local-transport.js:58:7
[task 2018-12-12T22:30:57.939Z] 22:30:57     INFO - send@resource://devtools/server/main.js:1031:5
[task 2018-12-12T22:30:57.940Z] 22:30:57     INFO - onProcessListChanged@resource://devtools/server/actors/root.js:515:5
[task 2018-12-12T22:30:57.941Z] 22:30:57     INFO - _notifyListChanged@resource://devtools/server/actors/process.js:74:7
[task 2018-12-12T22:30:57.942Z] 22:30:57     INFO - _onMessage@resource://devtools/server/actors/process.js:83:5
[task 2018-12-12T22:30:57.942Z] 22:30:57     INFO - MessageListener.receiveMessage*_checkListening@resource://devtools/server/actors/process.js:64:7
[task 2018-12-12T22:30:57.943Z] 22:30:57     INFO - getList@resource://devtools/server/actors/process.js:37:5
[task 2018-12-12T22:30:57.944Z] 22:30:57     INFO - onListProcesses@resource://devtools/server/actors/root.js:510:18
[task 2018-12-12T22:30:57.944Z] 22:30:57     INFO - onPacket@resource://devtools/server/main.js:1324:15
[task 2018-12-12T22:30:57.945Z] 22:30:57     INFO - send/<@resource://devtools/shared/transport/local-transport.js:64:11
[task 2018-12-12T22:30:57.945Z] 22:30:57     INFO - exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:109:14
[task 2018-12-12T22:30:57.946Z] 22:30:57     INFO - DevToolsUtils.executeSoon*exports.executeSoon@resource://devtools/shared/DevToolsUtils.js:57:21
[task 2018-12-12T22:30:57.947Z] 22:30:57     INFO - send@resource://devtools/shared/transport/local-transport.js:58:7
[task 2018-12-12T22:30:57.947Z] 22:30:57     INFO - send@resource://devtools/shared/protocol.js:1390:9
[task 2018-12-12T22:30:57.948Z] 22:30:57     INFO - request@resource://devtools/shared/protocol.js:1408:5
[task 2018-12-12T22:30:57.949Z] 22:30:57     INFO - generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol.js:1530:14
[task 2018-12-12T22:30:57.949Z] 22:30:57     INFO - listAllWorkers@resource://devtools/shared/fronts/root.js:65:35
[task 2018-12-12T22:30:57.950Z] 22:30:57     INFO - async*listWorkers@resource://devtools/client/aboutdebugging-new/src/modules/client-wrapper.js:120:46
[task 2018-12-12T22:30:57.950Z] 22:30:57     INFO - async*requestWorkers/<@resource://devtools/client/aboutdebugging-new/src/actions/debug-targets.js:201:17
[task 2018-12-12T22:30:57.951Z] 22:30:57     INFO - async*thunk/</<@resource://devtools/client/shared/redux/middleware/thunk.js:15:9
[task 2018-12-12T22:30:57.951Z] 22:30:57     INFO - dispatch@resource://devtools/client/shared/vendor/redux.js:755:18
[task 2018-12-12T22:30:57.952Z] 22:30:57     INFO - Rejection date: Wed Dec 12 2018 22:30:56 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 257
[task 2018-12-12T22:30:57.953Z] 22:30:57     INFO - Stack trace:
[task 2018-12-12T22:30:57.953Z] 22:30:57     INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:257
[task 2018-12-12T22:30:57.954Z] 22:30:57     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1118
[task 2018-12-12T22:30:57.954Z] 22:30:57     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1084
[task 2018-12-12T22:30:57.955Z] 22:30:57     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:982
[task 2018-12-12T22:30:57.955Z] 22:30:57     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:803
[task 2018-12-12T22:30:57.956Z] 22:30:57     INFO - Leaving test bound 
[task 2018-12-12T22:30:57.957Z] 22:30:57     INFO - GECKO(1085) | MEMORY STAT | vsize 2013MB | residentFast 392MB | heapAllocated 147MB
[task 2018-12-12T22:30:57.958Z] 22:30:57     INFO - TEST-OK | devtools/client/aboutdebugging-new/test/browser/browser_aboutdebugging_sidebar_usb_runtime_connect.js | took 423ms
[task 2018-12-12T22:30:57.958Z] 22:30:57     INFO - checking window state

Comment 1

[Intermittent Failures Robot]

3 failures in 2485 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* try: 1
* autoland: 1
* mozilla-central: 1

Platform breakdown:
* linux32: 2
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513739&startday=2018-12-10&endday=2018-12-16&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 2648 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1

Platform breakdown:
* linux32: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1513739&startday=2018-12-17&endday=2018-12-23&tree=all

Comment 3

[Firefox Bug Husbandry Bot]

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