Closed Bug 1547891 Opened 7 years ago Closed 6 years ago

Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.<random> | MoveTargetOutOfBoundsException: (<random>, <random>) is out of bounds of viewport width (640) and height (0)

Categories

(Testing :: Marionette Client and Harness, defect, P5)

Product:
Testing
Component:
Marionette Client and Harness
Version:
Version 3
Platform:
x86_64
Android
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, regression)

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

[task 2019-04-30T01:05:15.368Z] 01:05:15 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.test_click_element_larger_than_viewport_with_center_point_inside
[task 2019-04-30T01:05:16.459Z] 01:05:16 WARNING - TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.test_click_element_larger_than_viewport_with_center_point_inside | MoveTargetOutOfBoundsException: (488, 8) is out of bounds of viewport width (640) and height (0)
[task 2019-04-30T01:05:16.459Z] 01:05:16 INFO - stacktrace:
[task 2019-04-30T01:05:16.460Z] 01:05:16 INFO - WebDriverError@chrome://marionette/content/error.js:179:5
[task 2019-04-30T01:05:16.461Z] 01:05:16 INFO - MoveTargetOutOfBoundsError@chrome://marionette/content/error.js:367:5
[task 2019-04-30T01:05:16.461Z] 01:05:16 INFO - dispatchPointerMove/<@chrome://marionette/content/action.js:1342:13
[task 2019-04-30T01:05:16.463Z] 01:05:16 INFO - dispatchPointerMove@chrome://marionette/content/action.js:1333:10
[task 2019-04-30T01:05:16.467Z] 01:05:16 INFO - toEvents/<@chrome://marionette/content/action.js:1114:16
[task 2019-04-30T01:05:16.467Z] 01:05:16 INFO - action.dispatchTickActions@chrome://marionette/content/action.js:1024:35
[task 2019-04-30T01:05:16.468Z] 01:05:16 INFO - action.dispatch/chainEvents<@chrome://marionette/content/action.js:993:20
[task 2019-04-30T01:05:16.468Z] 01:05:16 INFO - action.dispatch@chrome://marionette/content/action.js:998:5
[task 2019-04-30T01:05:16.470Z] 01:05:16 INFO - performActions@chrome://marionette/content/listener.js:773:16
[task 2019-04-30T01:05:16.471Z] 01:05:16 INFO - dispatch/</req<@chrome://marionette/content/listener.js:482:14
[task 2019-04-30T01:05:16.472Z] 01:05:16 INFO - dispatch/<@chrome://marionette/content/listener.js:475:15
[task 2019-04-30T01:05:16.472Z] 01:05:16 INFO - Traceback (most recent call last):
[task 2019-04-30T01:05:16.472Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 159, in run
[task 2019-04-30T01:05:16.473Z] 01:05:16 INFO - testMethod()
[task 2019-04-30T01:05:16.473Z] 01:05:16 INFO - File "/builds/worker/workspace/build/tests/marionette/tests/testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py", line 148, in test_click_element_larger_than_viewport_with_center_point_inside
[task 2019-04-30T01:05:16.474Z] 01:05:16 INFO - self.mouse_chain.click(element=elem).perform()
[task 2019-04-30T01:05:16.474Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 74, in perform
[task 2019-04-30T01:05:16.474Z] 01:05:16 INFO - self.marionette.actions.perform([self.dict])
[task 2019-04-30T01:05:16.475Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 182, in perform
[task 2019-04-30T01:05:16.475Z] 01:05:16 INFO - return self.marionette._send_message("WebDriver:PerformActions", body)
[task 2019-04-30T01:05:16.476Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2019-04-30T01:05:16.476Z] 01:05:16 INFO - return func(*args, **kwargs)
[task 2019-04-30T01:05:16.477Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 598, in _send_message
[task 2019-04-30T01:05:16.477Z] 01:05:16 INFO - self._handle_error(err)
[task 2019-04-30T01:05:16.477Z] 01:05:16 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 618, in _handle_error
[task 2019-04-30T01:05:16.478Z] 01:05:16 INFO - raise errors.lookup(error)(message, stacktrace=stacktrace)
[task 2019-04-30T01:05:16.488Z] 01:05:16 INFO - TEST-INFO took 1089ms

MoveTargetOutOfBoundsException: (488, 8) is out of bounds of viewport width (640) and height (0)

Viewport of height 0? There is something totally wrong with the browser window. Here the excerpt from the Android logcat:

04-30 02:02:27.460 2393 2410 I Gecko : 1556586147460 Marionette TRACE [887] Received DOM event beforeunload for http://172.17.0.9:44585/keyboard.html
04-30 02:02:27.460 2393 2393 I GeckoTabs: zerdatime 1052520 - page load start
04-30 02:02:27.460 2393 2393 D GeckoToolbar: onTabChanged: START
04-30 02:02:27.460 2393 2393 D GeckoBrowserApp: BrowserApp.onTabChanged: 55: START
04-30 02:02:27.470 2393 2410 D GeckoViewAutoFill: Clearing auto-fill
04-30 02:02:27.470 2393 2410 I Gecko : 1556586147470 Marionette TRACE [887] Received DOM event pagehide for http://172.17.0.9:44585/keyboard.html
04-30 02:02:27.480 2393 2410 D GeckoViewAutoFill: Auto-fill focus on null
04-30 02:02:27.480 2393 2410 I Gecko : 1556586147480 Marionette TRACE [887] Received DOM event unload for http://172.17.0.9:44585/keyboard.html
04-30 02:02:27.500 2393 2393 D GeckoToolbar: onTabChanged: TITLE
04-30 02:02:27.500 2393 2393 D GeckoBrowserApp: BrowserApp.onTabChanged: 55: TITLE
04-30 02:02:27.530 2393 2393 D GeckoToolbar: onTabChanged: LOCATION_CHANGE
04-30 02:02:27.530 2393 2393 D GeckoBrowserApp: BrowserApp.onTabChanged: 55: LOCATION_CHANGE
04-30 02:02:27.560 2393 2410 W GeckoEventDispatcher: No listener for Website:AppLeft
04-30 02:02:27.640 1382 1382 W InputMethodService: Window size has been changed. This may cause jankiness of resizing window: -1 -> -2
04-30 02:02:27.640 1382 1382 I LatinIME: Starting input. Cursor position = 0,0
04-30 02:02:27.710 2393 2410 I Gecko : 1556586147710 Marionette TRACE [887] Received DOM event DOMContentLoaded for data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%3Cdiv%20id%3D%22div%22%20style%3D%22width%3A%20150vw%3B%20heig ... lick%3D%22window.click_x%20%3D%20event.clientX%3B%20window.click_y%20%3D%20event.clientY%22%20/%3E%0A%20%20%20%20%20%20%20%20
04-30 02:02:27.750 2393 2410 I Gecko : 1556586147720 Marionette TRACE [887] Received DOM event pageshow for data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%3Cdiv%20id%3D%22div%22%20style%3D%22width%3A%20150vw%3B%20heig ... lick%3D%22window.click_x%20%3D%20event.clientX%3B%20window.click_y%20%3D%20event.clientY%22%20/%3E%0A%20%20%20%20%20%20%20%20
04-30 02:02:27.790 2393 2410 I Gecko : 1556586147790 Marionette DEBUG 780 <- [1,2,null,{"value":null}]
04-30 02:02:27.810 2393 2410 I Gecko : 1556586147810 Marionette DEBUG 780 -> [0,3,"WebDriver:FindElement",{"using":"id","value":"div"}]
04-30 02:02:27.810 1309 1330 I WindowManager: Destroying surface Surface(name=InputMethod) called by com.android.server.wm.WindowStateAnimator.destroySurface:2014 com.android.server.wm.WindowStateAnimator.destroySurfaceLocked:881 com.android.server.wm.WindowState.destroyOrSaveSurface:2073 com.android.server.wm.WindowSurfacePlacer.performSurfacePlacementInner:429 com.android.server.wm.WindowSurfacePlacer.performSurfacePlacementLoop:232 com.android.server.wm.WindowSurfacePlacer.performSurfacePlacement:180 com.android.server.wm.WindowManagerService$H.handleMessage:8079 android.os.Handler.dispatchMessage:102
04-30 02:02:27.840 2393 2410 I Gecko : 1556586147840 Marionette DEBUG 780 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"999e089b-e122-4a77-8129-40fa7cf67aeb"}}]
04-30 02:02:27.840 2393 2410 I Gecko : 1556586147840 Marionette DEBUG 780 -> [0,4,"WebDriver:GetElementRect",{"id":"999e089b-e122-4a77-8129-40fa7cf67aeb"}]
04-30 02:02:27.850 2393 2410 I Gecko : 1556586147850 Marionette DEBUG 780 <- [1,4,null,{"x":8,"y":8,"width":960,"height":0}]
04-30 02:02:27.860 2393 2410 I Gecko : 1556586147860 Marionette DEBUG 780 -> [0,5,"WebDriver:GetElementRect",{"id":"999e089b-e122-4a77-8129-40fa7cf67aeb"}]
04-30 02:02:27.870 2393 2410 I Gecko : 1556586147870 Marionette DEBUG 780 <- [1,5,null,{"x":8,"y":8,"width":960,"height":0}]
04-30 02:02:27.870 2393 2410 I Gecko : 1556586147870 Marionette DEBUG 780 -> [0,6,"WebDriver:GetElementRect",{"id":"999e089b-e122-4a77-8129-40fa7cf67aeb"}]
04-30 02:02:27.900 2393 2410 I Gecko : 1556586147900 Marionette DEBUG 780 <- [1,6,null,{"x":8,"y":8,"width":960,"height":0}]
04-30 02:02:27.910 2393 2410 I Gecko : 1556586147910 Marionette DEBUG 780 -> [0,7,"WebDriver:GetElementRect",{"id":"999e089b-e122-4a77-8129-40fa7cf67aeb"}]
04-30 02:02:27.910 2393 2410 I Gecko : 1556586147910 Marionette DEBUG 780 <- [1,7,null,{"x":8,"y":8,"width":960,"height":0}]
04-30 02:02:27.920 2393 2410 I Gecko : 1556586147920 Marionette DEBUG 780 -> [0,8,"WebDriver:PerformActions",{"actions":[{"parameters":{"pointerType":"mouse"},"type":"pointer","id":"pointer_id","actions ... 4f735466cecf":"999e089b-e122-4a77-8129-40fa7cf67aeb"}},{"button":0,"type":"pointerDown"},{"button":0,"type":"pointerUp"}]}]}]
04-30 02:02:27.950 2393 2410 I Gecko : 1556586147950 Marionette DEBUG 780 <- [1,8,{"error":"move target out of bounds","message":"(488, 8) is out of bounds of viewport width (640) and height (0)","stack ... ch/</req<@chrome://marionette/content/listener.js:482:14\ndispatch/<@chrome://marionette/content/listener.js:475:15\n"},null]

OS: Unspecified → Android
Hardware: Unspecified → x86_64
Summary: Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.test_click_element_larger_than_viewport_with_center_point_inside | MoveTargetOutOfBoundsException: (488, 8) is out of bounds of vi → Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.<random> | MoveTargetOutOfBoundsException: (x, y) is out of bounds of viewport width (640) and height (0)

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Summary: Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.<random> | MoveTargetOutOfBoundsException: (x, y) is out of bounds of viewport width (640) and height (0) → Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_mouse_action.py TestNonSpecCompliantPointerOrigin.<random> | MoveTargetOutOfBoundsException: (<random>, <random>) is out of bounds of viewport width (640) and height (0)

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: REOPENED → RESOLVED
Closed: 6 years ago → 6 years ago
Resolution: --- → INCOMPLETE
Product: Testing → Remote Protocol
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in before you can comment on or make changes to this bug.