Closed
Bug 1665487
Opened 4 years ago
Closed 4 years ago
Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_click.py TestClickNavigation.test_click_link_anchor | AssertionError: u'http://127.0.0.1:46178/clicks.html ' != 'http://127.0.0.1:46178/clicks.html #'
Categories
(Testing :: Marionette Client and Harness, defect, P5)
Testing
Marionette Client and Harness
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1665141
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: assertion, intermittent-failure)
Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=315855736&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Ll-dwriNTqiEHiLcjG6eeA/runs/0/artifacts/public/logs/live_backing.log
[task 2020-09-16T16:24:10.049Z] 16:24:10 INFO - TEST-PASS | testing/marionette/harness/marionette_harness/tests/unit/test_click.py TestClickCloseContext.test_click_close_window | took 1216ms
[task 2020-09-16T16:24:10.050Z] 16:24:10 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_click.py TestClickNavigation.test_click_link_anchor
[task 2020-09-16T16:24:10.051Z] 16:24:10 INFO - 1600273450044 Marionette DEBUG 205 <- [1,28,null,{"value":null}]
[task 2020-09-16T16:24:10.054Z] 16:24:10 INFO - 1600273450049 Marionette DEBUG Closed connection 205
[task 2020-09-16T16:24:10.055Z] 16:24:10 INFO - 1600273450051 Marionette DEBUG Accepted connection 206 from 127.0.0.1:40452
[task 2020-09-16T16:24:10.059Z] 16:24:10 INFO - 1600273450056 Marionette DEBUG 206 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2020-09-16T16:24:10.064Z] 16:24:10 INFO - 1600273450059 Marionette TRACE [17] Frame script loaded
[task 2020-09-16T16:24:10.071Z] 16:24:10 INFO - 1600273450066 Marionette DEBUG 206 <- [1,1,null,{"sessionId":"0d7e8e10-8af0-4f07-8dd8-e72ff86b3357","capabilities":{"browserName":"firefox","browserVersion":"82.0a ... mp/tmpl7DDZU.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2020-09-16T16:24:10.071Z] 16:24:10 INFO - 1600273450067 Marionette DEBUG 206 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2020-09-16T16:24:10.071Z] 16:24:10 INFO - 1600273450068 Marionette DEBUG 206 <- [1,2,null,{"value":null}]
[task 2020-09-16T16:24:10.071Z] 16:24:10 INFO - 1600273450069 Marionette DEBUG 206 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2020-09-16T16:24:10.071Z] 16:24:10 INFO - 1600273450070 Marionette DEBUG 206 <- [1,3,null,{"value":null}]
[task 2020-09-16T16:24:10.074Z] 16:24:10 INFO - 1600273450071 Marionette DEBUG 206 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2020-09-16T16:24:10.075Z] 16:24:10 INFO - 1600273450072 Marionette DEBUG 206 <- [1,4,null,{"value":null}]
[task 2020-09-16T16:24:10.075Z] 16:24:10 INFO - 1600273450073 Marionette DEBUG 206 -> [0,5,"WebDriver:Navigate",{"url":"http://127.0.0.1:46178/clicks.html"}]
[task 2020-09-16T16:24:10.090Z] 16:24:10 INFO - 1600273450081 Marionette TRACE Received message beforeunload for data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%3Ctable%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Ctr%3E%3Ctd ... 20%20%20%20%20%20%20foo%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/td%3E%3C/tr%3E%0A%20%20%20%20%20%20%20%20%20%20%3C/table%3E
[task 2020-09-16T16:24:10.110Z] 16:24:10 INFO - 1600273450107 Marionette TRACE Received message pagehide for data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%3Ctable%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Ctr%3E%3Ctd ... 20%20%20%20%20%20%20foo%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/td%3E%3C/tr%3E%0A%20%20%20%20%20%20%20%20%20%20%3C/table%3E
[task 2020-09-16T16:24:10.166Z] 16:24:10 INFO - 1600273450159 Marionette TRACE Received message DOMContentLoaded for http://127.0.0.1:46178/clicks.html
[task 2020-09-16T16:24:10.168Z] 16:24:10 INFO - 1600273450159 Marionette TRACE Received message pageshow for http://127.0.0.1:46178/clicks.html
[task 2020-09-16T16:24:10.168Z] 16:24:10 INFO - 1600273450162 Marionette DEBUG 206 <- [1,5,null,{"value":null}]
[task 2020-09-16T16:24:10.190Z] 16:24:10 INFO - 1600273450187 Marionette DEBUG 206 -> [0,6,"WebDriver:FindElement",{"using":"id","value":"anchor"}]
[task 2020-09-16T16:24:10.198Z] 16:24:10 INFO - 1600273450192 Marionette DEBUG 206 <- [1,6,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f3eb4b89-a517-4e02-9267-80739c553465"}}]
[task 2020-09-16T16:24:10.206Z] 16:24:10 INFO - 1600273450202 Marionette DEBUG 206 -> [0,7,"WebDriver:ElementClick",{"id":"f3eb4b89-a517-4e02-9267-80739c553465"}]
[task 2020-09-16T16:24:10.443Z] 16:24:10 INFO - 1600273450439 Marionette TRACE Canceled page load listener because no navigation has been detected
[task 2020-09-16T16:24:10.444Z] 16:24:10 INFO - 1600273450440 Marionette DEBUG 206 <- [1,7,null,{"value":null}]
[task 2020-09-16T16:24:10.445Z] 16:24:10 INFO - 1600273450441 Marionette DEBUG 206 -> [0,8,"WebDriver:GetCurrentURL",{}]
[task 2020-09-16T16:24:10.485Z] 16:24:10 INFO - [Child 2085, Main Thread] WARNING: NS_ENSURE_TRUE(info) failed: file /builds/worker/checkouts/gecko/extensions/permissions/PermissionDelegateHandler.cpp, line 348
[task 2020-09-16T16:24:10.488Z] 16:24:10 INFO - 1600273450485 Marionette DEBUG 206 <- [1,8,null,{"value":"http://127.0.0.1:46178/clicks.html"}]
[task 2020-09-16T16:24:10.504Z] 16:24:10 INFO - DEBUG: Adding blocker UserInteractionTimer 23 for document 7f9a03c33000 for phase xpcom-will-shutdown
[task 2020-09-16T16:24:10.512Z] 16:24:10 INFO - 1600273450509 Marionette DEBUG 206 -> [0,9,"Marionette:GetContext",{}]
[task 2020-09-16T16:24:10.513Z] 16:24:10 INFO - 1600273450510 Marionette DEBUG 206 <- [1,9,null,{"value":"content"}]
[task 2020-09-16T16:24:10.514Z] 16:24:10 INFO - 1600273450512 Marionette DEBUG 206 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2020-09-16T16:24:10.515Z] 16:24:10 INFO - 1600273450512 Marionette DEBUG 206 <- [1,10,null,{"value":null}]
[task 2020-09-16T16:24:10.518Z] 16:24:10 INFO - 1600273450514 Marionette DEBUG 206 -> [0,11,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2020-09-16T16:24:10.594Z] 16:24:10 INFO - 1600273450584 Marionette DEBUG 206 <- [1,11,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQQCAYAAAC9RfbYAAAgAElEQVR4nOzd3XNc930naFxOVS6Aq5mq/R9S2K3adW44NReb2itpkJ28 ... AAAADCBEAAAAAACBMAAQAAACBMAAQAAACAMAEQAAAAAMIEQAAAAAAIEwABAAAAIEwABAAAAIAwARAAAAAAwgRAAAAAAAj7B6tXbnANh6W8AAAAAElFTkSuQmCC"}]
[task 2020-09-16T16:24:10.597Z] 16:24:10 INFO - 1600273450591 Marionette DEBUG 206 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-16T16:24:10.600Z] 16:24:10 INFO - 1600273450592 Marionette DEBUG 206 <- [1,12,null,{"value":null}]
[task 2020-09-16T16:24:10.600Z] 16:24:10 INFO - 1600273450593 Marionette DEBUG 206 -> [0,13,"Marionette:GetContext",{}]
[task 2020-09-16T16:24:10.600Z] 16:24:10 INFO - 1600273450593 Marionette DEBUG 206 <- [1,13,null,{"value":"content"}]
[task 2020-09-16T16:24:10.600Z] 16:24:10 INFO - 1600273450595 Marionette DEBUG 206 -> [0,14,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-16T16:24:10.601Z] 16:24:10 INFO - 1600273450595 Marionette DEBUG 206 <- [1,14,null,{"value":null}]
[task 2020-09-16T16:24:10.603Z] 16:24:10 INFO - 1600273450598 Marionette DEBUG 206 -> [0,15,"WebDriver:GetPageSource",{}]
[task 2020-09-16T16:24:10.607Z] 16:24:10 INFO - 1600273450603 Marionette DEBUG 206 <- [1,15,null,{"value":"<html><head>\n <!-- This Source Code Form is subject to the terms of the Mozilla Public\n - License ... <a id=\"overflowLink\" href=\"test.html\">looooooooooong short looooooooooong</a>\n </p>\n</div>\n\n\n\n</body></html>"}]
[task 2020-09-16T16:24:10.630Z] 16:24:10 INFO - TEST-UNEXPECTED-FAIL | testing/marionette/harness/marionette_harness/tests/unit/test_click.py TestClickNavigation.test_click_link_anchor | AssertionError: u'http://127.0.0.1:46178/clicks.html' != 'http://127.0.0.1:46178/clicks.html#'
[task 2020-09-16T16:24:10.631Z] 16:24:10 INFO - Traceback (most recent call last):
[task 2020-09-16T16:24:10.632Z] 16:24:10 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 196, in run
[task 2020-09-16T16:24:10.632Z] 16:24:10 INFO - testMethod()
[task 2020-09-16T16:24:10.632Z] 16:24:10 INFO - File "/builds/worker/workspace/build/tests/marionette/tests/testing/marionette/harness/marionette_harness/tests/unit/test_click.py", line 413, in test_click_link_anchor
[task 2020-09-16T16:24:10.632Z] 16:24:10 INFO - self.assertEqual(self.marionette.get_url(), "{}#".format(self.test_page))
[task 2020-09-16T16:24:10.632Z] 16:24:10 INFO - TEST-INFO took 559ms
[task 2020-09-16T16:24:10.633Z] 16:24:10 INFO - 1600273450604 Marionette DEBUG 206 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2020-09-16T16:24:10.633Z] 16:24:10 INFO - 1600273450604 Marionette DEBUG 206 <- [1,16,null,{"value":null}]
[task 2020-09-16T16:24:10.634Z] 16:24:10 INFO - 1600273450611 Marionette DEBUG 206 -> [0,17,"WebDriver:DeleteSession",{}]
[task 2020-09-16T16:24:10.634Z] 16:24:10 INFO - 1600273450615 Marionette DEBUG 206 <- [1,17,null,{"value":null}]```
| Comment hidden (Intermittent Failures Robot) |
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → DUPLICATE
|
||
Updated•2 years ago
|
Product: Testing → Remote Protocol
|
|
||
Comment 3•2 years ago
|
||
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.
Description
•