1585860 - Perma [tier 2] devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js | Time warp menu item is available -

Status: RESOLVED FIXED

(Core Graveyard :: Web Replay, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ccoroiu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=269542602&repo=autoland
Full log: https://queue.taskcluster.net/v1/task/VEx-MSWUS0K2aYu-WZj9sg/runs/0/artifacts/public/logs/live_backing.log

---

task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - TEST-PASS | devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js | Found one message -
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - Buffered messages finished
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - TEST-UNEXPECTED-FAIL | devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js | Time warp menu item is available -
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - Stack trace:
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochikit/content/browser-test.js:test_ok:1580
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/head.js:warpToMessage:160
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js:null:16
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1350
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1385
[task 2019-10-03T00:29:54.513Z] 00:29:54 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1213
[task 2019-10-03T00:29:54.514Z] 00:29:54 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:805
[task 2019-10-03T00:29:54.514Z] 00:29:54 INFO - Not taking screenshot here: see the one that was previously logged
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - TEST-UNEXPECTED-FAIL | devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js | Uncaught exception - at chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/head.js:162 - TypeError: timeWarpItem is null
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - Stack trace:
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - warpToMessage@chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/head.js:162:3
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - async*@chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js:16:9
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - AsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1350:34
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1385:11
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:1213:14
[task 2019-10-03T00:29:54.515Z] 00:29:54 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:805:67
[task 2019-10-03T00:29:54.516Z] 00:29:54 INFO - Leaving test bound
[task 2019-10-03T00:29:54.524Z] 00:29:54 INFO - GECKO(1680) | console.log: "getSources failed. Connection may have closed: Error: Connection closed, pending request to server0.conn7.child1/thread20, type sources failed\n\nRequest stack:\nrequest@resource://devtools/shared/protocol/Front.js:167:14\ngenerateRequestMethods/</frontProto[name]@resource://devtools/shared/protocol/Front/FrontClassWithSpec.js:49:19\ngetSources@resource://devtools/shared/fronts/thread.js:210: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\nenqueueForceUpdate@resource://devtools/client/shared/vendor/react-dom.js:8225:17\nComponent.prototype.forceUpdate@resource://devtools/client/shared/vendor/react.js:346:16\nonVisibilityChange@resource://devtools/client/shared/components/VisibilityHandler.js:46:12\nsetIframeVisible@resource://devtools/client/framework/toolbox.js:2489:11\nopenSplitConsole@resource://devtools/client/framework/toolbox.js:2698:12\ntoggleSplitConsole@resource://devtools/client/framework/toolbox.js:2750:16\n_splitConsoleOnKeypress@resource://devtools/client/framework/toolbox.js:1438:12\nsynthesizeKey@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:870:11\npressKey@chrome://mochitests/content/browser/devtools/client/debugger/test/mochitest/helpers.js:1156:21\ngetDebuggerSplitConsole@chrome://mochitests/content/browser/devtools/client/debugger/test/mochitest/helpers.js:1828:13\n@chrome://mochitests/content/browser/devtools/client/webreplay/mochitest/browser_dbg_rr_console_warp-01.js:13:25\nAsync*Tester_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-10-03T00:29:54.524Z] 00:29:54 INFO - GECKO(1680) | [ReplayControl 8.56] ManifestFinished #1 {"point":{"checkpoint":4,"progress":23,"position":{"kind":"OnStep","script":3,"offset":579,"frameIndex":0}}}
[task 2019-10-03T00:29:54.525Z] 00:29:54 INFO - GECKO(1680) | [ReplayControl 8.56] SendManifest #1 {"kind":"runToPoint","endpoint":{"checkpoint":17,"progress":49},"snapshotPoints":[{"checkpoint":17,"progress":49}]}
[task 2019-10-03T00:29:55.227Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.32] ManifestFinished #1 {"point":{"checkpoint":17,"progress":49}}
[task 2019-10-03T00:29:55.227Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.32] SetPauseState PAUSED {"checkpoint":17,"progress":49} #1
[task 2019-10-03T00:29:55.227Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.32] SendManifest #1 {"kind":"batchDebuggerRequest","requests":[{"type":"getFrame","index":-1}]}
[task 2019-10-03T00:29:55.227Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.32] ManifestFinished #1 {"divergedFromRecording":false}
[task 2019-10-03T00:29:55.227Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.32] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getFixedObjects"}}
[task 2019-10-03T00:29:55.228Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] ManifestFinished #1 {"response":{"window":1,"document":2,"Services":3,"InspectorUtils":4},"divergedFromRecording":true}
[task 2019-10-03T00:29:55.228Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getObject","id":1}}
[task 2019-10-03T00:29:55.228Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] ManifestFinished #1 {"response":{"id":1,"kind":"Object","callable":false,"proto":5,"class":"Window","script":0,"environment":0,"isProxy":false,"isExtensible":true,"isSealed":false,"isFrozen":false},"divergedFromRecording":true}
[task 2019-10-03T00:29:55.228Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getObject","id":2}}
[task 2019-10-03T00:29:55.228Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] ManifestFinished #1 {"response":{"id":2,"kind":"Object","callable":false,"proto":6,"class":"HTMLDocument","script":0,"environment":0,"isProxy":false,"isExtensible":true,"isSealed":false,"isFrozen":false},"divergedFromRecording":true}
[task 2019-10-03T00:29:55.229Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getObject","id":3}}
[task 2019-10-03T00:29:55.229Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] ManifestFinished #1 {"response":{"id":3,"kind":"Object","callable":false,"proto":7,"class":"Object","script":0,"environment":0,"isProxy":false,"isExtensible":true,"isSealed":false,"isFrozen":false},"divergedFromRecording":true}
[task 2019-10-03T00:29:55.229Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getObject","id":4}}
[task 2019-10-03T00:29:55.229Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] ManifestFinished #1 {"response":{"id":4,"kind":"Object","callable":false,"proto":8,"class":"Object","script":0,"environment":0,"isProxy":false,"isExtensible":true,"isSealed":false,"isFrozen":false},"divergedFromRecording":true}
[task 2019-10-03T00:29:55.229Z] 00:29:55 INFO - GECKO(1680) | [ReplayControl 9.33] SendManifest #1 {"kind":"debuggerRequest","request":{"type":"getObjectProperties","id":1}}
[task 2019-10-03T00:29:55.340Z] 00:29:55 INFO - Removing tab.
[task 2019-10-03T00:29:55.340Z] 00:29:55 INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2019-10-03T00:29:55.340Z] 00:29:55 INFO - Got event: 'TabClose' on [object XULElement].
[task 2019-10-03T00:29:55.349Z] 00:29:55 INFO - Tab removed and finished closing

Comment 1

[Cristina Coroiu [:ccoroiu]]

Started to perma fail with this fix:
https://hg.mozilla.org/integration/autoland/rev/94eaa02e0ea1

https://treeherder.mozilla.org/#/jobs?repo=autoland&fromchange=20b68b99a4d25a0c8886787b1b572568035a84a5&searchStr=os%2Cx%2C10.14%2Cshippable%2Copt%2Cmochitests%2Ctest-macosx1014-64-shippable%2Fopt-mochitest-devtools-webreplay-e10s%2Cm%28dt-wr%29&selectedJob=269538821

Brian, can you please take a look at this too? Thank you!

Comment 2

[Brian Hackett [Laid off!]]

Attachment: Bug 1585860 - Fix console warping console menu item, r=jlast.

Comment 3

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/eec117b84631
Fix console warping console menu item, r=nchevobbe.

Comment 4

[Noemi Erli[:noemi_erli]]

https://hg.mozilla.org/mozilla-central/rev/eec117b84631

Comment 5

[Intermittent Failures Robot]

40 failures in 824 pushes (0.049 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 37
• mozilla-central: 2
• mozilla-inbound: 1

Platform breakdown:

• macosx1014-64-shippable: 40

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585860&startday=2019-10-03&endday=2019-10-03&tree=all

Comment 6

[Intermittent Failures Robot]

52 failures in 4292 pushes (0.012 failures/push) were associated with this bug in the last 7 days.

This is the #22 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 49
• mozilla-central: 2
• mozilla-inbound: 1

Platform breakdown:

• macosx1014-64-shippable: 52

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1585860&startday=2019-09-30&endday=2019-10-06&tree=all