Open Bug 1570100 Opened 5 years ago Updated 2 years ago

OSX Mojave (10.14) - TEST-UNEXPECTED-TIMEOUT | browser/tools/mozscreenshots/devtools/browser_devtools.js

Categories

(DevTools :: General, defect, P5)

defect

Tracking

(Not tracked)

People

(Reporter: egao, Unassigned)

References

(Blocks 1 open bug)

Details

Filed by: egao [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=259043591&repo=try
Full log: https://queue.taskcluster.net/v1/task/cheb44W3SJGKFa4RBvhYuA/runs/0/artifacts/public/logs/live_backing.log


Platform: macosx1014
Suite: browser-screenshots

Test consumes too much time causing the following test to crash.

Context:
[task 2019-07-30T17:12:46.323Z] 17:12:46 INFO - TEST-START | browser/tools/mozscreenshots/devtools/browser_devtools.js
[task 2019-07-30T17:12:46.354Z] 17:12:46 INFO - installing extension temporarily
[task 2019-07-30T17:12:46.407Z] 17:12:46 INFO - GECKO(1650) | /System/Library/LaunchAgents/com.apple.notificationcenterui.plist: Could not find specified service
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - GECKO(1650) | No matching processes belonging to you were found
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - Checking for mozscreenshots extension
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | The mozscreenshots extension should be installed -
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - Leaving test bound setup
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - Entering test bound capture
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - Saving screenshots to: /Users/cltbld/tasks/task_1564506618/build/blobber_upload_dir
[task 2019-07-30T17:12:46.445Z] 17:12:46 INFO - 1 sets: DevTools
[task 2019-07-30T17:12:46.446Z] 17:12:46 INFO - 9 combinations
[task 2019-07-30T17:12:46.665Z] 17:12:46 INFO - Combination 1/9: bottomToolbox
[task 2019-07-30T17:12:46.666Z] 17:12:46 INFO - promising bottomToolbox
[task 2019-07-30T17:12:46.666Z] 17:12:46 INFO - calling bottomToolbox
[task 2019-07-30T17:12:46.720Z] 17:12:46 INFO - called bottomToolbox
[task 2019-07-30T17:12:47.553Z] 17:12:47 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.jsm" line: 253}]
[task 2019-07-30T17:12:47.559Z] 17:12:47 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.jsm" line: 253}]
[task 2019-07-30T17:12:47.645Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_GRIDS"
[task 2019-07-30T17:12:47.666Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2019-07-30T17:12:47.779Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2019-07-30T17:12:47.781Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2019-07-30T17:12:47.886Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2019-07-30T17:12:47.886Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2019-07-30T17:12:47.886Z] 17:12:47 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2019-07-30T17:12:49.338Z] 17:12:49 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:12:49.338Z] 17:12:49 INFO - Configured UI for [ bottomToolbox ] successfully
[task 2019-07-30T17:12:49.338Z] 17:12:49 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:12:50.218Z] 17:12:50 INFO - GECKO(1650) | 2019-07-30 17:12:50.182 firefox[1650:7240] Persistent UI failed to open file file:///Users/cltbld/Library/Saved%20Application%20State/org.mozilla.nightly.savedState/window_1.data: No such file or directory (2)
[task 2019-07-30T17:13:31.442Z] 17:13:31 INFO - Longer timeout required, waiting longer... Remaining timeouts: 99
[task 2019-07-30T17:14:16.488Z] 17:14:16 INFO - Longer timeout required, waiting longer... Remaining timeouts: 98
[task 2019-07-30T17:14:49.648Z] 17:14:49 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:14:51.960Z] 17:14:51 INFO - _onConfigurationReady
[task 2019-07-30T17:14:51.961Z] 17:14:51 INFO - Combination 2/9: sideToolbox
[task 2019-07-30T17:14:51.963Z] 17:14:51 INFO - promising sideToolbox
[task 2019-07-30T17:14:51.963Z] 17:14:51 INFO - calling sideToolbox
[task 2019-07-30T17:14:51.964Z] 17:14:51 INFO - called sideToolbox
[task 2019-07-30T17:14:52.220Z] 17:14:52 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2019-07-30T17:14:52.220Z] 17:14:52 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2019-07-30T17:14:52.255Z] 17:14:52 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2019-07-30T17:14:53.071Z] 17:14:53 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:14:53.071Z] 17:14:53 INFO - Configured UI for [ sideToolbox ] successfully
[task 2019-07-30T17:14:53.071Z] 17:14:53 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:15:01.498Z] 17:15:01 INFO - Longer timeout required, waiting longer... Remaining timeouts: 97
[task 2019-07-30T17:15:46.593Z] 17:15:46 INFO - Longer timeout required, waiting longer... Remaining timeouts: 96
[task 2019-07-30T17:16:31.732Z] 17:16:31 INFO - Longer timeout required, waiting longer... Remaining timeouts: 95
[task 2019-07-30T17:16:53.287Z] 17:16:53 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:16:55.625Z] 17:16:55 INFO - _onConfigurationReady
[task 2019-07-30T17:16:55.625Z] 17:16:55 INFO - Combination 3/9: undockedToolbox
[task 2019-07-30T17:16:55.625Z] 17:16:55 INFO - promising undockedToolbox
[task 2019-07-30T17:16:55.625Z] 17:16:55 INFO - calling undockedToolbox
[task 2019-07-30T17:16:55.625Z] 17:16:55 INFO - called undockedToolbox
[task 2019-07-30T17:16:55.821Z] 17:16:55 INFO - Console message: OpenGL compositor Initialized Succesfully.
[task 2019-07-30T17:16:55.821Z] 17:16:55 INFO - Version: 2.1 INTEL-12.9.22
[task 2019-07-30T17:16:55.821Z] 17:16:55 INFO - Vendor: Intel Inc.
[task 2019-07-30T17:16:55.821Z] 17:16:55 INFO - Renderer: Intel Iris OpenGL Engine
[task 2019-07-30T17:16:55.821Z] 17:16:55 INFO - FBO Texture Target: TEXTURE_2D
[task 2019-07-30T17:16:55.913Z] 17:16:55 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "CLEAR_FLEXBOX"
[task 2019-07-30T17:16:55.938Z] 17:16:55 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_OFFSET_PARENT"
[task 2019-07-30T17:16:55.938Z] 17:16:55 INFO - GECKO(1650) | console.log: "[DISPATCH] action type:" "UPDATE_LAYOUT"
[task 2019-07-30T17:16:56.959Z] 17:16:56 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:16:56.959Z] 17:16:56 INFO - Configured UI for [ undockedToolbox ] successfully
[task 2019-07-30T17:16:56.959Z] 17:16:56 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:17:16.793Z] 17:17:16 INFO - Longer timeout required, waiting longer... Remaining timeouts: 94
[task 2019-07-30T17:18:01.888Z] 17:18:01 INFO - Longer timeout required, waiting longer... Remaining timeouts: 93
[task 2019-07-30T17:18:46.899Z] 17:18:46 INFO - Longer timeout required, waiting longer... Remaining timeouts: 92
[task 2019-07-30T17:18:57.104Z] 17:18:57 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:18:59.281Z] 17:18:59 INFO - _onConfigurationReady
[task 2019-07-30T17:18:59.285Z] 17:18:59 INFO - Combination 4/9: options
[task 2019-07-30T17:18:59.285Z] 17:18:59 INFO - promising options
[task 2019-07-30T17:18:59.285Z] 17:18:59 INFO - calling options
[task 2019-07-30T17:18:59.285Z] 17:18:59 INFO - called options
[task 2019-07-30T17:19:00.573Z] 17:19:00 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:19:00.573Z] 17:19:00 INFO - Configured UI for [ options ] successfully
[task 2019-07-30T17:19:00.573Z] 17:19:00 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:19:31.959Z] 17:19:31 INFO - Longer timeout required, waiting longer... Remaining timeouts: 91
[task 2019-07-30T17:20:16.993Z] 17:20:16 INFO - Longer timeout required, waiting longer... Remaining timeouts: 90
[task 2019-07-30T17:21:00.782Z] 17:21:00 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:21:01.955Z] 17:21:01 INFO - Longer timeout required, waiting longer... Remaining timeouts: 89
[task 2019-07-30T17:21:03.110Z] 17:21:03 INFO - _onConfigurationReady
[task 2019-07-30T17:21:03.110Z] 17:21:03 INFO - Combination 5/9: webconsole
[task 2019-07-30T17:21:03.110Z] 17:21:03 INFO - promising webconsole
[task 2019-07-30T17:21:03.110Z] 17:21:03 INFO - calling webconsole
[task 2019-07-30T17:21:03.110Z] 17:21:03 INFO - called webconsole
[task 2019-07-30T17:21:04.512Z] 17:21:04 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:21:04.512Z] 17:21:04 INFO - Configured UI for [ webconsole ] successfully
[task 2019-07-30T17:21:04.512Z] 17:21:04 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:21:47.038Z] 17:21:47 INFO - Longer timeout required, waiting longer... Remaining timeouts: 88
[task 2019-07-30T17:22:32.116Z] 17:22:32 INFO - Longer timeout required, waiting longer... Remaining timeouts: 87
[task 2019-07-30T17:23:04.663Z] 17:23:04 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:23:06.849Z] 17:23:06 INFO - _onConfigurationReady
[task 2019-07-30T17:23:06.849Z] 17:23:06 INFO - Combination 6/9: jsdebugger
[task 2019-07-30T17:23:06.849Z] 17:23:06 INFO - promising jsdebugger
[task 2019-07-30T17:23:06.849Z] 17:23:06 INFO - calling jsdebugger
[task 2019-07-30T17:23:06.849Z] 17:23:06 INFO - called jsdebugger
[task 2019-07-30T17:23:08.635Z] 17:23:08 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:23:08.635Z] 17:23:08 INFO - Configured UI for [ jsdebugger ] successfully
[task 2019-07-30T17:23:08.635Z] 17:23:08 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:23:17.122Z] 17:23:17 INFO - Longer timeout required, waiting longer... Remaining timeouts: 86
[task 2019-07-30T17:24:02.318Z] 17:24:02 INFO - Longer timeout required, waiting longer... Remaining timeouts: 85
[task 2019-07-30T17:24:47.392Z] 17:24:47 INFO - Longer timeout required, waiting longer... Remaining timeouts: 84
[task 2019-07-30T17:25:08.794Z] 17:25:08 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:25:10.957Z] 17:25:10 INFO - _onConfigurationReady
[task 2019-07-30T17:25:10.957Z] 17:25:10 INFO - Combination 7/9: styleeditor
[task 2019-07-30T17:25:10.958Z] 17:25:10 INFO - promising styleeditor
[task 2019-07-30T17:25:10.958Z] 17:25:10 INFO - calling styleeditor
[task 2019-07-30T17:25:10.958Z] 17:25:10 INFO - called styleeditor
[task 2019-07-30T17:25:11.104Z] 17:25:11 INFO - Console message: [JavaScript Warning: "XUL box for h3 element contained an inline #text child, forcing all its children to be wrapped in a block." {file: "chrome://devtools/content/styleeditor/index.xul" line: 0}]
[task 2019-07-30T17:25:12.149Z] 17:25:12 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:25:12.149Z] 17:25:12 INFO - Configured UI for [ styleeditor ] successfully
[task 2019-07-30T17:25:12.150Z] 17:25:12 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:25:32.463Z] 17:25:32 INFO - Longer timeout required, waiting longer... Remaining timeouts: 83
[task 2019-07-30T17:26:17.523Z] 17:26:17 INFO - Longer timeout required, waiting longer... Remaining timeouts: 82
[task 2019-07-30T17:27:02.622Z] 17:27:02 INFO - Longer timeout required, waiting longer... Remaining timeouts: 81
[task 2019-07-30T17:27:12.422Z] 17:27:12 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:27:14.605Z] 17:27:14 INFO - _onConfigurationReady
[task 2019-07-30T17:27:14.605Z] 17:27:14 INFO - Combination 8/9: performance
[task 2019-07-30T17:27:14.605Z] 17:27:14 INFO - promising performance
[task 2019-07-30T17:27:14.605Z] 17:27:14 INFO - calling performance
[task 2019-07-30T17:27:14.605Z] 17:27:14 INFO - called performance
[task 2019-07-30T17:27:14.785Z] 17:27:14 INFO - GECKO(1650) | JavaScript warning: resource://devtools/client/shared/demangle.js, line 0: Successfully compiled asm.js code (total compilation time 80ms)
[task 2019-07-30T17:27:14.827Z] 17:27:14 INFO - Console message: [JavaScript Warning: "Successfully compiled asm.js code (total compilation time 80ms)" {file: "resource://devtools/client/shared/demangle.js" line: 0}]
[task 2019-07-30T17:27:15.977Z] 17:27:15 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:27:15.978Z] 17:27:15 INFO - Configured UI for [ performance ] successfully
[task 2019-07-30T17:27:15.978Z] 17:27:15 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:27:47.697Z] 17:27:47 INFO - Longer timeout required, waiting longer... Remaining timeouts: 80
[task 2019-07-30T17:28:32.781Z] 17:28:32 INFO - Longer timeout required, waiting longer... Remaining timeouts: 79
[task 2019-07-30T17:29:16.122Z] 17:29:16 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:29:17.938Z] 17:29:17 INFO - Longer timeout required, waiting longer... Remaining timeouts: 78
[task 2019-07-30T17:29:18.488Z] 17:29:18 INFO - _onConfigurationReady
[task 2019-07-30T17:29:18.488Z] 17:29:18 INFO - Combination 9/9: netmonitor
[task 2019-07-30T17:29:18.488Z] 17:29:18 INFO - promising netmonitor
[task 2019-07-30T17:29:18.488Z] 17:29:18 INFO - calling netmonitor
[task 2019-07-30T17:29:18.488Z] 17:29:18 INFO - called netmonitor
[task 2019-07-30T17:29:19.921Z] 17:29:19 INFO - fulfilled all applyConfig so setting lastCombo.
[task 2019-07-30T17:29:19.921Z] 17:29:19 INFO - Configured UI for [ netmonitor ] successfully
[task 2019-07-30T17:29:19.921Z] 17:29:19 INFO - TEST-PASS | browser/tools/mozscreenshots/devtools/browser_devtools.js | A valid bounding box was found -
[task 2019-07-30T17:30:02.950Z] 17:30:02 INFO - Longer timeout required, waiting longer... Remaining timeouts: 77
[task 2019-07-30T17:30:47.969Z] 17:30:47 INFO - Longer timeout required, waiting longer... Remaining timeouts: 76
[task 2019-07-30T17:31:20.194Z] 17:31:20 INFO - GECKO(1650) | 73:75: execution error: Firefox Nightly got an error: AppleEvent timed out. (-1712)
[task 2019-07-30T17:31:22.529Z] 17:31:22 INFO - _onConfigurationReady
[task 2019-07-30T17:31:22.529Z] 17:31:22 INFO - Done: Completed 9 out of 9 configurations.
[task 2019-07-30T17:31:22.653Z] 17:31:22 INFO - GECKO(1650) | console.error: "Error: Can not send request because front 'stylesheets' is already destroyed.: generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:29:15\n_onNewDocument@resource://devtools/client/styleeditor/StyleEditorUI.jsm:257:8\nemit@resource://devtools/shared/event-emitter.js:190:24\nemit@resource://devtools/shared/event-emitter.js:271:18\n_onTabNavigated@resource://devtools/shared/fronts/targets/browsing-context.js:89:12\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:204:13\nonPacket@resource://devtools/shared/client/debugger-client.js:593: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/main.js:1108: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/main.js:800:24\nexports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22\nMessageListener.receiveMessagetrackMessageManager@resource://devtools/server/main.js:668:14\nconnectToFrame/<@resource://devtools/server/main.js:900:7\nconnectToFrame@resource://devtools/server/main.js:654:12\nconnect@resource://devtools/server/actors/targets/frame-proxy.js:62:36\nasyncBrowserTabList.prototype._getActorForBrowser@resource://devtools/server/actors/webbrowser.js:370:16\nBrowserTabList.prototype.getTab@resource://devtools/server/actors/webbrowser.js:412:21\nonGetTab@resource://devtools/server/actors/root.js:369:35\nonPacket@resource://devtools/server/main.js:1402: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:150:30\nrequest@resource://devtools/shared/protocol/Front.js:168:10\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\ngetTab@resource://devtools/shared/fronts/root.js:252:18\ncreateTargetForTab@resource://devtools/client/framework/target.js:90:28\nasyncforTab@resource://devtools/client/framework/target.js:35:26\ngetTargetForSelectedTab@resource://mozscreenshots/configurations/DevTools.jsm:17:36\napplyConfig@resource://mozscreenshots/configurations/DevTools.jsm:52:28\nchangeConfig@resource://mozscreenshots/TestRunner.jsm:358:49\n_performCombo@resource://mozscreenshots/TestRunner.jsm:379:32\nstart@resource://mozscreenshots/TestRunner.jsm:157:18\nasynccapture@chrome://mochitests/content/browser/browser/tools/mozscreenshots/devtools/browser_devtools.js:19:20\nTester_execTest/<@chrome://mochikit/content/browser-test.js:1346:34\nasyncTester_execTest@chrome://mochikit/content/browser-test.js:1381:11\nnextTest/<@chrome://mochikit/content/browser-test.js:1209:14\nSimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:803:59\n"
[task 2019-07-30T17:31:22.654Z] 17:31:22 INFO - GECKO(1650) | Error: Can not send request because front 'stylesheets' is already destroyed.: generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:29:15
[task 2019-07-30T17:31:22.654Z] 17:31:22 INFO - GECKO(1650) | _onNewDocument@resource://devtools/client/styleeditor/StyleEditorUI.jsm:257:8
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | emit@resource://devtools/shared/event-emitter.js:190:24
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | emit@resource://devtools/shared/event-emitter.js:271:18
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | _onTabNavigated@resource://devtools/shared/fronts/targets/browsing-context.js:89:12
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | emit@resource://devtools/shared/event-emitter.js:190:24
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | emit@resource://devtools/shared/event-emitter.js:271:18
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | onPacket@resource://devtools/shared/protocol/Front.js:204:13
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | onPacket@resource://devtools/shared/client/debugger-client.js:593:13
[task 2019-07-30T17:31:22.655Z] 17:31:22 INFO - GECKO(1650) | send/<@resource://devtools/shared/transport/local-transport.js:70:25
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | DevToolsUtils.executeSoonexports.executeSoon@resource://devtools/shared/DevToolsUtils.js:62:21
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | send@resource://devtools/shared/transport/local-transport.js:58:21
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | send@resource://devtools/server/main.js:1108:20
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | receiveMessage@resource://devtools/shared/transport/child-transport.js:66:16
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | MessageListener.receiveMessage
_addListener@resource://devtools/shared/transport/child-transport.js:40:14
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | ready@resource://devtools/shared/transport/child-transport.js:57:10
[task 2019-07-30T17:31:22.656Z] 17:31:22 INFO - GECKO(1650) | connectToFrame/</onActorCreated<@resource://devtools/server/main.js:800:24
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | MessageListener.receiveMessagetrackMessageManager@resource://devtools/server/main.js:668:14
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | connectToFrame/<@resource://devtools/server/main.js:900:7
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | connectToFrame@resource://devtools/server/main.js:654:12
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | connect@resource://devtools/server/actors/targets/frame-proxy.js:62:36
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | async
BrowserTabList.prototype._getActorForBrowser@resource://devtools/server/actors/webbrowser.js:370:16
[task 2019-07-30T17:31:22.657Z] 17:31:22 INFO - GECKO(1650) | BrowserTabList.prototype.getTab@resource://devtools/server/actors/webbrowser.js:412:21
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | onGetTab@resource://devtools/server/actors/root.js:369:35
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | onPacket@resource://devtools/server/main.js:1402:58
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | send/<@resource://devtools/shared/transport/local-transport.js:70:25
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | exports.makeInfallible/<@resource://devtools/shared/ThreadSafeDevToolsUtils.js:111:22
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | DevToolsUtils.executeSoonexports.executeSoon@resource://devtools/shared/DevToolsUtils.js:62:21
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | send@resource://devtools/shared/transport/local-transport.js:58:21
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | send@resource://devtools/shared/protocol/Front.js:150:30
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | request@resource://devtools/shared/protocol/Front.js:168:10
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | generateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19
[task 2019-07-30T17:31:22.658Z] 17:31:22 INFO - GECKO(1650) | getTab@resource://devtools/shared/fronts/root.js:252:18
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | createTargetForTab@resource://devtools/client/framework/target.js:90:28
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | async
forTab@resource://devtools/client/framework/target.js:35:26
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | getTargetForSelectedTab@resource://mozscreenshots/configurations/DevTools.jsm:17:36
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | applyConfig@resource://mozscreenshots/configurations/DevTools.jsm:52:28
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | changeConfig@resource://mozscreenshots/TestRunner.jsm:358:49
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | _performCombo@resource://mozscreenshots/TestRunner.jsm:379:32
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | start@resource://mozscreenshots/TestRunner.jsm:157:18
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | asynccapture@chrome://mochitests/content/browser/browser/tools/mozscreenshots/devtools/browser_devtools.js:19:20
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | Tester_execTest/<@chrome://mochikit/content/browser-test.js:1346:34
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | async
Tester_execTest@chrome://mochikit/content/browser-test.js:1381:11
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | nextTest/<@chrome://mochikit/content/browser-test.js:1209:14
[task 2019-07-30T17:31:22.659Z] 17:31:22 INFO - GECKO(1650) | SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:803:59
[task 2019-07-30T17:31:22.833Z] 17:31:22 INFO - Leaving test bound capture
[task 2019-07-30T17:31:22.833Z] 17:31:22 INFO - GECKO(1650) | console.log: "getSources failed. Connection may have closed: Error: Can not send request because front 'thread' is already destroyed."
[task 2019-07-30T17:31:22.858Z] 17:31:22 INFO - GECKO(1650) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
[task 2019-07-30T17:31:22.858Z] 17:31:22 INFO - GECKO(1650) | MEMORY STAT | vsize 7757MB | residentFast 420MB | heapAllocated 128MB
[task 2019-07-30T17:31:22.858Z] 17:31:22 INFO - TEST-OK | browser/tools/mozscreenshots/devtools/browser_devtools.js | took 1116529ms

No longer depends on: 1570086

This test appears to be one of the blockers for migrating browser-screenshots to macosx1014, but I have been able to arrive at a solution via the following:

  • disable browser_controlCenter.js
  • disable browser_devtools.js
  • disable browser_permissionPrompts.js
  • disable browser_primaryUI.js

This results in a green mochitest-browser-screenshots run for macosx1014.

Enabling any one of these tests individually would cause the suite to time out at 60 minutes. Longer timeouts do not help, as the suite keeps expanding in time to consume any additional timeouts that are given.

The current proposal is to disable the tests mentioned above, which includes test detailed in this bug, so that browser-screenshots job can be moved to macosx1014 leading to decommisioning of macosx1010 machines.

:pbro - if you have any comments regarding this proposal, please let me know.

Severity: normal → S3
You need to log in before you can comment on or make changes to this bug.