Open Bug 1841181 Opened 3 years ago Updated 1 day ago

Intermittent layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py | single tracking bug

Categories

(Core :: Layout, defect, P5)

defect

Tracking

()

REOPENED

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: assertion, intermittent-failure)

Attachments

(1 obsolete file)

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


[task 2023-06-29T22:23:07.447Z] 22:23:07     INFO - TEST-START | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_caret_not_jump_when_dragging_to_editable_content_boundary_textarea_one_line
[task 2023-06-29T22:23:07.448Z] 22:23:07     INFO -  1688077387447	Marionette	DEBUG	Accepted connection 10 from 127.0.0.1:51749
[task 2023-06-29T22:23:07.448Z] 22:23:07     INFO -  1688077387448	Marionette	DEBUG	10 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2023-06-29T22:23:07.449Z] 22:23:07     INFO -  1688077387449	Marionette	DEBUG	Waiting for initial application window
[task 2023-06-29T22:23:07.451Z] 22:23:07     INFO -  1688077387450	RemoteAgent	TRACE	[12] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2023-06-29T22:23:07.451Z] 22:23:07     INFO -  1688077387450	RemoteAgent	TRACE	[12] ProgressListener Setting unload timer (40000ms)
[task 2023-06-29T22:23:07.451Z] 22:23:07     INFO -  1688077387450	RemoteAgent	TRACE	[12] Document already finished loading: http://127.0.0.1:49268/layout/test_carets_cursor.html
[task 2023-06-29T22:23:07.451Z] 22:23:07     INFO -  1688077387451	RemoteAgent	TRACE	[12] ProgressListener Stop: has error=false
[task 2023-06-29T22:23:07.453Z] 22:23:07     INFO -  1688077387452	Marionette	DEBUG	10 <- [1,1,null,{"sessionId":"66443645-9f3d-43ee-a410-8335687e83b5","capabilities":{"browserName":"firefox","browserVersion":"116.0a1","platformName":"mac","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","moz:accessibilityChecks":false,"moz:buildID":"20230629214838","moz:headless":false,"moz:platformVersion":"19.6.0","moz:processID":3294,"moz:profile":"/var/folders/w6/mmyn49294nd977c_4vsk_bkh000014/T/tmpx6ukjhho.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2023-06-29T22:23:07.454Z] 22:23:07     INFO -  1688077387453	Marionette	DEBUG	10 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2023-06-29T22:23:07.454Z] 22:23:07     INFO -  1688077387454	Marionette	DEBUG	10 <- [1,2,null,{"value":null}]
[task 2023-06-29T22:23:07.455Z] 22:23:07     INFO -  1688077387454	Marionette	DEBUG	10 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2023-06-29T22:23:07.455Z] 22:23:07     INFO -  1688077387455	Marionette	DEBUG	10 <- [1,3,null,{"value":null}]
[task 2023-06-29T22:23:07.456Z] 22:23:07     INFO -  1688077387455	Marionette	DEBUG	10 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2023-06-29T22:23:07.456Z] 22:23:07     INFO -  1688077387456	Marionette	DEBUG	10 <- [1,4,null,{"value":null}]
[task 2023-06-29T22:23:07.457Z] 22:23:07     INFO -  1688077387457	Marionette	DEBUG	10 -> [0,5,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:07.457Z] 22:23:07     INFO -  1688077387457	Marionette	DEBUG	10 <- [1,5,null,{"value":"content"}]
[task 2023-06-29T22:23:07.458Z] 22:23:07     INFO -  1688077387457	Marionette	DEBUG	10 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-06-29T22:23:07.458Z] 22:23:07     INFO -  1688077387458	Marionette	DEBUG	10 <- [1,6,null,{"value":null}]
[task 2023-06-29T22:23:07.459Z] 22:23:07     INFO -  1688077387459	Marionette	DEBUG	10 -> [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.accessiblecaret.enabled",true,false],"newSandbox":true,"sandbox":"default","line":873,"filename":"../../venv/lib/python3.7/site-packages/marionette_driver/marionette.py"}]
[task 2023-06-29T22:23:07.460Z] 22:23:07     INFO -  1688077387460	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 3294
[task 2023-06-29T22:23:07.460Z] 22:23:07     INFO -  1688077387460	Marionette	TRACE	[2] MarionetteCommands actor created for window id 4
[task 2023-06-29T22:23:07.463Z] 22:23:07     INFO -  1688077387462	Marionette	DEBUG	10 <- [1,7,null,{"value":null}]
[task 2023-06-29T22:23:07.464Z] 22:23:07     INFO -  1688077387463	Marionette	DEBUG	10 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:07.464Z] 22:23:07     INFO -  1688077387463	Marionette	DEBUG	10 <- [1,8,null,{"value":null}]
[task 2023-06-29T22:23:07.464Z] 22:23:07     INFO -  1688077387464	Marionette	DEBUG	10 -> [0,9,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:07.465Z] 22:23:07     INFO -  1688077387464	Marionette	DEBUG	10 <- [1,9,null,{"value":"content"}]
[task 2023-06-29T22:23:07.465Z] 22:23:07     INFO -  1688077387465	Marionette	DEBUG	10 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-06-29T22:23:07.465Z] 22:23:07     INFO -  1688077387465	Marionette	DEBUG	10 <- [1,10,null,{"value":null}]
[task 2023-06-29T22:23:07.467Z] 22:23:07     INFO -  1688077387466	Marionette	DEBUG	10 -> [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.hide_carets_for_mouse_input",false,false],"newSandbox":true,"sandbox":"default","line":873,"filename":"../../venv/lib/python3.7/site-packages/marionette_driver/marionette.py"}]
[task 2023-06-29T22:23:07.470Z] 22:23:07     INFO -  1688077387470	Marionette	DEBUG	10 <- [1,11,null,{"value":null}]
[task 2023-06-29T22:23:07.471Z] 22:23:07     INFO -  1688077387470	Marionette	DEBUG	10 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:07.471Z] 22:23:07     INFO -  1688077387471	Marionette	DEBUG	10 <- [1,12,null,{"value":null}]
[task 2023-06-29T22:23:07.471Z] 22:23:07     INFO -  1688077387471	Marionette	DEBUG	10 -> [0,13,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:07.472Z] 22:23:07     INFO -  1688077387471	Marionette	DEBUG	10 <- [1,13,null,{"value":"content"}]
[task 2023-06-29T22:23:07.472Z] 22:23:07     INFO -  1688077387472	Marionette	DEBUG	10 -> [0,14,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-06-29T22:23:07.472Z] 22:23:07     INFO -  1688077387472	Marionette	DEBUG	10 <- [1,14,null,{"value":null}]
[task 2023-06-29T22:23:07.474Z] 22:23:07     INFO -  1688077387473	Marionette	DEBUG	10 -> [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":873,"filename":"../../venv/lib/python3.7/site-packages/marionette_driver/marionette.py"}]
[task 2023-06-29T22:23:07.477Z] 22:23:07     INFO -  1688077387477	Marionette	DEBUG	10 <- [1,15,null,{"value":null}]
[task 2023-06-29T22:23:07.478Z] 22:23:07     INFO -  1688077387477	Marionette	DEBUG	10 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:07.478Z] 22:23:07     INFO -  1688077387478	Marionette	DEBUG	10 <- [1,16,null,{"value":null}]
[task 2023-06-29T22:23:07.479Z] 22:23:07     INFO -  1688077387478	Marionette	DEBUG	10 -> [0,17,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:07.479Z] 22:23:07     INFO -  1688077387478	Marionette	DEBUG	10 <- [1,17,null,{"value":"content"}]
[task 2023-06-29T22:23:07.479Z] 22:23:07     INFO -  1688077387479	Marionette	DEBUG	10 -> [0,18,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-06-29T22:23:07.479Z] 22:23:07     INFO -  1688077387479	Marionette	DEBUG	10 <- [1,18,null,{"value":null}]
[task 2023-06-29T22:23:07.481Z] 22:23:07     INFO -  1688077387480	Marionette	DEBUG	10 -> [0,19,"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.hapticfeedback",true,false],"newSandbox":true,"sandbox":"default","line":873,"filename":"../../venv/lib/python3.7/site-packages/marionette_driver/marionette.py"}]
[task 2023-06-29T22:23:07.484Z] 22:23:07     INFO -  1688077387484	Marionette	DEBUG	10 <- [1,19,null,{"value":null}]
[task 2023-06-29T22:23:07.485Z] 22:23:07     INFO -  1688077387484	Marionette	DEBUG	10 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:07.485Z] 22:23:07     INFO -  1688077387485	Marionette	DEBUG	10 <- [1,20,null,{"value":null}]
[task 2023-06-29T22:23:07.486Z] 22:23:07     INFO -  1688077387486	Marionette	DEBUG	10 -> [0,21,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:07.487Z] 22:23:07     INFO -  1688077387487	RemoteAgent	TRACE	WebDriverProcessData actor created for PID 3304
[task 2023-06-29T22:23:07.487Z] 22:23:07     INFO -  1688077387487	Marionette	TRACE	[12] MarionetteCommands actor created for window id 6442450952
[task 2023-06-29T22:23:07.488Z] 22:23:07     INFO -  1688077387487	Marionette	DEBUG	10 <- [1,21,null,{"value":null}]
[task 2023-06-29T22:23:07.488Z] 22:23:07     INFO -  1688077387488	Marionette	DEBUG	10 -> [0,22,"WebDriver:Navigate",{"url":"http://127.0.0.1:49268/layout/test_carets_cursor.html"}]
[task 2023-06-29T22:23:07.489Z] 22:23:07     INFO -  [Parent 3294, 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:230
[task 2023-06-29T22:23:07.491Z] 22:23:07     INFO -  1688077387491	Marionette	TRACE	[12] Received event beforeunload for http://127.0.0.1:49268/layout/test_carets_cursor.html
[task 2023-06-29T22:23:07.505Z] 22:23:07     INFO -  1688077387504	Marionette	TRACE	[12] Received event pagehide for http://127.0.0.1:49268/layout/test_carets_cursor.html
[task 2023-06-29T22:23:07.511Z] 22:23:07     INFO -  1688077387511	Marionette	TRACE	[12] MarionetteCommands actor destroyed for window id 6442450952
[task 2023-06-29T22:23:07.526Z] 22:23:07     INFO -  1688077387525	Marionette	TRACE	[12] Received event DOMContentLoaded for http://127.0.0.1:49268/layout/test_carets_cursor.html
[task 2023-06-29T22:23:07.526Z] 22:23:07     INFO -  1688077387525	Marionette	TRACE	[12] Received event pageshow for http://127.0.0.1:49268/layout/test_carets_cursor.html
[task 2023-06-29T22:23:07.526Z] 22:23:07     INFO -  1688077387526	Marionette	DEBUG	10 <- [1,22,null,{"value":null}]
[task 2023-06-29T22:23:07.538Z] 22:23:07     INFO -  1688077387538	Marionette	DEBUG	10 -> [0,23,"WebDriver:FindElement",{"value":"textarea-one-line","using":"id"}]
[task 2023-06-29T22:23:07.539Z] 22:23:07     INFO -  1688077387539	Marionette	TRACE	[12] MarionetteCommands actor created for window id 6442450953
[task 2023-06-29T22:23:07.539Z] 22:23:07     INFO -  DEBUG: Adding blocker Transaction (7) for phase protections.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.540Z] 22:23:07     INFO -  DEBUG: Completed blocker Transaction (7) for phase protections.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.541Z] 22:23:07     INFO -  1688077387540	Marionette	DEBUG	10 <- [1,23,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}}]
[task 2023-06-29T22:23:07.541Z] 22:23:07     INFO -  1688077387541	Marionette	DEBUG	10 -> [0,24,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.543Z] 22:23:07     INFO -  1688077387542	Marionette	DEBUG	10 <- [1,24,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.543Z] 22:23:07     INFO -  1688077387543	Marionette	DEBUG	10 -> [0,25,"WebDriver:GetElementProperty",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c","name":"value"}]
[task 2023-06-29T22:23:07.545Z] 22:23:07     INFO -  1688077387544	Marionette	DEBUG	10 <- [1,25,null,{"value":"ABCDEFGHI"}]
[task 2023-06-29T22:23:07.546Z] 22:23:07     INFO -  1688077387545	Marionette	DEBUG	10 -> [0,26,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[{"type":"pointerMove","x":0,"y":0,"origin":{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}},{"type":"pointerDown","button":0},{"type":"pointerUp","button":0}],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-06-29T22:23:07.547Z] 22:23:07     INFO -  1688077387546	Marionette	TRACE	Dispatching tick 1/3
[task 2023-06-29T22:23:07.547Z] 22:23:07     INFO -  1688077387546	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 0 y: 0
[task 2023-06-29T22:23:07.547Z] 22:23:07     INFO -  1688077387547	Marionette	TRACE	moveOverTime start: 0,0 target: 171,128 duration: 0
[task 2023-06-29T22:23:07.547Z] 22:23:07     INFO -  1688077387547	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [171,128]
[task 2023-06-29T22:23:07.548Z] 22:23:07     INFO -  1688077387548	Marionette	TRACE	Dispatching tick 2/3
[task 2023-06-29T22:23:07.549Z] 22:23:07     INFO -  1688077387548	Marionette	TRACE	Dispatch PointerDownAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.550Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: '!editingHost', file /builds/worker/checkouts/gecko/editor/libeditor/HTMLEditor.cpp:1091
[task 2023-06-29T22:23:07.550Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: mozInlineSpellCHecker::UpdateCurrentDictionary() failed, but ignored: 'NS_SUCCEEDED(rvIgnored)', file /builds/worker/checkouts/gecko/editor/libeditor/EditorBase.cpp:5841
[task 2023-06-29T22:23:07.551Z] 22:23:07     INFO -  1688077387551	Marionette	TRACE	Dispatching tick 3/3
[task 2023-06-29T22:23:07.551Z] 22:23:07     INFO -  1688077387551	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.554Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:07.554Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:07.555Z] 22:23:07     INFO -  DEBUG: Adding blocker UserInteractionTimer 9 for document 121503c00 for phase xpcom-will-shutdown
[task 2023-06-29T22:23:07.556Z] 22:23:07     INFO -  1688077387555	Marionette	DEBUG	10 <- [1,26,null,{"value":null}]
[task 2023-06-29T22:23:07.556Z] 22:23:07     INFO -  DEBUG: Adding blocker Transaction (10) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.557Z] 22:23:07     INFO -  DEBUG: Adding blocker Transaction (11) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.559Z] 22:23:07     INFO -  1688077387558	Marionette	DEBUG	10 -> [0,27,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[]}]}]
[task 2023-06-29T22:23:07.560Z] 22:23:07     INFO -  DEBUG: Completed blocker Transaction (10) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.560Z] 22:23:07     INFO -  1688077387560	Marionette	DEBUG	10 <- [1,27,null,{"value":null}]
[task 2023-06-29T22:23:07.561Z] 22:23:07     INFO -  DEBUG: Completed blocker Transaction (11) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.562Z] 22:23:07     INFO -  1688077387562	Marionette	DEBUG	10 -> [0,28,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:07.563Z] 22:23:07     INFO -  1688077387563	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.564Z] 22:23:07     INFO -  1688077387563	Marionette	DEBUG	10 <- [1,28,null,{"value":null}]
[task 2023-06-29T22:23:07.565Z] 22:23:07     INFO -  1688077387565	Marionette	DEBUG	10 -> [0,29,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.566Z] 22:23:07     INFO -  1688077387566	Marionette	DEBUG	10 <- [1,29,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.570Z] 22:23:07     INFO -  1688077387569	Marionette	DEBUG	10 -> [0,30,"WebDriver:ExecuteScript",{"script":"arguments[0].setSelectionRange(0, 0);","args":[{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}],"newSandbox":true,"sandbox":null,"line":168,"filename":"tests/layout/base/tests/marionette/selection.py"}]
[task 2023-06-29T22:23:07.591Z] 22:23:07     INFO -  1688077387591	Marionette	DEBUG	10 <- [1,30,null,{"value":null}]
[task 2023-06-29T22:23:07.612Z] 22:23:07     INFO -  1688077387612	Marionette	DEBUG	10 -> [0,31,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.613Z] 22:23:07     INFO -  1688077387613	Marionette	DEBUG	10 <- [1,31,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.615Z] 22:23:07     INFO -  1688077387614	Marionette	DEBUG	10 -> [0,32,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}],"newSandbox":true,"sandbox":"system","line":204,"filename":"tests/layout/base/tests/marionette/selection.py"}]
[task 2023-06-29T22:23:07.638Z] 22:23:07     INFO -  1688077387638	Marionette	DEBUG	10 <- [1,32,null,{"value":1}]
[task 2023-06-29T22:23:07.660Z] 22:23:07     INFO -  1688077387660	Marionette	DEBUG	10 -> [0,33,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.681Z] 22:23:07     INFO -  1688077387681	Marionette	DEBUG	10 <- [1,33,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.683Z] 22:23:07     INFO -  1688077387682	Marionette	DEBUG	10 -> [0,34,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}],"newSandbox":true,"sandbox":"system","line":197,"filename":"tests/layout/base/tests/marionette/selection.py"}]
[task 2023-06-29T22:23:07.704Z] 22:23:07     INFO -  1688077387704	Marionette	DEBUG	10 <- [1,34,null,{"value":{"0":{"x":86.01666259765625,"y":95.86666870117188,"width":0,"height":17,"top":95.86666870117188,"right":86.01666259765625,"bottom":112.86666870117188,"left":86.01666259765625},"item":{},"length":1}}]
[task 2023-06-29T22:23:07.725Z] 22:23:07     INFO -  1688077387725	Marionette	DEBUG	10 -> [0,35,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.747Z] 22:23:07     INFO -  1688077387746	Marionette	DEBUG	10 <- [1,35,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.747Z] 22:23:07     INFO -  1688077387747	Marionette	DEBUG	10 -> [0,36,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.749Z] 22:23:07     INFO -  1688077387749	Marionette	DEBUG	10 <- [1,36,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.750Z] 22:23:07     INFO -  1688077387749	Marionette	DEBUG	10 -> [0,37,"WebDriver:GetElementProperty",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c","name":"dir"}]
[task 2023-06-29T22:23:07.771Z] 22:23:07     INFO -  1688077387771	Marionette	DEBUG	10 <- [1,37,null,{"value":""}]
[task 2023-06-29T22:23:07.793Z] 22:23:07     INFO -  1688077387792	Marionette	DEBUG	10 -> [0,38,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.820Z] 22:23:07     INFO -  1688077387820	Marionette	DEBUG	10 <- [1,38,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.841Z] 22:23:07     INFO -  1688077387841	Marionette	DEBUG	10 -> [0,39,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[{"type":"pointerMove","x":86,"y":104},{"type":"pointerDown","button":0},{"type":"pointerUp","button":0}],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-06-29T22:23:07.842Z] 22:23:07     INFO -  1688077387842	Marionette	TRACE	Dispatching tick 1/3
[task 2023-06-29T22:23:07.843Z] 22:23:07     INFO -  1688077387842	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 86 y: 104
[task 2023-06-29T22:23:07.843Z] 22:23:07     INFO -  1688077387842	Marionette	TRACE	moveOverTime start: 0,0 target: 86,104 duration: 0
[task 2023-06-29T22:23:07.843Z] 22:23:07     INFO -  1688077387842	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [86,104]
[task 2023-06-29T22:23:07.843Z] 22:23:07     INFO -  1688077387843	Marionette	TRACE	Dispatching tick 2/3
[task 2023-06-29T22:23:07.843Z] 22:23:07     INFO -  1688077387843	Marionette	TRACE	Dispatch PointerDownAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.844Z] 22:23:07     INFO -  1688077387844	Marionette	TRACE	Dispatching tick 3/3
[task 2023-06-29T22:23:07.844Z] 22:23:07     INFO -  1688077387844	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.862Z] 22:23:07     INFO -  1688077387861	Marionette	DEBUG	10 <- [1,39,null,{"value":null}]
[task 2023-06-29T22:23:07.862Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.863Z] 22:23:07     INFO -  1688077387862	Marionette	DEBUG	10 -> [0,40,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[]}]}]
[task 2023-06-29T22:23:07.863Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.864Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.864Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1711
[task 2023-06-29T22:23:07.865Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.866Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.866Z] 22:23:07     INFO -  [Child 3295, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:07.868Z] 22:23:07     INFO -  1688077387868	Marionette	DEBUG	10 <- [1,40,null,{"value":null}]
[task 2023-06-29T22:23:07.868Z] 22:23:07     INFO -  DEBUG: Adding blocker Transaction (12) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.870Z] 22:23:07     INFO -  1688077387869	Marionette	DEBUG	10 -> [0,41,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:07.870Z] 22:23:07     INFO -  1688077387870	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.870Z] 22:23:07     INFO -  DEBUG: Completed blocker Transaction (12) for phase content-prefs.sqlite#0: waiting for clients
[task 2023-06-29T22:23:07.871Z] 22:23:07     INFO -  1688077387871	Marionette	DEBUG	10 <- [1,41,null,{"value":null}]
[task 2023-06-29T22:23:07.872Z] 22:23:07     INFO -  1688077387872	Marionette	DEBUG	10 -> [0,42,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.873Z] 22:23:07     INFO -  1688077387873	Marionette	DEBUG	10 <- [1,42,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.874Z] 22:23:07     INFO -  1688077387874	Marionette	DEBUG	10 -> [0,43,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.rangeCount;","args":[{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}],"newSandbox":true,"sandbox":"system","line":204,"filename":"tests/layout/base/tests/marionette/selection.py"}]
[task 2023-06-29T22:23:07.877Z] 22:23:07     INFO -  1688077387877	Marionette	DEBUG	10 <- [1,43,null,{"value":1}]
[task 2023-06-29T22:23:07.878Z] 22:23:07     INFO -  1688077387877	Marionette	DEBUG	10 -> [0,44,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.879Z] 22:23:07     INFO -  1688077387878	Marionette	DEBUG	10 <- [1,44,null,{"value":"textarea"}]
[task 2023-06-29T22:23:07.880Z] 22:23:07     INFO -  1688077387880	Marionette	DEBUG	10 -> [0,45,"WebDriver:ExecuteScript",{"script":"var sel = arguments[0].editor.selection;return sel.getRangeAt(0).getClientRects();","args":[{"element-6066-11e4-a52e-4f735466cecf":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}],"newSandbox":true,"sandbox":"system","line":197,"filename":"tests/layout/base/tests/marionette/selection.py"}]
[task 2023-06-29T22:23:07.885Z] 22:23:07     INFO -  1688077387884	Marionette	DEBUG	10 <- [1,45,null,{"value":{"0":{"x":86.01666259765625,"y":95.86666870117188,"width":0,"height":17,"top":95.86666870117188,"right":86.01666259765625,"bottom":112.86666870117188,"left":86.01666259765625},"item":{},"length":1}}]
[task 2023-06-29T22:23:07.885Z] 22:23:07     INFO -  1688077387885	Marionette	DEBUG	10 -> [0,46,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.887Z] 22:23:07     INFO -  1688077387886	Marionette	DEBUG	10 <- [1,46,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.887Z] 22:23:07     INFO -  1688077387887	Marionette	DEBUG	10 -> [0,47,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.889Z] 22:23:07     INFO -  1688077387888	Marionette	DEBUG	10 <- [1,47,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.890Z] 22:23:07     INFO -  1688077387889	Marionette	DEBUG	10 -> [0,48,"WebDriver:GetElementProperty",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c","name":"dir"}]
[task 2023-06-29T22:23:07.891Z] 22:23:07     INFO -  1688077387890	Marionette	DEBUG	10 <- [1,48,null,{"value":""}]
[task 2023-06-29T22:23:07.891Z] 22:23:07     INFO -  1688077387891	Marionette	DEBUG	10 -> [0,49,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.892Z] 22:23:07     INFO -  1688077387892	Marionette	DEBUG	10 <- [1,49,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.893Z] 22:23:07     INFO -  1688077387893	Marionette	DEBUG	10 -> [0,50,"WebDriver:GetElementRect",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:07.894Z] 22:23:07     INFO -  1688077387894	Marionette	DEBUG	10 <- [1,50,null,{"x":82.01666259765625,"y":91.86666870117188,"width":179.68333435058594,"height":74}]
[task 2023-06-29T22:23:07.895Z] 22:23:07     INFO -  1688077387895	Marionette	DEBUG	10 -> [0,51,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[{"type":"pointerMove","x":86,"y":117,"duration":0},{"type":"pointerDown","button":0},{"type":"pointerMove","x":86,"y":167,"duration":200},{"type":"pointerUp","button":0}],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-06-29T22:23:07.896Z] 22:23:07     INFO -  1688077387896	Marionette	TRACE	Dispatching tick 1/4
[task 2023-06-29T22:23:07.896Z] 22:23:07     INFO -  1688077387896	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 86 y: 117
[task 2023-06-29T22:23:07.897Z] 22:23:07     INFO -  1688077387896	Marionette	TRACE	moveOverTime start: 0,0 target: 86,117 duration: 0
[task 2023-06-29T22:23:07.897Z] 22:23:07     INFO -  1688077387896	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [86,117]
[task 2023-06-29T22:23:07.897Z] 22:23:07     INFO -  1688077387897	Marionette	TRACE	Dispatching tick 2/4
[task 2023-06-29T22:23:07.897Z] 22:23:07     INFO -  1688077387897	Marionette	TRACE	Dispatch PointerDownAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:07.898Z] 22:23:07     INFO -  1688077387898	Marionette	TRACE	Dispatching tick 3/4
[task 2023-06-29T22:23:07.898Z] 22:23:07     INFO -  1688077387898	Marionette	TRACE	Dispatch PointerMoveAction mouse with id: pointer_id x: 86 y: 167
[task 2023-06-29T22:23:07.898Z] 22:23:07     INFO -  1688077387898	Marionette	TRACE	moveOverTime start: 86,117 target: 86,167 duration: 200
[task 2023-06-29T22:23:07.902Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:07.902Z] 22:23:07     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.023Z] 22:23:08     INFO -  1688077388023	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [86,148]
[task 2023-06-29T22:23:08.024Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.025Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.025Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.045Z] 22:23:08     INFO -  1688077388045	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [86,153]
[task 2023-06-29T22:23:08.046Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.047Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.047Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.141Z] 22:23:08     INFO -  1688077388140	Marionette	TRACE	PointerMoveAction.performPointerMoveStep [86,167]
[task 2023-06-29T22:23:08.141Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.142Z] 22:23:08     INFO -  1688077388141	Marionette	TRACE	Dispatching tick 4/4
[task 2023-06-29T22:23:08.142Z] 22:23:08     INFO -  1688077388141	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:08.145Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.145Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.146Z] 22:23:08     INFO -  1688077388145	Marionette	DEBUG	10 <- [1,51,null,{"value":null}]
[task 2023-06-29T22:23:08.147Z] 22:23:08     INFO -  1688077388146	Marionette	DEBUG	10 -> [0,52,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[]}]}]
[task 2023-06-29T22:23:08.148Z] 22:23:08     INFO -  1688077388147	Marionette	DEBUG	10 <- [1,52,null,{"value":null}]
[task 2023-06-29T22:23:08.148Z] 22:23:08     INFO -  1688077388148	Marionette	DEBUG	10 -> [0,53,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:08.149Z] 22:23:08     INFO -  1688077388149	Marionette	TRACE	Dispatch PointerUpAction mouse with id: pointer_id button: 0
[task 2023-06-29T22:23:08.150Z] 22:23:08     INFO -  1688077388149	Marionette	DEBUG	10 <- [1,53,null,{"value":null}]
[task 2023-06-29T22:23:08.150Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.150Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: 'child1Index.isNothing()', file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:2984
[task 2023-06-29T22:23:08.151Z] 22:23:08     INFO -  1688077388150	Marionette	DEBUG	10 -> [0,54,"WebDriver:PerformActions",{"actions":[{"type":"pointer","id":"pointer_id","actions":[],"parameters":{"pointerType":"mouse"}}]}]
[task 2023-06-29T22:23:08.152Z] 22:23:08     INFO -  1688077388152	Marionette	DEBUG	10 <- [1,54,null,{"value":null}]
[task 2023-06-29T22:23:08.153Z] 22:23:08     INFO -  1688077388152	Marionette	DEBUG	10 -> [0,55,"WebDriver:PerformActions",{"actions":[{"type":"key","id":"keyboard_id","actions":[{"type":"keyDown","value":"!"},{"type":"keyUp","value":"!"}]}]}]
[task 2023-06-29T22:23:08.153Z] 22:23:08     INFO -  1688077388153	Marionette	TRACE	Dispatching tick 1/2
[task 2023-06-29T22:23:08.153Z] 22:23:08     INFO -  1688077388153	Marionette	TRACE	Dispatch KeyDownAction with keyboard_id !
[task 2023-06-29T22:23:08.156Z] 22:23:08     INFO -  1688077388156	Marionette	TRACE	Dispatching tick 2/2
[task 2023-06-29T22:23:08.157Z] 22:23:08     INFO -  1688077388156	Marionette	TRACE	Dispatch KeyUpAction with keyboard_id !
[task 2023-06-29T22:23:08.159Z] 22:23:08     INFO -  1688077388159	Marionette	DEBUG	10 <- [1,55,null,{"value":null}]
[task 2023-06-29T22:23:08.160Z] 22:23:08     INFO -  1688077388160	Marionette	DEBUG	10 -> [0,56,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:08.160Z] 22:23:08     INFO -  1688077388160	Marionette	TRACE	Dispatch KeyUpAction with keyboard_id !
[task 2023-06-29T22:23:08.161Z] 22:23:08     INFO -  1688077388161	Marionette	DEBUG	10 <- [1,56,null,{"value":null}]
[task 2023-06-29T22:23:08.162Z] 22:23:08     INFO -  1688077388162	Marionette	DEBUG	10 -> [0,57,"WebDriver:GetElementTagName",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c"}]
[task 2023-06-29T22:23:08.163Z] 22:23:08     INFO -  1688077388163	Marionette	DEBUG	10 <- [1,57,null,{"value":"textarea"}]
[task 2023-06-29T22:23:08.164Z] 22:23:08     INFO -  1688077388163	Marionette	DEBUG	10 -> [0,58,"WebDriver:GetElementProperty",{"id":"d3765916-b7fa-4a69-a8d4-9b626dedb32c","name":"value"}]
[task 2023-06-29T22:23:08.165Z] 22:23:08     INFO -  1688077388165	Marionette	DEBUG	10 <- [1,58,null,{"value":"ABCDEFGHI!"}]
[task 2023-06-29T22:23:08.166Z] 22:23:08     INFO -  1688077388165	Marionette	DEBUG	10 -> [0,59,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:08.166Z] 22:23:08     INFO -  1688077388166	Marionette	DEBUG	10 <- [1,59,null,{"value":"content"}]
[task 2023-06-29T22:23:08.167Z] 22:23:08     INFO -  1688077388166	Marionette	DEBUG	10 -> [0,60,"Marionette:SetContext",{"value":"chrome"}]
[task 2023-06-29T22:23:08.167Z] 22:23:08     INFO -  1688077388166	Marionette	DEBUG	10 <- [1,60,null,{"value":null}]
[task 2023-06-29T22:23:08.168Z] 22:23:08     INFO -  1688077388167	Marionette	DEBUG	10 -> [0,61,"WebDriver:TakeScreenshot",{"id":null,"full":true,"hash":false,"scroll":true}]
[task 2023-06-29T22:23:08.174Z] 22:23:08     INFO -  [Child 3304, Main Thread] WARNING: '!aContent->GetComposedDoc()', file /builds/worker/checkouts/gecko/layout/base/nsCSSFrameConstructor.cpp:8492
[task 2023-06-29T22:23:08.190Z] 22:23:08     INFO -  [GFX3-]: Creating null Skia image from null SourceSurface
[task 2023-06-29T22:23:08.192Z] 22:23:08     INFO -  [GFX3-]: Creating null Skia image from null SourceSurface
[task 2023-06-29T22:23:08.202Z] 22:23:08     INFO -  [GFX3-]: Creating null Skia image from null SourceSurface
[task 2023-06-29T22:23:08.224Z] 22:23:08     INFO -  1688077388223	Marionette	DEBUG	10 <- [1,61,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAO3CAYAAAB8++kAAAAgAElEQVR4XuydB3xUxRaHT3oIvVfpVQGlCqIUKSooYH2iKNJsoGLB/gSxYu8FAbvYAEFRmg9EuiBFU ... IECBAgAABAgQIECBAgAABAhkBB2BmCkUIECBAgAABAgQIECBAgAABAgQI/AUcgH9TiQQIECBAgAABAgQIECBAgAABAgQyAgOYYkj+oA2WNAAAAABJRU5ErkJggg=="}]
[task 2023-06-29T22:23:08.230Z] 22:23:08     INFO -  1688077388230	Marionette	DEBUG	10 -> [0,62,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:08.231Z] 22:23:08     INFO -  1688077388230	Marionette	DEBUG	10 <- [1,62,null,{"value":null}]
[task 2023-06-29T22:23:08.231Z] 22:23:08     INFO -  1688077388231	Marionette	DEBUG	10 -> [0,63,"Marionette:GetContext",{}]
[task 2023-06-29T22:23:08.231Z] 22:23:08     INFO -  1688077388231	Marionette	DEBUG	10 <- [1,63,null,{"value":"content"}]
[task 2023-06-29T22:23:08.232Z] 22:23:08     INFO -  1688077388232	Marionette	DEBUG	10 -> [0,64,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:08.232Z] 22:23:08     INFO -  1688077388232	Marionette	DEBUG	10 <- [1,64,null,{"value":null}]
[task 2023-06-29T22:23:08.233Z] 22:23:08     INFO -  1688077388233	Marionette	DEBUG	10 -> [0,65,"WebDriver:GetPageSource",{}]
[task 2023-06-29T22:23:08.235Z] 22:23:08     INFO -  1688077388234	Marionette	DEBUG	10 <- [1,65,null,{"value":"<html id=\"html\"><head>\n    <title>Marionette tests for AccessibleCaret in cursor mode</title>\n    <style>\n    .block {\n       ... ea>\n    </div>\n    <br>\n    <div class=\"block\" contenteditable=\"true\" id=\"contenteditable\">ABCDEFGHI</div>\n  \n\n</body></html>"}]
[task 2023-06-29T22:23:08.235Z] 22:23:08     INFO -  1688077388235	Marionette	DEBUG	10 -> [0,66,"Marionette:SetContext",{"value":"content"}]
[task 2023-06-29T22:23:08.235Z] 22:23:08     INFO -  1688077388235	Marionette	DEBUG	10 <- [1,66,null,{"value":null}]
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO - TEST-UNEXPECTED-FAIL | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_caret_not_jump_when_dragging_to_editable_content_boundary_textarea_one_line | AssertionError: 'ABCDEFGHI!' == 'ABCDEFGHI!'
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO - Traceback (most recent call last):
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -   File "/opt/worker/tasks/task_168807517740747/build/venv/lib/python3.7/site-packages/marionette_harness/marionette_test/testcases.py", line 198, in run
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -     testMethod()
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -   File "/opt/worker/tasks/task_168807517740747/build/venv/lib/python3.7/site-packages/marionette_harness/marionette_test/testcases.py", line 48, in wrapper
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -     return func(self, *args, **kwargs)
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -   File "/opt/worker/tasks/task_168807517740747/build/tests/marionette/tests/layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py", line 196, in test_caret_not_jump_when_dragging_to_editable_content_boundary
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -     self.assertNotEqual(non_target_content, sel.content)
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO - TEST-INFO took 789ms
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -  1688077388244	Marionette	DEBUG	10 -> [0,67,"WebDriver:ReleaseActions",{}]
[task 2023-06-29T22:23:08.302Z] 22:23:08     INFO -  1688077388245	Marionette	DEBUG	10 <- [1,67,null,{"value":null}]
[task 2023-06-29T22:23:08.303Z] 22:23:08     INFO -  1688077388246	Marionette	DEBUG	10 -> [0,68,"WebDriver:DeleteSession",{}]
[task 2023-06-29T22:23:08.303Z] 22:23:08     INFO -  1688077388247	Marionette	TRACE	[2] MarionetteCommands actor destroyed for window id 4
[task 2023-06-29T22:23:08.303Z] 22:23:08     INFO -  1688077388247	Marionette	TRACE	[12] MarionetteCommands actor destroyed for window id 6442450953
[task 2023-06-29T22:23:08.303Z] 22:23:08     INFO -  1688077388248	Marionette	DEBUG	10 <- [1,68,null,{"value":null}]
[task 2023-06-29T22:23:08.303Z] 22:23:08     INFO - TEST-START | layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_drag_caret_from_front_to_end_across_columns
Summary: Intermittent layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py AccessibleCaretCursorModeTestCase.test_caret_not_jump_when_dragging_to_editable_content_boundary_textarea_one_line | AssertionError: 'ABCDEFGHI!' == 'ABCDEFGHI!' → Intermittent layout/base/tests/marionette/test_accessiblecaret_cursor_mode.py | single tracking bug
Duplicate of this bug: 1772444
Duplicate of this bug: 1681430
Duplicate of this bug: 1771784
Attachment #9387378 - Attachment is obsolete: true

There have been 34 total failures in the last 7 days.
There are:

  • 23 failures on macOS 14.70 x64 debug
  • 4 failures on Linux 18.04 x64 WebRender debug
  • 4 failures on macOS 14.70 x64 opt

Recent failure log.

Hi Holbert! Could you please take a loot at this?

Flags: needinfo?(dholbert)

I'll pass the needinfo along to TYLin who knows the most about this accessiblecaret test & functionality.

Flags: needinfo?(dholbert) → needinfo?(aethanyc)

I'll pass the needinfo along to TYLin who knows the most about this accessiblecaret test & functionality.

Filed bug 1939620 to reduce the intermittent failures.

Flags: needinfo?(aethanyc)
Whiteboard: [stockwell disable-recommended]
Whiteboard: [stockwell disable-recommended]
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: