1809686 - Intermittent layout/base/tests/marionette/test_accessiblecaret_selection_mode.py | single tracking bug

Status: RESOLVED DUPLICATE of bug 1855083

(Core :: Layout, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-01-11T15:42:56.071Z] 15:42:56     INFO -  TEST-START | layout/base/tests/marionette/test_accessiblecaret_selection_mode.py AccessibleCaretSelectionModeTestCase.test_minimum_select_one_character_textarea_disabled
[task 2023-01-11T15:42:56.270Z] 15:42:56     INFO -  1673451776271	Marionette	DEBUG	Accepted connection 80 from 127.0.0.1:52416
[task 2023-01-11T15:42:56.285Z] 15:42:56     INFO -  1673451776285	Marionette	DEBUG	80 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2023-01-11T15:42:56.287Z] 15:42:56     INFO -  1673451776286	Marionette	DEBUG	Waiting for initial application window
[task 2023-01-11T15:42:56.289Z] 15:42:56     INFO -  1673451776288	RemoteAgent	TRACE	[23] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=1600 waitForExplicitStart=false
[task 2023-01-11T15:42:56.289Z] 15:42:56     INFO -  1673451776289	RemoteAgent	TRACE	[23] ProgressListener Setting unload timer (1600ms)
[task 2023-01-11T15:42:56.289Z] 15:42:56     INFO -  1673451776289	RemoteAgent	TRACE	[23] Document already finished loading: http://127.0.0.1:49911/layout/test_carets_selection.html
[task 2023-01-11T15:42:56.290Z] 15:42:56     INFO -  1673451776289	RemoteAgent	TRACE	[23] ProgressListener Stop: has error=false
[task 2023-01-11T15:42:56.293Z] 15:42:56     INFO -  1673451776292	Marionette	DEBUG	80 <- [1,1,null,{"sessionId":"efa17d25-1b2a-481a-a1e0-8e172fc758bf","capabilities":{"browserName":"firefox","browserVersion":"110.0a1","platformName":"windows","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","moz:accessibilityChecks":false,"moz:buildID":"20230111144842","moz:headless":false,"moz:platformVersion":"10.0","moz:processID":2464,"moz:profile":"C:\\Users\\task_167344687073692\\AppData\\Local\\Temp\\tmpun2fvur7.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2023-01-11T15:42:56.298Z] 15:42:56     INFO -  1673451776297	Marionette	DEBUG	80 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2023-01-11T15:42:56.298Z] 15:42:56     INFO -  1673451776298	Marionette	DEBUG	80 <- [1,2,null,{"value":null}]
[task 2023-01-11T15:42:56.300Z] 15:42:56     INFO -  1673451776300	Marionette	DEBUG	80 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2023-01-11T15:42:56.301Z] 15:42:56     INFO -  1673451776301	Marionette	DEBUG	80 <- [1,3,null,{"value":null}]
[task 2023-01-11T15:42:56.302Z] 15:42:56     INFO -  1673451776302	Marionette	DEBUG	80 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2023-01-11T15:42:56.303Z] 15:42:56     INFO -  1673451776303	Marionette	DEBUG	80 <- [1,4,null,{"value":null}]
[task 2023-01-11T15:42:56.305Z] 15:42:56     INFO -  1673451776305	Marionette	DEBUG	80 -> [0,5,"Marionette:GetContext",{}]
[task 2023-01-11T15:42:56.306Z] 15:42:56     INFO -  1673451776306	Marionette	DEBUG	80 <- [1,5,null,{"value":"content"}]
[task 2023-01-11T15:42:56.307Z] 15:42:56     INFO -  1673451776307	Marionette	DEBUG	80 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-01-11T15:42:56.308Z] 15:42:56     INFO -  1673451776308	Marionette	DEBUG	80 <- [1,6,null,{"value":null}]
[task 2023-01-11T15:42:56.311Z] 15:42:56     INFO -  1673451776310	Marionette	DEBUG	80 -> [0,7,"WebDriver:ExecuteScript",{"script":"const { Preferences } = ChromeUtils.importESModule(\n                  \"resource://gre/modules/Preferences.sys.mjs\"\n           ... guments[2];\n\n                prefs = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","args":["layout.word_select.eat_space_to_next_word",false,false],"newSandbox":true,"sandbox":"default","line":831,"filename":"Z:\\task_167344687073692\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2023-01-11T15:42:56.312Z] 15:42:56     INFO -  1673451776312	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 2464
[task 2023-01-11T15:42:56.312Z] 15:42:56     INFO -  1673451776313	Marionette	TRACE	[1] MarionetteCommands actor created for window id 2
[task 2023-01-11T15:42:56.318Z] 15:42:56     INFO -  1673451776317	Marionette	DEBUG	80 <- [1,7,null,{"value":null}]
[task 2023-01-11T15:42:56.319Z] 15:42:56     INFO -  1673451776319	Marionette	DEBUG	80 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:56.319Z] 15:42:56     INFO -  1673451776319	Marionette	DEBUG	80 <- [1,8,null,{"value":null}]
[task 2023-01-11T15:42:56.320Z] 15:42:56     INFO -  1673451776320	Marionette	DEBUG	80 -> [0,9,"Marionette:GetContext",{}]
[task 2023-01-11T15:42:56.320Z] 15:42:56     INFO -  1673451776321	Marionette	DEBUG	80 <- [1,9,null,{"value":"content"}]
[task 2023-01-11T15:42:56.322Z] 15:42:56     INFO -  1673451776322	Marionette	DEBUG	80 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-01-11T15:42:56.322Z] 15:42:56     INFO -  1673451776322	Marionette	DEBUG	80 <- [1,10,null,{"value":null}]
[task 2023-01-11T15:42:56.323Z] 15:42:56     INFO -  1673451776324	Marionette	DEBUG	80 -> [0,11,"WebDriver:ExecuteScript",{"script":"const { Preferences } = ChromeUtils.importESModule(\n                  \"resource://gre/modules/Preferences.sys.mjs\"\n           ... guments[2];\n\n                prefs = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","args":["layout.accessiblecaret.enabled",true,false],"newSandbox":true,"sandbox":"default","line":831,"filename":"Z:\\task_167344687073692\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2023-01-11T15:42:56.330Z] 15:42:56     INFO -  1673451776329	Marionette	DEBUG	80 <- [1,11,null,{"value":null}]
[task 2023-01-11T15:42:56.331Z] 15:42:56     INFO -  1673451776331	Marionette	DEBUG	80 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:56.331Z] 15:42:56     INFO -  1673451776331	Marionette	DEBUG	80 <- [1,12,null,{"value":null}]
[task 2023-01-11T15:42:56.332Z] 15:42:56     INFO -  1673451776332	Marionette	DEBUG	80 -> [0,13,"Marionette:GetContext",{}]
[task 2023-01-11T15:42:56.333Z] 15:42:56     INFO -  1673451776332	Marionette	DEBUG	80 <- [1,13,null,{"value":"content"}]
[task 2023-01-11T15:42:56.334Z] 15:42:56     INFO -  1673451776333	Marionette	DEBUG	80 -> [0,14,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-01-11T15:42:56.334Z] 15:42:56     INFO -  1673451776334	Marionette	DEBUG	80 <- [1,14,null,{"value":null}]
[task 2023-01-11T15:42:56.334Z] 15:42:56     INFO -  1673451776335	Marionette	DEBUG	80 -> [0,15,"WebDriver:ExecuteScript",{"script":"const { Preferences } = ChromeUtils.importESModule(\n                  \"resource://gre/modules/Preferences.sys.mjs\"\n           ... guments[2];\n\n                prefs = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","args":["layout.accessiblecaret.transition-duration","0.0",false],"newSandbox":true,"sandbox":"default","line":831,"filename":"Z:\\task_167344687073692\\build\\venv\\lib\\site-packages\\marionette_driver\\marionette.py"}]
[task 2023-01-11T15:42:56.340Z] 15:42:56     INFO -  1673451776341	Marionette	DEBUG	80 <- [1,15,null,{"value":null}]
[task 2023-01-11T15:42:56.342Z] 15:42:56     INFO -  1673451776342	Marionette	DEBUG	80 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:56.343Z] 15:42:56     INFO -  1673451776342	Marionette	DEBUG	80 <- [1,16,null,{"value":null}]
[task 2023-01-11T15:42:56.343Z] 15:42:56     INFO -  1673451776344	Marionette	DEBUG	80 -> [0,17,"WebDriver:Navigate",{"url":"http://127.0.0.1:49911/layout/test_carets_selection.html"}]
[task 2023-01-11T15:42:56.344Z] 15:42:56     INFO -  [Parent 2464, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, false) failed with result 0x804B0051 (NS_ERROR_HOST_IS_IP_ADDRESS): file /builds/worker/checkouts/gecko/toolkit/components/antitracking/URLQueryStringStripper.cpp:150
[task 2023-01-11T15:42:56.347Z] 15:42:56     INFO -  1673451776349	Marionette	TRACE	[23] Received event beforeunload for http://127.0.0.1:49911/layout/test_carets_selection.html
[task 2023-01-11T15:42:56.383Z] 15:42:56     INFO -  1673451776384	Marionette	TRACE	[23] Received event pagehide for http://127.0.0.1:49911/layout/test_carets_selection.html
[task 2023-01-11T15:42:56.431Z] 15:42:56     INFO -  1673451776433	Marionette	TRACE	[23] Received event DOMContentLoaded for http://127.0.0.1:49911/layout/test_carets_selection.html
[task 2023-01-11T15:42:56.436Z] 15:42:56     INFO -  1673451776435	Marionette	TRACE	[23] Received event pageshow for http://127.0.0.1:49911/layout/test_carets_selection.html
[task 2023-01-11T15:42:56.437Z] 15:42:56     INFO -  1673451776437	Marionette	DEBUG	80 <- [1,17,null,{"value":null}]
[task 2023-01-11T15:42:56.448Z] 15:42:56     INFO -  1673451776449	Marionette	DEBUG	80 -> [0,18,"WebDriver:FindElement",{"value":"textarea-disabled","using":"id"}]
[task 2023-01-11T15:42:56.451Z] 15:42:56     INFO -  1673451776451	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 5744
[task 2023-01-11T15:42:56.452Z] 15:42:56     INFO -  1673451776451	Marionette	TRACE	[23] MarionetteCommands actor created for window id 6442451022
[task 2023-01-11T15:42:56.463Z] 15:42:56     INFO -  1673451776463	Marionette	DEBUG	80 <- [1,18,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}}]
[task 2023-01-11T15:42:56.465Z] 15:42:56     INFO -  1673451776465	Marionette	DEBUG	80 -> [0,19,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.468Z] 15:42:56     INFO -  1673451776467	Marionette	DEBUG	80 <- [1,19,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.469Z] 15:42:56     INFO -  1673451776468	Marionette	DEBUG	80 -> [0,20,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"value"}]
[task 2023-01-11T15:42:56.471Z] 15:42:56     INFO -  1673451776471	Marionette	DEBUG	80 <- [1,20,null,{"value":"ABC DEF GHI JKL MNO PQR"}]
[task 2023-01-11T15:42:56.472Z] 15:42:56     INFO -  1673451776472	Marionette	DEBUG	80 -> [0,21,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.474Z] 15:42:56     INFO -  1673451776474	Marionette	DEBUG	80 <- [1,21,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.477Z] 15:42:56     INFO -  1673451776476	Marionette	DEBUG	80 -> [0,22,"WebDriver:ExecuteScript",{"script":"var len = arguments[0].value.length;\n                  arguments[0].focus();\n                  arguments[0].setSelectionRange(0, len);","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":null,"line":317,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.483Z] 15:42:56     INFO -  1673451776483	Marionette	DEBUG	80 <- [1,22,null,{"value":null}]
[task 2023-01-11T15:42:56.488Z] 15:42:56     INFO -  1673451776486	Marionette	DEBUG	80 -> [0,23,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.490Z] 15:42:56     INFO -  DEBUG: Adding blocker Transaction (76) for phase protections.sqlite#0: waiting for clients
[task 2023-01-11T15:42:56.493Z] 15:42:56     INFO -  1673451776491	Marionette	DEBUG	80 <- [1,23,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.493Z] 15:42:56     INFO -  DEBUG: Completed blocker Transaction (76) for phase protections.sqlite#0: waiting for clients
[task 2023-01-11T15:42:56.496Z] 15:42:56     INFO -  1673451776495	Marionette	DEBUG	80 -> [0,24,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":175,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.500Z] 15:42:56     INFO -  1673451776500	Marionette	DEBUG	80 <- [1,24,null,{"value":1}]
[task 2023-01-11T15:42:56.501Z] 15:42:56     INFO -  1673451776501	Marionette	DEBUG	80 -> [0,25,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.503Z] 15:42:56     INFO -  1673451776504	Marionette	DEBUG	80 <- [1,25,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.505Z] 15:42:56     INFO -  1673451776505	Marionette	DEBUG	80 -> [0,26,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":168,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.510Z] 15:42:56     INFO -  1673451776512	Marionette	DEBUG	80 <- [1,26,null,{"value":{"0":{"x":97.01666259765625,"y":77.66667175292969,"width":56,"height":15,"top":77.66667175292969,"right":153.01666259765625,"bottom":92.66667175292969,"left":97.01666259765625},"1":{"x":97.01666259765625,"y":92.66667175292969,"width":56,"height":15,"top":92.66667175292969,"right":153.01666259765625,"bottom":107.66667175292969,"left":97.01666259765625},"2":{"x":97.01666259765625,"y":107.66667175292969,"width":49,"height":15,"top":107.66667175292969,"right":146.01666259765625,"bottom":122.66667175292969,"left":97.01666259765625},"item":{},"length":3}}]
[task 2023-01-11T15:42:56.514Z] 15:42:56     INFO -  1673451776513	Marionette	DEBUG	80 -> [0,27,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.515Z] 15:42:56     INFO -  1673451776516	Marionette	DEBUG	80 <- [1,27,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.518Z] 15:42:56     INFO -  1673451776518	Marionette	DEBUG	80 -> [0,28,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.520Z] 15:42:56     INFO -  1673451776520	Marionette	DEBUG	80 <- [1,28,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.521Z] 15:42:56     INFO -  1673451776522	Marionette	DEBUG	80 -> [0,29,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"dir"}]
[task 2023-01-11T15:42:56.523Z] 15:42:56     INFO -  1673451776524	Marionette	DEBUG	80 <- [1,29,null,{"value":""}]
[task 2023-01-11T15:42:56.525Z] 15:42:56     INFO -  1673451776525	Marionette	DEBUG	80 -> [0,30,"Marionette:SingleTap",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","x":null,"y":null}]
[task 2023-01-11T15:42:56.530Z] 15:42:56     INFO -  1673451776538	Marionette	DEBUG	Emitting mousemove mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.539Z] 15:42:56     INFO -  1673451776539	Marionette	DEBUG	Emitting mousedown mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.540Z] 15:42:56     INFO -  1673451776541	Marionette	DEBUG	Emitting mouseup mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.542Z] 15:42:56     INFO -  DEBUG: Adding blocker UserInteractionTimer 78 for document c1d0000 for phase xpcom-will-shutdown
[task 2023-01-11T15:42:56.545Z] 15:42:56     INFO -  1673451776545	Marionette	DEBUG	80 <- [1,30,null,{"value":null}]
[task 2023-01-11T15:42:56.546Z] 15:42:56     INFO -  1673451776546	Marionette	DEBUG	80 -> [0,31,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.547Z] 15:42:56     INFO -  1673451776548	Marionette	DEBUG	80 <- [1,31,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.549Z] 15:42:56     INFO -  1673451776550	Marionette	DEBUG	80 -> [0,32,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"value"}]
[task 2023-01-11T15:42:56.551Z] 15:42:56     INFO -  1673451776552	Marionette	DEBUG	80 <- [1,32,null,{"value":"ABC DEF GHI JKL MNO PQR"}]
[task 2023-01-11T15:42:56.553Z] 15:42:56     INFO -  1673451776554	Marionette	DEBUG	80 -> [0,33,"Marionette:SingleTap",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","x":null,"y":null}]
[task 2023-01-11T15:42:56.555Z] 15:42:56     INFO -  1673451776559	Marionette	DEBUG	Emitting mousemove mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.555Z] 15:42:56     INFO -  1673451776560	Marionette	DEBUG	Emitting mousedown mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.561Z] 15:42:56     INFO -  1673451776561	Marionette	DEBUG	Emitting mouseup mouse event at coordinates (133.5250015258789, 116.16667175292969) relative to the viewport, button: undefined, clickCount: undefined
[task 2023-01-11T15:42:56.562Z] 15:42:56     INFO -  1673451776566	Marionette	DEBUG	80 <- [1,33,null,{"value":null}]
[task 2023-01-11T15:42:56.568Z] 15:42:56     INFO -  1673451776568	Marionette	DEBUG	80 -> [0,34,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.569Z] 15:42:56     INFO -  1673451776570	Marionette	DEBUG	80 <- [1,34,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.571Z] 15:42:56     INFO -  1673451776572	Marionette	DEBUG	80 -> [0,35,"WebDriver:ExecuteScript",{"script":"arguments[0].setSelectionRange(0, 0);","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":null,"line":139,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.573Z] 15:42:56     INFO -  1673451776576	Marionette	DEBUG	80 <- [1,35,null,{"value":null}]
[task 2023-01-11T15:42:56.578Z] 15:42:56     INFO -  1673451776578	Marionette	DEBUG	80 -> [0,36,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.579Z] 15:42:56     INFO -  1673451776581	Marionette	DEBUG	80 <- [1,36,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.582Z] 15:42:56     INFO -  1673451776583	Marionette	DEBUG	80 -> [0,37,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;\n              for (let i = 0; i < 1; ++i) {\n                  sel.modify(\"move\", \"forward\", \"character\");\n              }","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":127,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.584Z] 15:42:56     INFO -  1673451776588	Marionette	DEBUG	80 <- [1,37,null,{"value":null}]
[task 2023-01-11T15:42:56.589Z] 15:42:56     INFO -  1673451776590	Marionette	DEBUG	80 -> [0,38,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.592Z] 15:42:56     INFO -  1673451776592	Marionette	DEBUG	80 <- [1,38,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.593Z] 15:42:56     INFO -  1673451776594	Marionette	DEBUG	80 -> [0,39,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":175,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.595Z] 15:42:56     INFO -  1673451776598	Marionette	DEBUG	80 <- [1,39,null,{"value":1}]
[task 2023-01-11T15:42:56.600Z] 15:42:56     INFO -  1673451776600	Marionette	DEBUG	80 -> [0,40,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.602Z] 15:42:56     INFO -  1673451776602	Marionette	DEBUG	80 <- [1,40,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.603Z] 15:42:56     INFO -  1673451776604	Marionette	DEBUG	80 -> [0,41,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":168,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.605Z] 15:42:56     INFO -  1673451776609	Marionette	DEBUG	80 <- [1,41,null,{"value":{"0":{"x":104.01666259765625,"y":77.66667175292969,"width":0,"height":15,"top":77.66667175292969,"right":104.01666259765625,"bottom":92.66667175292969,"left":104.01666259765625},"item":{},"length":1}}]
[task 2023-01-11T15:42:56.610Z] 15:42:56     INFO -  1673451776611	Marionette	DEBUG	80 -> [0,42,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.613Z] 15:42:56     INFO -  1673451776613	Marionette	DEBUG	80 <- [1,42,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.615Z] 15:42:56     INFO -  1673451776615	Marionette	DEBUG	80 -> [0,43,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.616Z] 15:42:56     INFO -  1673451776617	Marionette	DEBUG	80 <- [1,43,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.618Z] 15:42:56     INFO -  1673451776618	Marionette	DEBUG	80 -> [0,44,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"dir"}]
[task 2023-01-11T15:42:56.619Z] 15:42:56     INFO -  1673451776619	Marionette	DEBUG	80 <- [1,44,null,{"value":""}]
[task 2023-01-11T15:42:56.620Z] 15:42:56     INFO -  1673451776622	Marionette	DEBUG	80 -> [0,45,"WebDriver:ExecuteScript",{"script":"let rect = arguments[0].getBoundingClientRect();\n            return {x: rect.x, y:rect.y, width: rect.width, height: rect.height};","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"default","line":127,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\test_accessiblecaret_selection_mode.py"}]
[task 2023-01-11T15:42:56.623Z] 15:42:56     INFO -  1673451776626	Marionette	DEBUG	80 <- [1,45,null,{"value":{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}}]
[task 2023-01-11T15:42:56.628Z] 15:42:56     INFO -  1673451776629	Marionette	DEBUG	80 -> [0,46,"WebDriver:ExecuteScript",{"script":"let utils = window.windowUtils;\n            utils.sendTouchEventToWindow('touchstart', [0],\n                                  ...               [arguments[0]], [arguments[1]],\n                                         [1], [1], [0], [1], [0], [0], [0], 0);","args":[104.01666259765625,85.16667175292969],"newSandbox":true,"sandbox":"system","line":147,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\test_accessiblecaret_selection_mode.py"}]
[task 2023-01-11T15:42:56.633Z] 15:42:56     INFO -  1673451776638	Marionette	DEBUG	80 <- [1,46,null,{"value":null}]
[task 2023-01-11T15:42:56.639Z] 15:42:56     INFO -  1673451776639	Marionette	DEBUG	80 -> [0,47,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.640Z] 15:42:56     INFO -  1673451776641	Marionette	DEBUG	80 <- [1,47,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.642Z] 15:42:56     INFO -  1673451776643	Marionette	DEBUG	80 -> [0,48,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":175,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.644Z] 15:42:56     INFO -  1673451776648	Marionette	DEBUG	80 <- [1,48,null,{"value":1}]
[task 2023-01-11T15:42:56.650Z] 15:42:56     INFO -  1673451776650	Marionette	DEBUG	80 -> [0,49,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.651Z] 15:42:56     INFO -  1673451776651	Marionette	DEBUG	80 <- [1,49,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.653Z] 15:42:56     INFO -  1673451776653	Marionette	DEBUG	80 -> [0,50,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":168,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.655Z] 15:42:56     INFO -  1673451776658	Marionette	DEBUG	80 <- [1,50,null,{"value":{"0":{"x":97.01666259765625,"y":77.66667175292969,"width":21,"height":15,"top":77.66667175292969,"right":118.01666259765625,"bottom":92.66667175292969,"left":97.01666259765625},"item":{},"length":1}}]
[task 2023-01-11T15:42:56.660Z] 15:42:56     INFO -  1673451776659	Marionette	DEBUG	80 -> [0,51,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.661Z] 15:42:56     INFO -  1673451776661	Marionette	DEBUG	80 <- [1,51,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.663Z] 15:42:56     INFO -  1673451776662	Marionette	DEBUG	80 -> [0,52,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.665Z] 15:42:56     INFO -  1673451776664	Marionette	DEBUG	80 <- [1,52,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.665Z] 15:42:56     INFO -  1673451776665	Marionette	DEBUG	80 -> [0,53,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"dir"}]
[task 2023-01-11T15:42:56.666Z] 15:42:56     INFO -  1673451776667	Marionette	DEBUG	80 <- [1,53,null,{"value":""}]
[task 2023-01-11T15:42:56.668Z] 15:42:56     INFO -  1673451776668	Marionette	DEBUG	80 -> [0,54,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.669Z] 15:42:56     INFO -  1673451776670	Marionette	DEBUG	80 <- [1,54,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.671Z] 15:42:56     INFO -  1673451776671	Marionette	DEBUG	80 -> [0,55,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[{"type":"pointerMove","x":118,"y":97},{"type":"pointerDown","button":0},{"type":"pointerMove","x":146,"y":127,"duration":200},{"type":"pointerUp","button":0}],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-01-11T15:42:56.672Z] 15:42:56     INFO -  1673451776674	Marionette	TRACE	Dispatching tick 1/4
[task 2023-01-11T15:42:56.672Z] 15:42:56     INFO -  1673451776674	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 118 y: 97
[task 2023-01-11T15:42:56.672Z] 15:42:56     INFO -  1673451776674	Marionette	TRACE	moveOverTime start: 0,0 target: 118,97 duration: 0
[task 2023-01-11T15:42:56.675Z] 15:42:56     INFO -  1673451776674	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [118,97]
[task 2023-01-11T15:42:56.675Z] 15:42:56     INFO -  1673451776675	Marionette	TRACE	Dispatching tick 2/4
[task 2023-01-11T15:42:56.676Z] 15:42:56     INFO -  1673451776675	Marionette	TRACE	Dispatch PointerDownAction mouse with id: pointer_id button: 0
[task 2023-01-11T15:42:56.677Z] 15:42:56     INFO -  1673451776676	Marionette	TRACE	Dispatching tick 3/4
[task 2023-01-11T15:42:56.677Z] 15:42:56     INFO -  1673451776677	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 146 y: 127
[task 2023-01-11T15:42:56.677Z] 15:42:56     INFO -  1673451776677	Marionette	TRACE	moveOverTime start: 118,97 target: 146,127 duration: 200
[task 2023-01-11T15:42:56.696Z] 15:42:56     INFO -  1673451776696	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [120,99]
[task 2023-01-11T15:42:56.725Z] 15:42:56     INFO -  1673451776725	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [124,104]
[task 2023-01-11T15:42:56.754Z] 15:42:56     INFO -  1673451776754	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [128,108]
[task 2023-01-11T15:42:56.781Z] 15:42:56     INFO -  1673451776782	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [132,112]
[task 2023-01-11T15:42:56.810Z] 15:42:56     INFO -  1673451776811	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [136,117]
[task 2023-01-11T15:42:56.839Z] 15:42:56     INFO -  1673451776840	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [140,121]
[task 2023-01-11T15:42:56.862Z] 15:42:56     INFO -  1673451776862	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [143,124]
[task 2023-01-11T15:42:56.890Z] 15:42:56     INFO -  1673451776891	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [146,127]
[task 2023-01-11T15:42:56.894Z] 15:42:56     INFO -  1673451776893	Marionette	TRACE	Dispatching tick 4/4
[task 2023-01-11T15:42:56.894Z] 15:42:56     INFO -  1673451776893	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-01-11T15:42:56.904Z] 15:42:56     INFO -  1673451776903	Marionette	DEBUG	80 <- [1,55,null,{"value":null}]
[task 2023-01-11T15:42:56.905Z] 15:42:56     INFO -  1673451776905	Marionette	DEBUG	80 -> [0,56,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[]}]}]
[task 2023-01-11T15:42:56.907Z] 15:42:56     INFO -  1673451776907	Marionette	DEBUG	80 <- [1,56,null,{"value":null}]
[task 2023-01-11T15:42:56.909Z] 15:42:56     INFO -  1673451776908	Marionette	DEBUG	80 -> [0,57,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.911Z] 15:42:56     INFO -  1673451776910	Marionette	DEBUG	80 <- [1,57,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.913Z] 15:42:56     INFO -  1673451776912	Marionette	DEBUG	80 -> [0,58,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":175,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.917Z] 15:42:56     INFO -  1673451776917	Marionette	DEBUG	80 <- [1,58,null,{"value":1}]
[task 2023-01-11T15:42:56.919Z] 15:42:56     INFO -  1673451776919	Marionette	DEBUG	80 -> [0,59,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.921Z] 15:42:56     INFO -  1673451776920	Marionette	DEBUG	80 <- [1,59,null,{"value":"textarea"}]
[task 2023-01-11T15:42:56.923Z] 15:42:56     INFO -  1673451776923	Marionette	DEBUG	80 -> [0,60,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":168,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:56.928Z] 15:42:56     INFO -  1673451776929	Marionette	DEBUG	80 <- [1,60,null,{"value":{"0":{"x":97.01666259765625,"y":77.66667175292969,"width":56,"height":15,"top":77.66667175292969,"right":153.01666259765625,"bottom":92.66667175292969,"left":97.01666259765625},"1":{"x":97.01666259765625,"y":92.66667175292969,"width":56,"height":15,"top":92.66667175292969,"right":153.01666259765625,"bottom":107.66667175292969,"left":97.01666259765625},"2":{"x":97.01666259765625,"y":107.66667175292969,"width":49,"height":15,"top":107.66667175292969,"right":146.01666259765625,"bottom":122.66667175292969,"left":97.01666259765625},"item":{},"length":3}}]
[task 2023-01-11T15:42:56.930Z] 15:42:56     INFO -  1673451776930	Marionette	DEBUG	80 -> [0,61,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.931Z] 15:42:56     INFO -  1673451776932	Marionette	DEBUG	80 <- [1,61,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.933Z] 15:42:56     INFO -  1673451776933	Marionette	DEBUG	80 -> [0,62,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.934Z] 15:42:56     INFO -  1673451776935	Marionette	DEBUG	80 <- [1,62,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.936Z] 15:42:56     INFO -  1673451776936	Marionette	DEBUG	80 -> [0,63,"WebDriver:GetElementProperty",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794","name":"dir"}]
[task 2023-01-11T15:42:56.937Z] 15:42:56     INFO -  1673451776938	Marionette	DEBUG	80 <- [1,63,null,{"value":""}]
[task 2023-01-11T15:42:56.939Z] 15:42:56     INFO -  1673451776939	Marionette	DEBUG	80 -> [0,64,"WebDriver:GetElementRect",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:56.940Z] 15:42:56     INFO -  1673451776941	Marionette	DEBUG	80 <- [1,64,null,{"x":93.01666259765625,"y":73.66667175292969,"width":81.01667785644531,"height":85}]
[task 2023-01-11T15:42:56.942Z] 15:42:56     INFO -  1673451776942	Marionette	DEBUG	80 -> [0,65,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[{"type":"pointerMove","x":146,"y":127},{"type":"pointerDown","button":0},{"type":"pointerMove","x":97,"y":97,"duration":200},{"type":"pointerUp","button":0}],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-01-11T15:42:56.944Z] 15:42:56     INFO -  1673451776944	Marionette	TRACE	Dispatching tick 1/4
[task 2023-01-11T15:42:56.945Z] 15:42:56     INFO -  1673451776944	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 146 y: 127
[task 2023-01-11T15:42:56.945Z] 15:42:56     INFO -  1673451776945	Marionette	TRACE	moveOverTime start: 146,127 target: 146,127 duration: 0
[task 2023-01-11T15:42:56.946Z] 15:42:56     INFO -  1673451776945	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [146,127]
[task 2023-01-11T15:42:56.946Z] 15:42:56     INFO -  1673451776945	Marionette	TRACE	Dispatching tick 2/4
[task 2023-01-11T15:42:56.946Z] 15:42:56     INFO -  1673451776945	Marionette	TRACE	Dispatch PointerDownAction mouse with id: pointer_id button: 0
[task 2023-01-11T15:42:56.946Z] 15:42:56     INFO -  1673451776946	Marionette	TRACE	Dispatching tick 3/4
[task 2023-01-11T15:42:56.947Z] 15:42:56     INFO -  1673451776946	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 97 y: 97
[task 2023-01-11T15:42:56.947Z] 15:42:56     INFO -  1673451776946	Marionette	TRACE	moveOverTime start: 146,127 target: 97,97 duration: 200
[task 2023-01-11T15:42:56.981Z] 15:42:56     INFO -  1673451776981	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [137,121]
[task 2023-01-11T15:42:57.009Z] 15:42:57     INFO -  1673451777010	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [130,117]
[task 2023-01-11T15:42:57.038Z] 15:42:57     INFO -  1673451777038	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [123,113]
[task 2023-01-11T15:42:57.062Z] 15:42:57     INFO -  1673451777062	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [117,109]
[task 2023-01-11T15:42:57.091Z] 15:42:57     INFO -  1673451777091	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [110,105]
[task 2023-01-11T15:42:57.120Z] 15:42:57     INFO -  1673451777120	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [103,100]
[task 2023-01-11T15:42:57.133Z] 15:42:57     INFO -  DEBUG: Adding blocker OS.File: flush pending requests, warn about unclosed files, shut down service. for phase xpcom-will-shutdown
[task 2023-01-11T15:42:57.135Z] 15:42:57     INFO -  DEBUG: Adding blocker OS.File: flush I/O queued before profileBeforeChange for phase profile-before-change
[task 2023-01-11T15:42:57.162Z] 15:42:57     INFO -  1673451777163	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [97,97]
[task 2023-01-11T15:42:57.166Z] 15:42:57     INFO -  1673451777165	Marionette	TRACE	Dispatching tick 4/4
[task 2023-01-11T15:42:57.166Z] 15:42:57     INFO -  1673451777165	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-01-11T15:42:57.170Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.170Z] 15:42:57     INFO -  1673451777170	Marionette	DEBUG	80 <- [1,65,null,{"value":null}]
[task 2023-01-11T15:42:57.172Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.173Z] 15:42:57     INFO -  1673451777172	Marionette	DEBUG	80 -> [0,66,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[]}]}]
[task 2023-01-11T15:42:57.174Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.175Z] 15:42:57     INFO -  1673451777175	Marionette	DEBUG	80 <- [1,66,null,{"value":null}]
[task 2023-01-11T15:42:57.176Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.177Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.177Z] 15:42:57     INFO -  1673451777177	Marionette	DEBUG	80 -> [0,67,"WebDriver:GetElementTagName",{"id":"926535dd-f0ed-4f8b-afa9-d004ad055794"}]
[task 2023-01-11T15:42:57.179Z] 15:42:57     INFO -  [Child 724, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.183Z] 15:42:57     INFO -  1673451777183	Marionette	DEBUG	80 <- [1,67,null,{"value":"textarea"}]
[task 2023-01-11T15:42:57.186Z] 15:42:57     INFO -  1673451777185	Marionette	DEBUG	80 -> [0,68,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.toString();","args":[{"element-6066-11e4-a52e-4f735466cecf":"926535dd-f0ed-4f8b-afa9-d004ad055794"}],"newSandbox":true,"sandbox":"system","line":333,"filename":"Z:\\task_167344687073692\\build\\tests\\marionette\\tests\\layout\\base\\tests\\marionette\\selection.py"}]
[task 2023-01-11T15:42:57.197Z] 15:42:57     INFO -  [Child 5744, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1603
[task 2023-01-11T15:42:57.208Z] 15:42:57     INFO -  1673451777207	Marionette	DEBUG	80 <- [1,68,null,{"value":""}]
[task 2023-01-11T15:42:57.210Z] 15:42:57     INFO -  1673451777209	Marionette	DEBUG	80 -> [0,69,"Marionette:GetContext",{}]
[task 2023-01-11T15:42:57.210Z] 15:42:57     INFO -  1673451777210	Marionette	DEBUG	80 <- [1,69,null,{"value":"content"}]
[task 2023-01-11T15:42:57.211Z] 15:42:57     INFO -  1673451777211	Marionette	DEBUG	80 -> [0,70,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-01-11T15:42:57.211Z] 15:42:57     INFO -  1673451777211	Marionette	DEBUG	80 <- [1,70,null,{"value":null}]
[task 2023-01-11T15:42:57.212Z] 15:42:57     INFO -  1673451777212	Marionette	DEBUG	80 -> [0,71,"WebDriver:TakeScreenshot",{"id":null,"full":true,"hash":false,"scroll":true}]
[task 2023-01-11T15:42:57.224Z] 15:42:57     INFO -  [Child 5744, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8528
[task 2023-01-11T15:42:57.278Z] 15:42:57     INFO -  1673451777284	Marionette	DEBUG	80 <- [1,71,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAP/CAYAAACf8GEBAAAgAElEQVR4XuzdC7wVdb3//8/e3NkICmrWBsEUsxLzUoDi0cxLZJ0Agw6CnYrMfiWScKzs9PsJdDplZ ... BAgQIECBAgAABAgQIECBAgECagACYRm8wAQIECBAgQIAAAQIECBAgQIAAgXgBATDe2AQCBAgQIECAAAECBAgQIECAAAECaQL/Dw6BPjnN3uNBAAAAAElFTkSuQmCC"}]
[task 2023-01-11T15:42:57.296Z] 15:42:57     INFO -  1673451777297	Marionette	DEBUG	80 -> [0,72,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:57.298Z] 15:42:57     INFO -  1673451777297	Marionette	DEBUG	80 <- [1,72,null,{"value":null}]
[task 2023-01-11T15:42:57.303Z] 15:42:57     INFO -  1673451777303	Marionette	DEBUG	80 -> [0,73,"Marionette:GetContext",{}]
[task 2023-01-11T15:42:57.304Z] 15:42:57     INFO -  1673451777303	Marionette	DEBUG	80 <- [1,73,null,{"value":"content"}]
[task 2023-01-11T15:42:57.304Z] 15:42:57     INFO -  1673451777304	Marionette	DEBUG	80 -> [0,74,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:57.305Z] 15:42:57     INFO -  1673451777304	Marionette	DEBUG	80 <- [1,74,null,{"value":null}]
[task 2023-01-11T15:42:57.307Z] 15:42:57     INFO -  1673451777307	Marionette	DEBUG	80 -> [0,75,"WebDriver:GetPageSource",{}]
[task 2023-01-11T15:42:57.310Z] 15:42:57     INFO -  1673451777310	Marionette	DEBUG	80 <- [1,75,null,{"value":"<html id=\"html\"><head>\n    <meta http-equiv=\"Content-Type\" content=\"text/html; charset=utf-8\">\n    <title>Marionette tests fo ... t\">ABC DEF GHI</div>\n    <br>\n    <div style=\"user-select: none;\" id=\"non-selectable\">Non-selectable</div>\n  \n\n</body></html>"}]
[task 2023-01-11T15:42:57.312Z] 15:42:57     INFO -  1673451777311	Marionette	DEBUG	80 -> [0,76,"Marionette:SetContext",{"value":"content"}]
[task 2023-01-11T15:42:57.312Z] 15:42:57     INFO -  1673451777312	Marionette	DEBUG	80 <- [1,76,null,{"value":null}]
[task 2023-01-11T15:42:57.319Z] 15:42:57    ERROR -  TEST-UNEXPECTED-FAIL | layout/base/tests/marionette/test_accessiblecaret_selection_mode.py AccessibleCaretSelectionModeTestCase.test_minimum_select_one_character_textarea_disabled | AssertionError: 'A' != ''
[task 2023-01-11T15:42:57.320Z] 15:42:57     INFO -  - A
[task 2023-01-11T15:42:57.320Z] 15:42:57     INFO -  +
[task 2023-01-11T15:42:57.320Z] 15:42:57     INFO -  Traceback (most recent call last):
[task 2023-01-11T15:42:57.320Z] 15:42:57     INFO -    File "Z:\task_167344687073692\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 198, in run
[task 2023-01-11T15:42:57.321Z] 15:42:57     INFO -      testMethod()
[task 2023-01-11T15:42:57.322Z] 15:42:57     INFO -    File "Z:\task_167344687073692\build\venv\lib\site-packages\marionette_harness\marionette_test\testcases.py", line 48, in wrapper
[task 2023-01-11T15:42:57.322Z] 15:42:57     INFO -      return func(self, *args, **kwargs)
[task 2023-01-11T15:42:57.322Z] 15:42:57     INFO -    File "Z:\task_167344687073692\build\tests\marionette\tests\layout\base\tests\marionette\test_accessiblecaret_selection_mode.py", line 277, in test_minimum_select_one_character
[task 2023-01-11T15:42:57.322Z] 15:42:57     INFO -      self._test_minimum_select_one_character(el)
[task 2023-01-11T15:42:57.323Z] 15:42:57     INFO -    File "Z:\task_167344687073692\build\tests\marionette\tests\layout\base\tests\marionette\test_accessiblecaret_selection_mode.py", line 312, in _test_minimum_select_one_character
[task 2023-01-11T15:42:57.323Z] 15:42:57     INFO -      self.assertEqual(target_content, sel.selected_content)
[task 2023-01-11T15:42:57.323Z] 15:42:57     INFO -  TEST-INFO took 1244ms

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform and build breakdown:

• windows10-32-2004-qr: 1
  • debug: 1
• windows10-64-2004-asan-qr: 1
  • opt: 1

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

Comment 2

[Natalia Csoregi [:nataliaCs]]

First occurrence so far: retriggers and backfills

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-32-2004-qr: 1
  • debug: 1

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 1
• autoland: 2

Platform and build breakdown:

• windows10-64-2004-asan-qr: 2
  • opt: 2
• windows10-32-2004-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-01-30&endday=2023-02-05&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-02-06&endday=2023-02-12&tree=all

Comment 6

[Intermittent Failures Robot]

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

Repository breakdown:

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

Platform and build breakdown:

• windows10-64-2004-asan-qr: 4
  • opt: 4

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-02-20&endday=2023-02-26&tree=all

Comment 7

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows10-64-2004-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-02-27&endday=2023-03-05&tree=all

Comment 8

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

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

Comment 10

[Norisz Fay [:noriszfay]]

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

Comment 11

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• windows11-64-2009-qr: 1
  • debug: 1
• windows11-32-2009-qr: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-08-21&endday=2023-08-27&tree=all

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1
• try: 1

Platform and build breakdown:

• windows11-64-2009-qr: 2
  • debug: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-08-28&endday=2023-09-03&tree=all

Comment 13

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 1

Platform and build breakdown:

• windows11-64-2009-qr: 2
  • debug: 2
• windows11-32-2009-qr: 1
  • debug: 1

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

Comment 14

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows11-32-2009-qr: 1
  • debug: 1

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

Comment 15

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• windows11-32-2009-qr: 3
  • debug: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1809686&startday=2023-09-18&endday=2023-09-24&tree=all