could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:01:29 INFO - 1499965289743 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:01:29 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499965289745 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:01:29 INFO - 1499965289746 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:01:29 INFO - 1499965289747 Marionette TRACE 352 <- [1,6,null,{}]
10:01:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 145ms
10:01:29 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:01:29 INFO - 1499965289749 Marionette DEBUG Closed connection 352
10:01:29 INFO - 1499965289750 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49756
10:01:29 INFO - 1499965289751 Marionette DEBUG Closed connection 353
10:01:29 INFO - 1499965289752 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49757
10:01:29 INFO - 1499965289753 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:29 INFO - 1499965289753 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289755 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289758 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d9f6ebac-c1e5-42d9-afbe-aad6d7490474","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289760 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:01:29 INFO - 1499965289760 Marionette TRACE 354 <- [1,2,null,{}]
10:01:29 INFO - 1499965289761 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:29 INFO - 1499965289762 Marionette TRACE 354 <- [1,3,null,{}]
10:01:29 INFO - 1499965289763 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:29 INFO - 1499965289763 Marionette TRACE 354 <- [1,4,null,{}]
10:01:29 INFO - 1499965289764 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:01:29 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499965289766 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:01:29 INFO - 1499965289767 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:01:29 INFO - 1499965289768 Marionette TRACE 354 <- [1,6,null,{}]
10:01:29 INFO - 1499965289770 Marionette DEBUG Closed connection 354
10:01:29 INFO - 1499965289771 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49758
10:01:29 INFO - 1499965289771 Marionette DEBUG Closed connection 355
10:01:29 INFO - 1499965289772 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49759
10:01:29 INFO - 1499965289773 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:29 INFO - 1499965289773 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289775 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289778 Marionette TRACE 356 <- [1,1,null,{"sessionId":"aeb27623-3fae-4d55-813e-428ca8d5213c","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289780 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:01:29 INFO - 1499965289781 Marionette TRACE 356 <- [1,2,null,{}]
10:01:29 INFO - 1499965289783 Marionette DEBUG Closed connection 356
10:01:29 INFO - 1499965289783 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49760
10:01:29 INFO - 1499965289784 Marionette DEBUG Closed connection 357
10:01:29 INFO - 1499965289784 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49761
10:01:29 INFO - 1499965289785 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:29 INFO - 1499965289786 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289788 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289790 Marionette TRACE 358 <- [1,1,null,{"sessionId":"909448c4-d374-4a96-9b8d-ff0fda99ee52","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289792 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49323/clicks.html"}]
10:01:29 INFO - 1499965289793 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/hidden.html"
10:01:29 INFO - 1499965289798 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/hidden.html"
10:01:29 INFO - 1499965289798 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/hidden.html"
10:01:29 INFO - 1499965289814 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/clicks.html"
10:01:29 INFO - 1499965289820 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/clicks.html"
10:01:29 INFO - 1499965289823 Marionette TRACE 358 <- [1,2,null,{}]
10:01:29 INFO - 1499965289824 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:01:29 INFO - 1499965289827 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6efc75e2-87f5-45e6-8551-5b49b707eed7","ELEMENT":"6efc75e2-87f5-45e6-8551-5b49b707eed7"}}]
10:01:29 INFO - 1499965289827 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"6efc75e2-87f5-45e6-8551-5b49b707eed7"}]
10:01:29 INFO - 1499965289872 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/clicks.html"
10:01:29 INFO - 1499965289876 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/clicks.html"
10:01:29 INFO - 1499965289877 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/clicks.html"
10:01:29 INFO - 1499965289892 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/test.html"
10:01:29 INFO - 1499965289895 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/test.html"
10:01:29 INFO - 1499965289897 Marionette TRACE 358 <- [1,4,null,{}]
10:01:29 INFO - 1499965289898 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:01:29 INFO - 1499965289906 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8d8602b3-3c30-48be-8f6c-0ad9153aee40","ELEMENT":"8d8602b3-3c30-48be-8f6c-0ad9153aee40"}}]
10:01:29 INFO - 1499965289907 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:01:29 INFO - 1499965289907 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:01:29 INFO - 1499965289909 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:01:29 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499965289911 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:01:29 INFO - 1499965289912 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:01:29 INFO - 1499965289913 Marionette TRACE 358 <- [1,8,null,{}]
10:01:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 164ms
10:01:29 INFO - TEST-START | test_click.py TestClick.test_container_element
10:01:29 INFO - 1499965289915 Marionette DEBUG Closed connection 358
10:01:29 INFO - 1499965289916 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49764
10:01:29 INFO - 1499965289917 Marionette DEBUG Closed connection 359
10:01:29 INFO - 1499965289918 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49765
10:01:29 INFO - 1499965289918 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:29 INFO - 1499965289919 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289921 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289923 Marionette TRACE 360 <- [1,1,null,{"sessionId":"72c1cf7f-8545-4dc2-b351-cee61a03a831","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289925 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:01:29 INFO - 1499965289926 Marionette TRACE 360 <- [1,2,null,{}]
10:01:29 INFO - 1499965289926 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:29 INFO - 1499965289927 Marionette TRACE 360 <- [1,3,null,{}]
10:01:29 INFO - 1499965289927 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:29 INFO - 1499965289928 Marionette TRACE 360 <- [1,4,null,{}]
10:01:29 INFO - 1499965289929 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:01:29 INFO - TEST-START: test_click.py TestClick.test_container_element1499965289932 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:01:29 INFO - 1499965289932 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:01:29 INFO - 1499965289933 Marionette TRACE 360 <- [1,6,null,{}]
10:01:29 INFO - 1499965289935 Marionette DEBUG Closed connection 360
10:01:29 INFO - 1499965289936 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49766
10:01:29 INFO - 1499965289936 Marionette DEBUG Closed connection 361
10:01:29 INFO - 1499965289937 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49767
10:01:29 INFO - 1499965289938 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:29 INFO - 1499965289938 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289940 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289943 Marionette TRACE 362 <- [1,1,null,{"sessionId":"6ce0ba92-d900-404a-bb7a-5040f7ecaf32","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289944 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:01:29 INFO - 1499965289945 Marionette TRACE 362 <- [1,2,null,{}]
10:01:29 INFO - 1499965289947 Marionette DEBUG Closed connection 362
10:01:29 INFO - 1499965289948 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49768
10:01:29 INFO - 1499965289948 Marionette DEBUG Closed connection 363
10:01:29 INFO - 1499965289949 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49769
10:01:29 INFO - 1499965289950 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:29 INFO - 1499965289950 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:29 INFO - 1499965289953 Marionette DEBUG Register listener.js for window 15
10:01:29 INFO - 1499965289955 Marionette TRACE 364 <- [1,1,null,{"sessionId":"3a0d6311-e6b5-4adb-93b8-67d5145dc6ad","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:29 INFO - 1499965289957 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:01:29 INFO - 1499965289958 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/test.html"
10:01:29 INFO - 1499965289960 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/test.html"
10:01:29 INFO - 1499965289960 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/test.html"
10:01:29 INFO - 1499965289978 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:29 INFO - 1499965289981 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:29 INFO - 1499965289988 Marionette TRACE 364 <- [1,2,null,{}]
10:01:29 INFO - 1499965289990 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:01:29 INFO - 1499965289992 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"248fd5aa-bbdb-437d-b8c9-1f2fa856759a","ELEMENT":"248fd5aa-bbdb-437d-b8c9-1f2fa856759a"}}]
10:01:29 INFO - 1499965289992 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"248fd5aa-bbdb-437d-b8c9-1f2fa856759a"}]
10:01:30 INFO - 1499965290230 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:01:30 INFO - 1499965290230 Marionette TRACE 364 <- [1,4,null,{}]
10:01:30 INFO - 1499965290231 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"248fd5aa-bbdb-437d-b8c9-1f2fa856759a","name":"selected"}]
10:01:30 INFO - 1499965290236 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:01:30 INFO - 1499965290238 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:01:30 INFO - TEST-END: test_click.py TestClick.test_container_element1499965290240 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:01:30 INFO - 1499965290241 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:01:30 INFO - 1499965290242 Marionette TRACE 364 <- [1,7,null,{}]
10:01:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 328ms
10:01:30 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:01:30 INFO - 1499965290244 Marionette DEBUG Closed connection 364
10:01:30 INFO - 1499965290245 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49770
10:01:30 INFO - 1499965290246 Marionette DEBUG Closed connection 365
10:01:30 INFO - 1499965290246 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49771
10:01:30 INFO - 1499965290247 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290248 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290250 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290252 Marionette TRACE 366 <- [1,1,null,{"sessionId":"f52054a4-52f2-4ef4-b149-e91aca6023da","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290254 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:01:30 INFO - 1499965290255 Marionette TRACE 366 <- [1,2,null,{}]
10:01:30 INFO - 1499965290255 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:30 INFO - 1499965290256 Marionette TRACE 366 <- [1,3,null,{}]
10:01:30 INFO - 1499965290257 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:30 INFO - 1499965290258 Marionette TRACE 366 <- [1,4,null,{}]
10:01:30 INFO - 1499965290259 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:01:30 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499965290261 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:01:30 INFO - 1499965290263 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:01:30 INFO - 1499965290264 Marionette TRACE 366 <- [1,6,null,{}]
10:01:30 INFO - 1499965290265 Marionette DEBUG Closed connection 366
10:01:30 INFO - 1499965290266 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49772
10:01:30 INFO - 1499965290267 Marionette DEBUG Closed connection 367
10:01:30 INFO - 1499965290267 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49773
10:01:30 INFO - 1499965290268 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290269 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290271 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290273 Marionette TRACE 368 <- [1,1,null,{"sessionId":"2616c0d4-0c49-4b5e-9204-9c304d5edf38","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290276 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:01:30 INFO - 1499965290277 Marionette TRACE 368 <- [1,2,null,{}]
10:01:30 INFO - 1499965290278 Marionette DEBUG Closed connection 368
10:01:30 INFO - 1499965290279 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49774
10:01:30 INFO - 1499965290279 Marionette DEBUG Closed connection 369
10:01:30 INFO - 1499965290280 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49775
10:01:30 INFO - 1499965290281 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:30 INFO - 1499965290281 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290290 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290292 Marionette TRACE 370 <- [1,1,null,{"sessionId":"5d55a0c2-eac3-4421-9c25-389d412f5c77","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290294 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:01:30 INFO - 1499965290295 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290297 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290297 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290313 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290316 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290325 Marionette TRACE 370 <- [1,2,null,{}]
10:01:30 INFO - 1499965290327 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:01:30 INFO - 1499965290328 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c7e476ad-3ca7-4993-8cac-1d2d0767337d","ELEMENT":"c7e476ad-3ca7-4993-8cac-1d2d0767337d"}}]
10:01:30 INFO - 1499965290329 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"c7e476ad-3ca7-4993-8cac-1d2d0767337d"}]
10:01:30 INFO - 1499965290566 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:01:30 INFO - 1499965290566 Marionette TRACE 370 <- [1,4,null,{}]
10:01:30 INFO - 1499965290567 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"c7e476ad-3ca7-4993-8cac-1d2d0767337d","name":"selected"}]
10:01:30 INFO - 1499965290571 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:01:30 INFO - 1499965290573 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:01:30 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499965290575 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:01:30 INFO - 1499965290576 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:01:30 INFO - 1499965290577 Marionette TRACE 370 <- [1,7,null,{}]
10:01:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 336ms
10:01:30 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:01:30 INFO - 1499965290579 Marionette DEBUG Closed connection 370
10:01:30 INFO - 1499965290579 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49776
10:01:30 INFO - 1499965290580 Marionette DEBUG Closed connection 371
10:01:30 INFO - 1499965290581 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49777
10:01:30 INFO - 1499965290581 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290582 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290584 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290586 Marionette TRACE 372 <- [1,1,null,{"sessionId":"742bc305-eb7a-4687-a5e6-ce8fc82595ff","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290588 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:01:30 INFO - 1499965290589 Marionette TRACE 372 <- [1,2,null,{}]
10:01:30 INFO - 1499965290589 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:30 INFO - 1499965290590 Marionette TRACE 372 <- [1,3,null,{}]
10:01:30 INFO - 1499965290590 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:30 INFO - 1499965290591 Marionette TRACE 372 <- [1,4,null,{}]
10:01:30 INFO - 1499965290592 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:01:30 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499965290594 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:01:30 INFO - 1499965290595 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:01:30 INFO - 1499965290596 Marionette TRACE 372 <- [1,6,null,{}]
10:01:30 INFO - 1499965290598 Marionette DEBUG Closed connection 372
10:01:30 INFO - 1499965290598 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49778
10:01:30 INFO - 1499965290599 Marionette DEBUG Closed connection 373
10:01:30 INFO - 1499965290600 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49779
10:01:30 INFO - 1499965290601 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290601 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290603 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290606 Marionette TRACE 374 <- [1,1,null,{"sessionId":"e1385163-564f-4f14-9bb4-4d571fe608c8","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290608 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:01:30 INFO - 1499965290609 Marionette TRACE 374 <- [1,2,null,{}]
10:01:30 INFO - 1499965290610 Marionette DEBUG Closed connection 374
10:01:30 INFO - 1499965290611 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49780
10:01:30 INFO - 1499965290611 Marionette DEBUG Closed connection 375
10:01:30 INFO - 1499965290612 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49781
10:01:30 INFO - 1499965290613 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:30 INFO - 1499965290613 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290615 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290618 Marionette TRACE 376 <- [1,1,null,{"sessionId":"3c9139e1-1da5-469c-b2fd-d837f7ec61c2","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290619 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:01:30 INFO - 1499965290621 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290622 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290623 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290633 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:01:30 INFO - 1499965290636 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:01:30 INFO - 1499965290644 Marionette TRACE 376 <- [1,2,null,{}]
10:01:30 INFO - 1499965290647 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:01:30 INFO - 1499965290649 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8f02e121-adc0-4b57-95a0-ed4e98d53993","ELEMENT":"8f02e121-adc0-4b57-95a0-ed4e98d53993"}}]
10:01:30 INFO - 1499965290650 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"8f02e121-adc0-4b57-95a0-ed4e98d53993"}]
10:01:30 INFO - 1499965290891 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:01:30 INFO - 1499965290892 Marionette TRACE 376 <- [1,4,null,{}]
10:01:30 INFO - 1499965290893 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:01:30 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499965290895 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:01:30 INFO - 1499965290896 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:01:30 INFO - 1499965290897 Marionette TRACE 376 <- [1,6,null,{}]
10:01:30 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 320ms
10:01:30 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:01:30 INFO - 1499965290899 Marionette DEBUG Closed connection 376
10:01:30 INFO - 1499965290900 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49782
10:01:30 INFO - 1499965290901 Marionette DEBUG Closed connection 377
10:01:30 INFO - 1499965290901 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49783
10:01:30 INFO - 1499965290902 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290903 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290905 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290907 Marionette TRACE 378 <- [1,1,null,{"sessionId":"bf6b0bbb-3cb2-44ee-8ceb-ff3d5c3e83e0","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290909 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:01:30 INFO - 1499965290910 Marionette TRACE 378 <- [1,2,null,{}]
10:01:30 INFO - 1499965290911 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:30 INFO - 1499965290911 Marionette TRACE 378 <- [1,3,null,{}]
10:01:30 INFO - 1499965290912 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:30 INFO - 1499965290912 Marionette TRACE 378 <- [1,4,null,{}]
10:01:30 INFO - 1499965290914 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:01:30 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499965290916 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:01:30 INFO - 1499965290917 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:01:30 INFO - 1499965290918 Marionette TRACE 378 <- [1,6,null,{}]
10:01:30 INFO - 1499965290920 Marionette DEBUG Closed connection 378
10:01:30 INFO - 1499965290920 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49784
10:01:30 INFO - 1499965290921 Marionette DEBUG Closed connection 379
10:01:30 INFO - 1499965290922 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49785
10:01:30 INFO - 1499965290922 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:30 INFO - 1499965290923 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290925 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290927 Marionette TRACE 380 <- [1,1,null,{"sessionId":"d4525edd-c577-4927-bf3c-b65f8cd63a5c","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290929 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:01:30 INFO - 1499965290930 Marionette TRACE 380 <- [1,2,null,{}]
10:01:30 INFO - 1499965290932 Marionette DEBUG Closed connection 380
10:01:30 INFO - 1499965290932 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49786
10:01:30 INFO - 1499965290933 Marionette DEBUG Closed connection 381
10:01:30 INFO - 1499965290933 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49787
10:01:30 INFO - 1499965290934 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:30 INFO - 1499965290935 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:30 INFO - 1499965290936 Marionette DEBUG Register listener.js for window 15
10:01:30 INFO - 1499965290939 Marionette TRACE 382 <- [1,1,null,{"sessionId":"7ec01d71-9c77-408d-903b-6b7bb36f2d1d","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:30 INFO - 1499965290940 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:01:30 INFO - 1499965290942 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:01:30 INFO - 1499965290943 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:01:30 INFO - 1499965290944 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:01:30 INFO - 1499965290959 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290962 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:30 INFO - 1499965290964 Marionette TRACE 382 <- [1,2,null,{}]
10:01:30 INFO - 1499965290965 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:01:30 INFO - 1499965290973 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"83ad798e-c335-434e-8b60-3725626e39ae","ELEMENT":"83ad798e-c335-434e-8b60-3725626e39ae"}}]
10:01:30 INFO - 1499965290975 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"83ad798e-c335-434e-8b60-3725626e39ae"}]
10:01:31 INFO - 1499965291212 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:01:31 INFO - 1499965291212 Marionette TRACE 382 <- [1,4,null,{}]
10:01:31 INFO - 1499965291214 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:01:31 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499965291216 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:01:31 INFO - 1499965291217 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:01:31 INFO - 1499965291218 Marionette TRACE 382 <- [1,6,null,{}]
10:01:31 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 320ms
10:01:31 INFO - TEST-START | test_click.py TestClick.test_input_file
10:01:31 INFO - 1499965291220 Marionette DEBUG Closed connection 382
10:01:31 INFO - 1499965291221 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49788
10:01:31 INFO - 1499965291221 Marionette DEBUG Closed connection 383
10:01:31 INFO - 1499965291222 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49789
10:01:31 INFO - 1499965291223 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291223 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291225 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291228 Marionette TRACE 384 <- [1,1,null,{"sessionId":"ff5d1a2b-9519-4a88-bb62-20c841d489dd","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291230 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:01:31 INFO - 1499965291230 Marionette TRACE 384 <- [1,2,null,{}]
10:01:31 INFO - 1499965291231 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:31 INFO - 1499965291231 Marionette TRACE 384 <- [1,3,null,{}]
10:01:31 INFO - 1499965291232 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:31 INFO - 1499965291232 Marionette TRACE 384 <- [1,4,null,{}]
10:01:31 INFO - 1499965291234 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:01:31 INFO - TEST-START: test_click.py TestClick.test_input_file1499965291236 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:01:31 INFO - 1499965291237 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:01:31 INFO - 1499965291238 Marionette TRACE 384 <- [1,6,null,{}]
10:01:31 INFO - 1499965291240 Marionette DEBUG Closed connection 384
10:01:31 INFO - 1499965291241 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49790
10:01:31 INFO - 1499965291241 Marionette DEBUG Closed connection 385
10:01:31 INFO - 1499965291242 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49791
10:01:31 INFO - 1499965291243 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291244 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291245 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291248 Marionette TRACE 386 <- [1,1,null,{"sessionId":"fd67a0b0-c5b3-489d-9ab1-6d8b1a3fdcba","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291250 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:01:31 INFO - 1499965291251 Marionette TRACE 386 <- [1,2,null,{}]
10:01:31 INFO - 1499965291252 Marionette DEBUG Closed connection 386
10:01:31 INFO - 1499965291253 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49792
10:01:31 INFO - 1499965291253 Marionette DEBUG Closed connection 387
10:01:31 INFO - 1499965291254 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49793
10:01:31 INFO - 1499965291255 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:31 INFO - 1499965291255 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291257 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291260 Marionette TRACE 388 <- [1,1,null,{"sessionId":"bcf01b57-da7f-42f1-97cf-8bf9be81cc17","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291269 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:01:31 INFO - 1499965291270 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:31 INFO - 1499965291272 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:31 INFO - 1499965291272 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:01:31 INFO - 1499965291280 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:01:31 INFO - 1499965291284 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:01:31 INFO - 1499965291293 Marionette TRACE 388 <- [1,2,null,{}]
10:01:31 INFO - 1499965291295 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:01:31 INFO - 1499965291296 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e3f46d22-5dcb-4cf0-a6c9-01451c672b3a","ELEMENT":"e3f46d22-5dcb-4cf0-a6c9-01451c672b3a"}}]
10:01:31 INFO - 1499965291297 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"e3f46d22-5dcb-4cf0-a6c9-01451c672b3a"}]
10:01:31 INFO - 1499965291321 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:01:31 INFO - 1499965291323 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:01:31 INFO - TEST-END: test_click.py TestClick.test_input_file1499965291325 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:01:31 INFO - 1499965291326 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:01:31 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 108ms
10:01:31 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:01:31 INFO - 1499965291327 Marionette TRACE 388 <- [1,6,null,{}]
10:01:31 INFO - 1499965291329 Marionette DEBUG Closed connection 388
10:01:31 INFO - 1499965291330 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49794
10:01:31 INFO - 1499965291331 Marionette DEBUG Closed connection 389
10:01:31 INFO - 1499965291331 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49795
10:01:31 INFO - 1499965291332 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291333 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291335 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291337 Marionette TRACE 390 <- [1,1,null,{"sessionId":"206718f4-e37b-4249-b47d-547887aefb36","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291339 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:01:31 INFO - 1499965291339 Marionette TRACE 390 <- [1,2,null,{}]
10:01:31 INFO - 1499965291340 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:31 INFO - 1499965291340 Marionette TRACE 390 <- [1,3,null,{}]
10:01:31 INFO - 1499965291341 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:31 INFO - 1499965291342 Marionette TRACE 390 <- [1,4,null,{}]
10:01:31 INFO - 1499965291343 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:01:31 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499965291345 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:01:31 INFO - 1499965291346 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:01:31 INFO - 1499965291347 Marionette TRACE 390 <- [1,6,null,{}]
10:01:31 INFO - 1499965291349 Marionette DEBUG Closed connection 390
10:01:31 INFO - 1499965291349 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49796
10:01:31 INFO - 1499965291350 Marionette DEBUG Closed connection 391
10:01:31 INFO - 1499965291351 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49797
10:01:31 INFO - 1499965291351 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291352 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291354 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291356 Marionette TRACE 392 <- [1,1,null,{"sessionId":"3a97e3d9-8b8d-475d-809b-14e3e1692614","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291358 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:01:31 INFO - 1499965291359 Marionette TRACE 392 <- [1,2,null,{}]
10:01:31 INFO - 1499965291361 Marionette DEBUG Closed connection 392
10:01:31 INFO - 1499965291361 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49798
10:01:31 INFO - 1499965291362 Marionette DEBUG Closed connection 393
10:01:31 INFO - 1499965291362 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49799
10:01:31 INFO - 1499965291363 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:31 INFO - 1499965291364 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291366 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291368 Marionette TRACE 394 <- [1,1,null,{"sessionId":"60a522b9-c798-46bd-aeb5-76cea13288bb","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291370 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:01:31 INFO - 1499965291371 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:01:31 INFO - 1499965291373 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:01:31 INFO - 1499965291373 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:01:31 INFO - 1499965291383 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:01:31 INFO - 1499965291386 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:01:31 INFO - 1499965291394 Marionette TRACE 394 <- [1,2,null,{}]
10:01:31 INFO - 1499965291395 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:01:31 INFO - 1499965291398 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ef876627-7b0a-4f7d-8649-841ef5a6f8ef","ELEMENT":"ef876627-7b0a-4f7d-8649-841ef5a6f8ef"}}]
10:01:31 INFO - 1499965291398 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:01:31 INFO - 1499965291401 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"94be5c4a-b02f-4161-9859-845ea537f0e8","ELEMENT":"94be5c4a-b02f-4161-9859-845ea537f0e8"}}]
10:01:31 INFO - 1499965291402 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"ef876627-7b0a-4f7d-8649-841ef5a6f8ef"}]
10:01:31 INFO - 1499965291641 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:01:31 INFO - 1499965291641 Marionette TRACE 394 <- [1,5,null,{}]
10:01:31 INFO - 1499965291643 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"94be5c4a-b02f-4161-9859-845ea537f0e8"}]
10:01:31 INFO - 1499965291656 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:01:31 INFO - 1499965291658 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:01:31 INFO - 1499965291660 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:01:31 INFO - 1499965291661 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:01:31 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499965291663 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:01:31 INFO - 1499965291664 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:01:31 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 339ms
10:01:31 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:01:31 INFO - 1499965291665 Marionette TRACE 394 <- [1,9,null,{}]
10:01:31 INFO - 1499965291667 Marionette DEBUG Closed connection 394
10:01:31 INFO - 1499965291668 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49800
10:01:31 INFO - 1499965291668 Marionette DEBUG Closed connection 395
10:01:31 INFO - 1499965291669 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49801
10:01:31 INFO - 1499965291670 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291670 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291672 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291675 Marionette TRACE 396 <- [1,1,null,{"sessionId":"fda896b8-c2ca-4229-8f07-e49a4dfe2f61","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291676 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:01:31 INFO - 1499965291677 Marionette TRACE 396 <- [1,2,null,{}]
10:01:31 INFO - 1499965291677 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:01:31 INFO - 1499965291678 Marionette TRACE 396 <- [1,3,null,{}]
10:01:31 INFO - 1499965291678 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:01:31 INFO - 1499965291679 Marionette TRACE 396 <- [1,4,null,{}]
10:01:31 INFO - 1499965291681 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:01:31 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499965291682 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:01:31 INFO - 1499965291683 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:01:31 INFO - 1499965291685 Marionette TRACE 396 <- [1,6,null,{}]
10:01:31 INFO - 1499965291686 Marionette DEBUG Closed connection 396
10:01:31 INFO - 1499965291687 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49802
10:01:31 INFO - 1499965291688 Marionette DEBUG Closed connection 397
10:01:31 INFO - 1499965291688 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49803
10:01:31 INFO - 1499965291689 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:01:31 INFO - 1499965291689 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291691 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291694 Marionette TRACE 398 <- [1,1,null,{"sessionId":"34f772f1-e2e0-4bc1-bbe5-4645223aca12","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291696 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:01:31 INFO - 1499965291697 Marionette TRACE 398 <- [1,2,null,{}]
10:01:31 INFO - 1499965291698 Marionette DEBUG Closed connection 398
10:01:31 INFO - 1499965291699 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49804
10:01:31 INFO - 1499965291699 Marionette DEBUG Closed connection 399
10:01:31 INFO - 1499965291700 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49805
10:01:31 INFO - 1499965291701 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:01:31 INFO - 1499965291701 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}
10:01:31 INFO - 1499965291703 Marionette DEBUG Register listener.js for window 15
10:01:31 INFO - 1499965291705 Marionette TRACE 400 <- [1,1,null,{"sessionId":"9c3f451e-d55b-4037-9d30-dded0683e4d6","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":1648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-314.001\\AppData\\Local\\Temp\\tmpcootf2.mozrunner","moz:accessibilityChecks":false}}]
10:01:31 INFO - 1499965291707 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:01:31 INFO - 1499965291708 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:01:31 INFO - 1499965291710 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:01:31 INFO - 1499965291710 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:01:31 INFO - 1499965291729 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:01:31 INFO - 1499965291731 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:01:31 INFO - 1499965291734 Marionette TRACE 400 <- [1,2,null,{}]
10:01:31 INFO - 1499965291740 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:01:31 INFO - 1499965291742 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"147b54eb-77a4-4a1a-a14a-bb574a107794","ELEMENT":"147b54eb-77a4-4a1a-a14a-bb574a107794"}}]
10:01:31 INFO - 1499965291748 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"147b54eb-77a4-4a1a-a14a-bb574a107794"}]
10:01:31 INFO - 1499965291770 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:01:31 INFO - 1499965291781 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"147b54eb-77a4-4a1a-a14a-bb574a107794"}]
10:01:31 INFO - 1499965291794 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element