1667910 - Intermittent layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_move_cursor_to_front_by_dragging_caret_to_front_input | KeyError: '0'

Status: RESOLVED INCOMPLETE

(Core :: Layout, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: btara [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=316959100&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/b_GZwUB7Q1in25344_OfRw/runs/0/artifacts/public/logs/live_backing.log

---

[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159003 Marionette DEBUG 23 -> [0,43,"Marionette:SingleTap",{"y":11,"x":64.14999389648438,"id":"5376656c-f9d8-0f4d-b649-043c9a0cff98"}]
[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159004 Marionette DEBUG Emitting mousemove mouse event at coordinates (72.14999389648438, 29) relative to the viewport, button: undefined, clickCount: undefined
[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159005 Marionette DEBUG Emitting mousedown mouse event at coordinates (72.14999389648438, 29) relative to the viewport, button: undefined, clickCount: undefined
[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159005 Marionette DEBUG Emitting mouseup mouse event at coordinates (72.14999389648438, 29) relative to the viewport, button: undefined, clickCount: undefined
[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159007 Marionette DEBUG 23 <- [1,43,null,{"value":null}]
[task 2020-09-28T23:35:59.056Z] 23:35:59 INFO - 1601336159008 Marionette DEBUG 23 -> [0,44,"WebDriver:GetElementTagName",{"id":"5376656c-f9d8-0f4d-b649-043c9a0cff98"}]
[task 2020-09-28T23:35:59.057Z] 23:35:59 INFO - 1601336159009 Marionette DEBUG 23 <- [1,44,null,{"value":"input"}]
[task 2020-09-28T23:35:59.057Z] 23:35:59 INFO - 1601336159010 Marionette DEBUG 23 -> [0,45,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","newSandbox":true, ... c-f9d8-0f4d-b649-043c9a0cff98"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":167}]
[task 2020-09-28T23:35:59.057Z] 23:35:59 INFO - 1601336159012 Marionette DEBUG 23 <- [1,45,null,{"value":1}]
[task 2020-09-28T23:35:59.057Z] 23:35:59 INFO - 1601336159012 Marionette DEBUG 23 -> [0,46,"WebDriver:GetElementTagName",{"id":"5376656c-f9d8-0f4d-b649-043c9a0cff98"}]
[task 2020-09-28T23:35:59.101Z] 23:35:59 INFO - 1601336159093 Marionette DEBUG 23 <- [1,46,null,{"value":"input"}]
[task 2020-09-28T23:35:59.101Z] 23:35:59 INFO - 1601336159094 Marionette DEBUG 23 -> [0,47,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects(); ... c-f9d8-0f4d-b649-043c9a0cff98"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":160}]
[task 2020-09-28T23:35:59.108Z] 23:35:59 INFO - 1601336159100 Marionette DEBUG 23 <- [1,47,null,{"value":{"item":{},"length":0}}]
[task 2020-09-28T23:35:59.109Z] 23:35:59 INFO - 1601336159102 Marionette DEBUG 23 -> [0,48,"WebDriver:GetElementTagName",{"id":"5376656c-f9d8-0f4d-b649-043c9a0cff98"}]
[task 2020-09-28T23:35:59.109Z] 23:35:59 INFO - 1601336159102 Marionette DEBUG 23 <- [1,48,null,{"value":"input"}]
[task 2020-09-28T23:35:59.109Z] 23:35:59 INFO - 1601336159103 Marionette DEBUG 23 -> [0,49,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects(); ... c-f9d8-0f4d-b649-043c9a0cff98"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":160}]
[task 2020-09-28T23:35:59.111Z] 23:35:59 INFO - 1601336159109 Marionette DEBUG 23 <- [1,49,null,{"value":{"0":{"x":72.14999389648438,"y":22,"width":0,"height":14,"top":22,"right":72.14999389648438,"bottom":36,"left":72.14999389648438},"item":{},"length":1}}]
[task 2020-09-28T23:35:59.115Z] 23:35:59 INFO - 1601336159111 Marionette DEBUG 23 -> [0,50,"Marionette:GetContext",{}]
[task 2020-09-28T23:35:59.115Z] 23:35:59 INFO - 1601336159111 Marionette DEBUG 23 <- [1,50,null,{"value":"content"}]
[task 2020-09-28T23:35:59.115Z] 23:35:59 INFO - 1601336159112 Marionette DEBUG 23 -> [0,51,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-09-28T23:35:59.115Z] 23:35:59 INFO - 1601336159112 Marionette DEBUG 23 <- [1,51,null,{"value":null}]
[task 2020-09-28T23:35:59.117Z] 23:35:59 INFO - 1601336159114 Marionette DEBUG 23 -> [0,52,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2020-09-28T23:35:59.198Z] 23:35:59 INFO - 1601336159196 Marionette DEBUG 23 <- [1,52,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQmCAYAAABvZhJoAAAgAElEQVR4nOzdeVRU9/0+8PvP95xfv+18u5iQjTYNbUi0DW1sTNMaG5PW ... OAAAAAADAmAAEAAABgTAACAAAAwJgABAAAAIAxAQgAAAAAYwIQAAAAAMYEIAAAAACMCUAAAAAAGBOAAAAAADAmAAEAAABgLMshEa8TOp4nAAAAAElFTkSuQmCC"}]
[task 2020-09-28T23:35:59.202Z] 23:35:59 INFO - 1601336159198 Marionette DEBUG 23 -> [0,53,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-28T23:35:59.202Z] 23:35:59 INFO - 1601336159198 Marionette DEBUG 23 <- [1,53,null,{"value":null}]
[task 2020-09-28T23:35:59.202Z] 23:35:59 INFO - 1601336159198 Marionette DEBUG 23 -> [0,54,"Marionette:GetContext",{}]
[task 2020-09-28T23:35:59.202Z] 23:35:59 INFO - 1601336159199 Marionette DEBUG 23 <- [1,54,null,{"value":"content"}]
[task 2020-09-28T23:35:59.203Z] 23:35:59 INFO - 1601336159199 Marionette DEBUG 23 -> [0,55,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-28T23:35:59.203Z] 23:35:59 INFO - 1601336159199 Marionette DEBUG 23 <- [1,55,null,{"value":null}]
[task 2020-09-28T23:35:59.203Z] 23:35:59 INFO - 1601336159200 Marionette DEBUG 23 -> [0,56,"WebDriver:GetPageSource",{}]
[task 2020-09-28T23:35:59.203Z] 23:35:59 INFO - 1601336159200 Marionette DEBUG 23 <- [1,56,null,{"value":"<html id="html"><head>\n <title>Marionette tests for AccessibleCaret in cursor mode</title>\n <s ... \n <br>\n <div class="block" id="contenteditable" contenteditable="true">ABCDEFGHI</div>\n \n\n</body></html>"}]
[task 2020-09-28T23:35:59.207Z] 23:35:59 INFO - 1601336159201 Marionette DEBUG 23 -> [0,57,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-28T23:35:59.207Z] 23:35:59 INFO - 1601336159201 Marionette DEBUG 23 <- [1,57,null,{"value":null}]
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - TEST-UNEXPECTED-ERROR | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_move_cursor_to_front_by_dragging_caret_to_front_input | KeyError: '0'
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - Traceback (most recent call last):
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 196, in run
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - testMethod()
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 65, in wrapper
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - return func(self, *args, **kwargs)
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/tests/marionette/tests/layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py", line 134, in test_move_cursor_to_front_by_dragging_caret_to_front
[task 2020-09-28T23:35:59.244Z] 23:35:59 INFO - src_x, src_y = sel.first_caret_location()
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 247, in first_caret_location
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - return self.carets_location()[0]
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 229, in carets_location
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - return self._selection_location_helper('caret')
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - File "/Users/cltbld/tasks/task_1601332409/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 182, in _selection_location_helper
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - first_rect, last_rect = first_rect_list['0'], last_rect_list[str(last_list_length - 1)]
[task 2020-09-28T23:35:59.245Z] 23:35:59 INFO - TEST-INFO took 527ms

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• macosx1014-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1667910&startday=2020-09-28&endday=2020-10-04&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• mozilla-central: 1

Platform breakdown:

• macosx1014-64: 1
• macosx1014-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1667910&startday=2020-10-05&endday=2020-10-11&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• macosx1014-64-shippable: 1

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 2

Platform breakdown:

• macosx1014-64-devedition: 1
• macosx1014-64-shippable: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1667910&startday=2020-10-19&endday=2020-10-25&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 2
• mozilla-beta: 3
• try: 1

Platform breakdown:

• macosx1014-64-shippable: 5
• macosx1014-64-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1667910&startday=2020-10-26&endday=2020-11-01&tree=all

Comment 6

[Intermittent Failures Robot]

12 failures in 4128 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10
• try: 2

Platform breakdown:

• macosx1014-64-qr: 10
• macosx1014-64-devedition-qr: 1
• macosx1014-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1667910&startday=2020-11-02&endday=2020-11-08&tree=all

Comment 7

[Andreea Pavel [:apavel]]

Hi Henrik, some of the recent failures here have KeyError: '-1' instead of 0, should we file a new bug or update the summary here?

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=321422811&repo=autoland&lineNumber=42975

[task 2020-11-11T08:09:05.874Z] 08:09:05 INFO - TEST-START | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_move_cursor_to_front_by_dragging_caret_to_front_input
[task 2020-11-11T08:09:05.874Z] 08:09:05 INFO - 1605082145846 Marionette DEBUG Closed connection 20
[task 2020-11-11T08:09:05.874Z] 08:09:05 INFO - 1605082145847 Marionette DEBUG Accepted connection 21 from 127.0.0.1:53114
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145848 Marionette DEBUG 21 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145849 Marionette TRACE [16] Frame script loaded
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145850 Marionette DEBUG 21 <- [1,1,null,{"sessionId":"e07db497-a659-8545-8825-d8a279f1f89c","capabilities":{"browserName":"firefox","browserVersion":"84.0a ... /T/tmptdJXYr.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145871 Marionette DEBUG 21 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145871 Marionette DEBUG 21 <- [1,2,null,{"value":null}]
[task 2020-11-11T08:09:05.875Z] 08:09:05 INFO - 1605082145872 Marionette DEBUG 21 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2020-11-11T08:09:05.876Z] 08:09:05 INFO - 1605082145872 Marionette DEBUG 21 <- [1,3,null,{"value":null}]
[task 2020-11-11T08:09:05.876Z] 08:09:05 INFO - 1605082145873 Marionette DEBUG 21 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2020-11-11T08:09:05.876Z] 08:09:05 INFO - 1605082145873 Marionette DEBUG 21 <- [1,4,null,{"value":null}]
[task 2020-11-11T08:09:05.878Z] 08:09:05 INFO - 1605082145874 Marionette DEBUG 21 -> [0,5,"Marionette:GetContext",{}]
[task 2020-11-11T08:09:05.878Z] 08:09:05 INFO - 1605082145874 Marionette DEBUG 21 <- [1,5,null,{"value":"content"}]
[task 2020-11-11T08:09:05.878Z] 08:09:05 INFO - 1605082145875 Marionette DEBUG 21 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-11-11T08:09:05.880Z] 08:09:05 INFO - 1605082145875 Marionette DEBUG 21 <- [1,6,null,{"value":null}]
[task 2020-11-11T08:09:05.880Z] 08:09:05 INFO - 1605082145876 Marionette DEBUG 21 -> [0,7,"WebDriver:ExecuteScript",{"script":"Components.utils.import("resource://gre/modules/Preferences.jsm");\n\n ... e,false],"filename":"../../venv/lib/python2.7/site-packages/marionette_driver/marionette.py","sandbox":"default","line":809}]
[task 2020-11-11T08:09:05.880Z] 08:09:05 INFO - 1605082145876 Marionette TRACE [14] MarionetteCommands actor created for window id 4
[task 2020-11-11T08:09:05.880Z] 08:09:05 INFO - 1605082145878 Marionette DEBUG 21 <- [1,7,null,{"value":null}]
[task 2020-11-11T08:09:05.885Z] 08:09:05 INFO - 1605082145878 Marionette DEBUG 21 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2020-11-11T08:09:05.885Z] 08:09:05 INFO - 1605082145879 Marionette DEBUG 21 <- [1,8,null,{"value":null}]
[task 2020-11-11T08:09:05.885Z] 08:09:05 INFO - 1605082145879 Marionette DEBUG 21 -> [0,9,"Marionette:GetContext",{}]
[task 2020-11-11T08:09:05.885Z] 08:09:05 INFO - 1605082145879 Marionette DEBUG 21 <- [1,9,null,{"value":"content"}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145880 Marionette DEBUG 21 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145880 Marionette DEBUG 21 <- [1,10,null,{"value":null}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145881 Marionette DEBUG 21 -> [0,11,"WebDriver:ExecuteScript",{"script":"Components.utils.import("resource://gre/modules/Preferences.jsm");\n\n ... e,false],"filename":"../../venv/lib/python2.7/site-packages/marionette_driver/marionette.py","sandbox":"default","line":809}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145882 Marionette DEBUG 21 <- [1,11,null,{"value":null}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145883 Marionette DEBUG 21 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145883 Marionette DEBUG 21 <- [1,12,null,{"value":null}]
[task 2020-11-11T08:09:05.886Z] 08:09:05 INFO - 1605082145884 Marionette DEBUG 21 -> [0,13,"WebDriver:Navigate",{"url":"http://127.0.0.1:50063/layout/test_carets_cursor.html"}]

[task 2020-11-11T08:09:06.027Z] 08:09:06 INFO - DEBUG: Adding blocker UserInteractionTimer 16 for document 12089e000 for phase xpcom-will-shutdown
[task 2020-11-11T08:09:06.046Z] 08:09:06 INFO - 1605082146030 Marionette DEBUG 21 <- [1,17,null,{"value":null}]
[task 2020-11-11T08:09:06.047Z] 08:09:06 INFO - 1605082146034 Marionette DEBUG 21 -> [0,18,"WebDriver:GetElementTagName",{"id":"4d176903-1cd4-e74f-b8d9-d2b2466670d7"}]
[task 2020-11-11T08:09:06.047Z] 08:09:06 INFO - 1605082146041 Marionette DEBUG 21 <- [1,18,null,{"value":"input"}]
[task 2020-11-11T08:09:06.093Z] 08:09:06 INFO - 1605082146062 Marionette DEBUG 21 -> [0,19,"WebDriver:ExecuteScript",{"script":"arguments[0].setSelectionRange(0, 0);","newSandbox":true,"args":[{"element-6066-11 ... 76903-1cd4-e74f-b8d9-d2b2466670d7"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":null,"line":142}]
[task 2020-11-11T08:09:06.093Z] 08:09:06 INFO - 1605082146085 Marionette DEBUG 21 <- [1,19,null,{"value":null}]
[task 2020-11-11T08:09:06.123Z] 08:09:06 INFO - 1605082146106 Marionette DEBUG 21 -> [0,20,"WebDriver:GetElementTagName",{"id":"4d176903-1cd4-e74f-b8d9-d2b2466670d7"}]
[task 2020-11-11T08:09:06.189Z] 08:09:06 INFO - 1605082146128 Marionette DEBUG 21 <- [1,20,null,{"value":"input"}]
[task 2020-11-11T08:09:06.189Z] 08:09:06 INFO - 1605082146149 Marionette DEBUG 21 -> [0,21,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","newSandbox":true, ... 3-1cd4-e74f-b8d9-d2b2466670d7"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":178}]
[task 2020-11-11T08:09:06.189Z] 08:09:06 INFO - 1605082146173 Marionette DEBUG 21 <- [1,21,null,{"value":1}]
[task 2020-11-11T08:09:06.218Z] 08:09:06 INFO - 1605082146194 Marionette DEBUG 21 -> [0,22,"WebDriver:GetElementTagName",{"id":"4d176903-1cd4-e74f-b8d9-d2b2466670d7"}]
[task 2020-11-11T08:09:06.218Z] 08:09:06 INFO - 1605082146216 Marionette DEBUG 21 <- [1,22,null,{"value":"input"}]
[task 2020-11-11T08:09:06.241Z] 08:09:06 INFO - 1605082146237 Marionette DEBUG 21 -> [0,23,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects(); ... 3-1cd4-e74f-b8d9-d2b2466670d7"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":171}]
[task 2020-11-11T08:09:06.250Z] 08:09:06 INFO - 1605082146240 Marionette DEBUG 21 <- [1,23,null,{"value":{"0":{"x":12,"y":22,"width":0,"height":14,"top":22,"right":12,"bottom":36,"left":12},"item":{},"length":1}}]
[task 2020-11-11T08:09:06.283Z] 08:09:06 INFO - 1605082146261 Marionette DEBUG 21 -> [0,24,"WebDriver:GetElementTagName",{"id":"4d176903-1cd4-e74f-b8d9-d2b2466670d7"}]
[task 2020-11-11T08:09:06.294Z] 08:09:06 INFO - 1605082146283 Marionette DEBUG 21 <- [1,24,null,{"value":"input"}]
[task 2020-11-11T08:09:06.304Z] 08:09:06 INFO - 1605082146294 Marionette DEBUG 21 -> [0,25,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects(); ... 3-1cd4-e74f-b8d9-d2b2466670d7"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":171}]
[task 2020-11-11T08:09:06.304Z] 08:09:06 INFO - 1605082146302 Marionette DEBUG 21 <- [1,25,null,{"value":{"item":{},"length":0}}]
[task 2020-11-11T08:09:06.308Z] 08:09:06 INFO - 1605082146303 Marionette DEBUG 21 -> [0,26,"Marionette:GetContext",{}]
[task 2020-11-11T08:09:06.308Z] 08:09:06 INFO - 1605082146303 Marionette DEBUG 21 <- [1,26,null,{"value":"content"}]
[task 2020-11-11T08:09:06.315Z] 08:09:06 INFO - 1605082146304 Marionette DEBUG 21 -> [0,27,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-11-11T08:09:06.315Z] 08:09:06 INFO - 1605082146304 Marionette DEBUG 21 <- [1,27,null,{"value":null}]
[task 2020-11-11T08:09:06.315Z] 08:09:06 INFO - 1605082146304 Marionette DEBUG 21 -> [0,28,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146384 Marionette DEBUG 21 <- [1,28,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAPpCAYAAABKf4CHAAAgAElEQVR4nOzdeVhU970/8PPPfZ57bzvdYjALTVrSkuptSGNjfmmtqaa1 ... ACAAAAwJgABAAAAIAxAQgAAAAAYwIQAAAAAMYEIAAAAACMCUAAAAAAGBOAAAAAADAmAAEAAABgTAACAAAAwJgABAAAAICxAFWrMwgHCqvQAAAAAElFTkSuQmCC"}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146387 Marionette DEBUG 21 -> [0,29,"Marionette:SetContext",{"value":"content"}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146387 Marionette DEBUG 21 <- [1,29,null,{"value":null}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146388 Marionette DEBUG 21 -> [0,30,"Marionette:GetContext",{}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146388 Marionette DEBUG 21 <- [1,30,null,{"value":"content"}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146389 Marionette DEBUG 21 -> [0,31,"Marionette:SetContext",{"value":"content"}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146389 Marionette DEBUG 21 <- [1,31,null,{"value":null}]
[task 2020-11-11T08:09:06.401Z] 08:09:06 INFO - 1605082146390 Marionette DEBUG 21 -> [0,32,"WebDriver:GetPageSource",{}]
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - TEST-UNEXPECTED-ERROR | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_move_cursor_to_front_by_dragging_caret_to_front_input | KeyError: '-1'
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - Traceback (most recent call last):
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 214, in run
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - testMethod()
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 64, in wrapper
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - return func(self, *args, **kwargs)
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/tests/marionette/tests/layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py", line 129, in test_move_cursor_to_front_by_dragging_caret_to_front
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - dest_x, dest_y = sel.first_caret_location()
[task 2020-11-11T08:09:06.424Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 262, in first_caret_location
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - return self.carets_location()[0]
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 244, in carets_location
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - return self._selection_location_helper("caret")
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - File "/Users/cltbld/tasks/task_1605081387/build/tests/marionette/tests/layout/base/tests/marionette/selection.py", line 196, in _selection_location_helper
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - last_rect_list[str(last_list_length - 1)],
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - TEST-INFO took 547ms
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - 1605082146391 Marionette DEBUG 21 <- [1,32,null,{"value":"<html id="html"><head>\n <title>Marionette tests for AccessibleCaret in cursor mode</title>\n <s ... \n <br>\n <div class="block" id="contenteditable" contenteditable="true">ABCDEFGHI</div>\n \n\n</body></html>"}]
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - 1605082146391 Marionette DEBUG 21 -> [0,33,"Marionette:SetContext",{"value":"content"}]
[task 2020-11-11T08:09:06.425Z] 08:09:06 INFO - 1605082146392 Marionette DEBUG 21 <- [1,33,null,{"value":null}]
[task 2020-11-11T08:09:06.426Z] 08:09:06 INFO - 1605082146393 Marionette DEBUG 21 -> [0,34,"WebDriver:ReleaseActions",{}]
[task 2020-11-11T08:09:06.426Z] 08:09:06 INFO - 1605082146394 Marionette DEBUG 21 <- [1,34,null,{"value":null}]
[task 2020-11-11T08:09:06.427Z] 08:09:06 INFO - 1605082146396 Marionette DEBUG 21 -> [0,35,"WebDriver:DeleteSession",{}]
[task 2020-11-11T08:09:06.427Z] 08:09:06 INFO - 1605082146397 Marionette DEBUG 21 <- [1,35,null,{"value":null}]

Comment 8

[Henrik Skupin [:whimboo][⌚️UTC+2]]

(In reply to Andreea Pavel [:apavel] from comment #7)

Hi Henrik, some of the recent failures here have KeyError: '-1' instead of 0, should we file a new bug or update the summary here?

I don't know. Note that this is a test under layout, so someone from that team should be able to give you that answer. Sean, can you please have a look or forward it? Thanks.

Comment 9

[Henrik Skupin [:whimboo][⌚️UTC+2]]

Oh and note that this failure mostly only happens with the framescript implementation in Marionette, but way lesser since the JSWindowActor implementation is the default one.

Comment 10

[Intermittent Failures Robot]

27 failures in 4040 pushes (0.007 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• try: 4
• autoland: 23

Platform breakdown:

• macosx1014-64-devedition-qr: 3
• macosx1014-64-qr: 22
• linux1804-64: 1
• macosx1014-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-11-09&endday=2020-11-15&tree=all

Comment 11

[Henrik Skupin [:whimboo][⌚️UTC+2]]

For the failing case WebDriver:ExecuteScript returns the following:

[task 2020-11-15T14:30:39.747Z] 14:30:39     INFO -  1605450639743	Marionette	DEBUG	21 -> [0,29,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects(); ... a-dc47-1e4a-a08d-e71a9191dc12"}],"filename":"tests/layout/base/tests/marionette/selection.py","sandbox":"system","line":171}]
[task 2020-11-15T14:30:39.782Z] 14:30:39     INFO -  1605450639746	Marionette	DEBUG	21 <- [1,29,null,{"value":{"0":{"x":12,"y":22,"width":0,"height":14,"top":22,"right":12,"bottom":36,"left":12},"item":{},"length":1}}]

The Marionette layout test fails here:
https://searchfox.org/mozilla-central/rev/c37038c592a352eda0f5e77dfb58c4929bf8bcd3/layout/base/tests/marionette/selection.py#194-197

I can't actually see why that should fail given that there is clearly 0 returned that seems to get accessed here.

Ting, could you help here?

Comment 12

[Intermittent Failures Robot]

18 failures in 4810 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 10
• mozilla-central: 3
• try: 3
• mozilla-beta: 2

Platform breakdown:

• macosx1014-64-qr: 12
• macosx1014-64-shippable-qr: 4
• macosx1014-64-devedition-qr: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-11-16&endday=2020-11-22&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform breakdown:

• macosx1014-64-qr: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-11-23&endday=2020-11-29&tree=all

Comment 14

[Ting-Yu Lin [:TYLin] (PDT, UTC-7)]

The Marionette layout test fails here:
https://searchfox.org/mozilla-central/rev/c37038c592a352eda0f5e77dfb58c4929bf8bcd3/layout/base/tests/marionette/selection.py#194-197

I can't actually see why that should fail given that there is clearly 0 returned that seems to get accessed here.

I take a look at various intermittent bugs by searching test_accessiblecaret_. Most of them are on macOS, and are failed because window.getSelection().rangeCount returns 0. The test are expecting the rangeCount is 1 or 2. I don't know why it would fail ...

It would be great if we have a more robust way to interact with Selection object in marionette.

For now, I'm thinking about maybe we could throw an exception from selection.py if there's no range object from layout. In this way, we could condense all the intermittent bugs into just one.

Comment 15

[Henrik Skupin [:whimboo][⌚️UTC+2]]

(In reply to Ting-Yu Lin [:TYLin] (UTC-8) from comment #14)

It would be great if we have a more robust way to interact with Selection object in marionette.

What would you have in mind?

For now, I'm thinking about maybe we could throw an exception from selection.py if there's no range object from layout. In this way, we could condense all the intermittent bugs into just one.

That would be good.

Comment 16

[Intermittent Failures Robot]

8 failures in 3712 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 6
• try: 1
• mozilla-central: 1

Platform breakdown:

• macosx1014-64-qr: 7
• macosx1014-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-11-30&endday=2020-12-06&tree=all

Comment 17

[Ting-Yu Lin [:TYLin] (PDT, UTC-7)]

(In reply to Henrik Skupin (:whimboo) [⌚️UTC+2] (away 12/07 - 12/11) from comment #15)

(In reply to Ting-Yu Lin [:TYLin] (UTC-8) from comment #14)

It would be great if we have a more robust way to interact with Selection object in marionette.

What would you have in mind?

I don't have anything particular though. Anyway, I filed bug 1681402 to improve the API that has intermittents.

Comment 18

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 5

Platform breakdown:

• macosx1014-64-qr: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-12-07&endday=2020-12-13&tree=all

Comment 19

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3
• mozilla-beta: 1

Platform breakdown:

• macosx1014-64-qr: 3
• macosx1014-64-devedition-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2020-12-14&endday=2020-12-20&tree=all

Comment 20

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 2

Platform breakdown:

• macosx1014-64-devedition-qr: 1
• macosx1014-64-shippable-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1667910&startday=2021-01-04&endday=2021-01-10&tree=all

Comment 21

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.