Closed Bug 1749983 Opened 3 years ago Closed 3 years ago

Intermittent devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | A promise chain failed to handle a rejection: this.commands is null - stack: get target@resource://devtools/client/framework/toolbox.js:540:5

Categories

(DevTools :: Console, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: ccozmuta [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=363992846&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/KnRvM5o0RwS_6NhvjDHpmA/runs/0/artifacts/public/logs/live_backing.log


[task 2022-01-13T13:03:23.098Z] 13:03:23     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js
[task 2022-01-13T13:03:24.019Z] 13:03:24     INFO - GECKO(6246) | console.warn: "Already started legacy listener for cloned-content-process-message on server0.conn24.windowGlobal2147483673/windowGlobalTarget2"
[task 2022-01-13T13:03:24.465Z] 13:03:24     INFO - GECKO(6246) | console.warn: "Async method failed in safeAsyncMethod" (new Error("Connection closed, pending request to server0.conn24.windowGlobal2147483670/performanceActor12, type connect failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:292:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:46:19\nconnect@resource://devtools/client/fronts/performance.js:63:36\nAsync*exports.safeAsyncMethod/<@resource://devtools/shared/async-utils.js:61:25\ninitialize@resource://devtools/client/fronts/performance.js:54:16\nmanage@resource://devtools/shared/protocol/Front.js:146:19\ngetFront@resource://devtools/shared/protocol/types.js:559:18\ngetFront@resource://devtools/client/fronts/targets/target-mixin.js:332:15\ninitPerformance@resource://devtools/client/framework/toolbox.js:4208:48\n_onTargetAvailable@resource://devtools/client/framework/toolbox.js:731:18\nAsync*_emit@resource://devtools/shared/event-emitter.js:244:34\nemitAsync@resource://devtools/shared/event-emitter.js:194:25\nemitAsync@resource://devtools/shared/event-emitter.js:346:25\n_onTargetAvailable@resource://devtools/shared/commands/target/target-command.js:215:33\nAsync*_emit@resource://devtools/shared/event-emitter.js:244:34\nemit@resource://devtools/shared/event-emitter.js:190:18\nemit@resource://devtools/shared/event-emitter.js:342:18\n_onTargetAvailable@resource://devtools/client/fronts/watcher.js:60:10\n_emit@resource://devtools/shared/event-emitter.js:244:34\nemit@resource://devtools/shared/event-emitter.js:190:18\nemit@resource://devtools/shared/event-emitter.js:342:18\nonPacket@resource://devtools/shared/protocol/Front.js:336:13\nonPacket@resource://devtools/client/devtools-client.js:482:13\nsend/<@resource://devtools/shared/transport/local-transport.js:68:25\nexports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:103:22\nDevToolsUtils.executeSoon*exports.executeSoon@resource://devtools/shared/DevToolsUtils.js:54:21\nsend@resource://devtools/shared/transport/local-transport.js:56:21\nsend@resource://devtools/server/devtools-server-connection.js:99:20\n_sendEvent@resource://devtools/shared/protocol/Actor.js:72:15\ninitialize/<@resource://devtools/shared/protocol/Actor.js:46:16\n_emit@resource://devtools/shared/event-emitter.js:244:34\nemit@resource://devtools/shared/event-emitter.js:190:18\nemit@resource://devtools/shared/event-emitter.js:342:18\nnotifyTargetAvailable@resource://devtools/server/actors/watcher.js:316:12\nconnectFromContent@resource://devtools/server/connectors/js-window-actor/DevToolsFrameParent.jsm:145:13\nreceiveMessage@resource://devtools/server/connectors/js-window-actor/DevToolsFrameParent.jsm:211:21\nJSActor query*_createTargetActor@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:281:10\ninstantiate@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:163:14\nhandleEvent@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:583:12\n", "resource://devtools/shared/protocol/Front.js", 106))
[task 2022-01-13T13:03:24.468Z] 13:03:24     INFO - GECKO(6246) | console.warn: "IGNORED REDUX ACTION:" "AUTOCOMPLETE_CLEAR"
[task 2022-01-13T13:03:24.474Z] 13:03:24     INFO - GECKO(6246) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2022-01-13T13:03:24.475Z] 13:03:24     INFO - GECKO(6246) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'DevToolsFrame'
[task 2022-01-13T13:03:24.491Z] 13:03:24     INFO - GECKO(6246) | JavaScript error: resource://devtools/client/framework/toolbox.js, line 540: TypeError: this.commands is null
[task 2022-01-13T13:03:24.500Z] 13:03:24     INFO - TEST-INFO | started process screentopng
[task 2022-01-13T13:03:25.179Z] 13:03:25     INFO - TEST-INFO | screentopng: exit 0
[task 2022-01-13T13:03:25.182Z] 13:03:25     INFO - Buffered messages logged at 13:03:23
[task 2022-01-13T13:03:25.183Z] 13:03:25     INFO - Entering test bound 
[task 2022-01-13T13:03:25.183Z] 13:03:25     INFO - Adding a new tab with URL: http://example.com/browser/devtools/client/webconsole/test/browser/test-console-api-iframe.html
[task 2022-01-13T13:03:25.184Z] 13:03:25     INFO - Tab added and finished loading
[task 2022-01-13T13:03:25.184Z] 13:03:25     INFO - Opening the toolbox
[task 2022-01-13T13:03:25.185Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.185Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.186Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-01-13T13:03:25.191Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.191Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.192Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-01-13T13:03:25.192Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.193Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.194Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-01-13T13:03:25.194Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.198Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.201Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-01-13T13:03:25.202Z] 13:03:25     INFO - Toolbox opened and focused
[task 2022-01-13T13:03:25.203Z] 13:03:25     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | The initial message is displayed in the console - 
[task 2022-01-13T13:03:25.205Z] 13:03:25     INFO - Buffered messages logged at 13:03:24
[task 2022-01-13T13:03:25.206Z] 13:03:25     INFO - Matched a message with text: "iframe added", all messages received.
[task 2022-01-13T13:03:25.208Z] 13:03:25     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | The message is also displayed after a page reload - 
[task 2022-01-13T13:03:25.210Z] 13:03:25     INFO - Leaving test bound 
[task 2022-01-13T13:03:25.211Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.212Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-01-13T13:03:25.213Z] 13:03:25     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-01-13T13:03:25.214Z] 13:03:25     INFO - Removing tab.
[task 2022-01-13T13:03:25.215Z] 13:03:25     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2022-01-13T13:03:25.216Z] 13:03:25     INFO - Got event: 'TabClose' on [object XULElement].
[task 2022-01-13T13:03:25.217Z] 13:03:25     INFO - Tab removed and finished closing
[task 2022-01-13T13:03:25.218Z] 13:03:25     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2022-01-13T13:03:25.219Z] 13:03:25     INFO - Console message: [JavaScript Error: "NotFoundError: No such JSWindowActor 'DevToolsFrame'"]
[task 2022-01-13T13:03:25.219Z] 13:03:25     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2022-01-13T13:03:25.221Z] 13:03:25     INFO - Console message: [JavaScript Error: "TypeError: this.commands is null" {file: "resource://devtools/client/framework/toolbox.js" line: 540}]
[task 2022-01-13T13:03:25.221Z] 13:03:25     INFO - Buffered messages finished
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | A promise chain failed to handle a rejection: this.commands is null - stack: get target@resource://devtools/client/framework/toolbox.js:540:5
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _commandIsVisible@resource://devtools/client/framework/toolbox.js:2376:30
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - updateFrameButton@resource://devtools/client/framework/toolbox.js:2351:14
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - updateUiElements@resource://devtools/client/framework/toolbox.js:3508:12
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _updateFrames@resource://devtools/client/framework/toolbox.js:3520:7
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _onTargetAvailable@resource://devtools/client/framework/toolbox.js:735:12
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - Async*_emit@resource://devtools/shared/event-emitter.js:244:34
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - emitAsync@resource://devtools/shared/event-emitter.js:194:25
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - emitAsync@resource://devtools/shared/event-emitter.js:346:25
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _onTargetAvailable@resource://devtools/shared/commands/target/target-command.js:215:33
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - Async*_emit@resource://devtools/shared/event-emitter.js:244:34
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:190:18
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:342:18
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _onTargetAvailable@resource://devtools/client/fronts/watcher.js:60:10
[task 2022-01-13T13:03:25.226Z] 13:03:25     INFO - _emit@resource://devtools/shared/event-emitter.js:244:34
[task 2022-01-13T13:03:25.227Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:190:18
[task 2022-01-13T13:03:25.228Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:342:18
[task 2022-01-13T13:03:25.228Z] 13:03:25     INFO - onPacket@resource://devtools/shared/protocol/Front.js:336:13
[task 2022-01-13T13:03:25.228Z] 13:03:25     INFO - onPacket@resource://devtools/client/devtools-client.js:482:13
[task 2022-01-13T13:03:25.229Z] 13:03:25     INFO - send/<@resource://devtools/shared/transport/local-transport.js:68:25
[task 2022-01-13T13:03:25.229Z] 13:03:25     INFO - exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:103:22
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - DevToolsUtils.executeSoon*exports.executeSoon@resource://devtools/shared/DevToolsUtils.js:54:21
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - send@resource://devtools/shared/transport/local-transport.js:56:21
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - send@resource://devtools/server/devtools-server-connection.js:99:20
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - _sendEvent@resource://devtools/shared/protocol/Actor.js:72:15
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - initialize/<@resource://devtools/shared/protocol/Actor.js:46:16
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - _emit@resource://devtools/shared/event-emitter.js:244:34
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:190:18
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - emit@resource://devtools/shared/event-emitter.js:342:18
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - notifyTargetAvailable@resource://devtools/server/actors/watcher.js:316:12
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - connectFromContent@resource://devtools/server/connectors/js-window-actor/DevToolsFrameParent.jsm:145:13
[task 2022-01-13T13:03:25.230Z] 13:03:25     INFO - receiveMessage@resource://devtools/server/connectors/js-window-actor/DevToolsFrameParent.jsm:211:21
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - JSActor query*_createTargetActor@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:281:10
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - instantiate@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:163:14
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - handleEvent@resource://devtools/server/connectors/js-window-actor/DevToolsFrameChild.jsm:583:12
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - Rejection date: Thu Jan 13 2022 13:03:24 GMT+0000 (Coordinated Universal Time) - false == true - JS frame :: resource://testing-common/PromiseTestUtils.jsm :: assertNoUncaughtRejections :: line 271
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - Stack trace:
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - resource://testing-common/PromiseTestUtils.jsm:assertNoUncaughtRejections:271
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - chrome://mochikit/content/browser-test.js:nextTest:625
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - chrome://mochikit/content/browser-test.js:testScope/test_finish/<:1594
[task 2022-01-13T13:03:25.231Z] 13:03:25     INFO - chrome://mochikit/content/browser-test.js:run:1509
[task 2022-01-13T13:03:25.237Z] 13:03:25     INFO - GECKO(6246) | MEMORY STAT | vsize 11851MB | residentFast 810MB | heapAllocated 442MB
[task 2022-01-13T13:03:25.238Z] 13:03:25     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_console_api_iframe.js | took 1429ms
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.