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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:43:58 INFO - 1499283838783 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}]
12:43:58 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499283838785 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:43:58 INFO - 1499283838786 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:43:58 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 117ms
12:43:58 INFO - 1499283838787 Marionette TRACE 352 <- [1,6,null,{}]
12:43:58 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:43:58 INFO - 1499283838789 Marionette DEBUG Closed connection 352
12:43:58 INFO - 1499283838790 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49765
12:43:58 INFO - 1499283838791 Marionette DEBUG Closed connection 353
12:43:58 INFO - 1499283838791 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49766
12:43:58 INFO - 1499283838792 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:58 INFO - 1499283838793 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838795 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838798 Marionette TRACE 354 <- [1,1,null,{"sessionId":"72fddd50-0382-4deb-a9fe-dbd9fbf38e94","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838799 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:43:58 INFO - 1499283838799 Marionette TRACE 354 <- [1,2,null,{}]
12:43:58 INFO - 1499283838800 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:43:58 INFO - 1499283838801 Marionette TRACE 354 <- [1,3,null,{}]
12:43:58 INFO - 1499283838801 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:43:58 INFO - 1499283838802 Marionette TRACE 354 <- [1,4,null,{}]
12:43:58 INFO - 1499283838804 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}]
12:43:58 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499283838806 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:43:58 INFO - 1499283838806 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:43:58 INFO - 1499283838808 Marionette TRACE 354 <- [1,6,null,{}]
12:43:58 INFO - 1499283838809 Marionette DEBUG Closed connection 354
12:43:58 INFO - 1499283838809 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49767
12:43:58 INFO - 1499283838810 Marionette DEBUG Closed connection 355
12:43:58 INFO - 1499283838811 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49768
12:43:58 INFO - 1499283838812 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:58 INFO - 1499283838812 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838814 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838817 Marionette TRACE 356 <- [1,1,null,{"sessionId":"9372e30c-b790-4096-980c-af4ba8e049cf","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838818 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:43:58 INFO - 1499283838819 Marionette TRACE 356 <- [1,2,null,{}]
12:43:58 INFO - 1499283838820 Marionette DEBUG Closed connection 356
12:43:58 INFO - 1499283838821 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49769
12:43:58 INFO - 1499283838821 Marionette DEBUG Closed connection 357
12:43:58 INFO - 1499283838822 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49770
12:43:58 INFO - 1499283838823 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:43:58 INFO - 1499283838823 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838825 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838828 Marionette TRACE 358 <- [1,1,null,{"sessionId":"f7aadfbf-013a-48fb-8732-62dc11e63ef0","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838829 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49331/clicks.html"}]
12:43:58 INFO - 1499283838830 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/hidden.html"
12:43:58 INFO - 1499283838836 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/hidden.html"
12:43:58 INFO - 1499283838836 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/hidden.html"
12:43:58 INFO - 1499283838842 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/clicks.html"
12:43:58 INFO - 1499283838848 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/clicks.html"
12:43:58 INFO - 1499283838852 Marionette TRACE 358 <- [1,2,null,{}]
12:43:58 INFO - 1499283838855 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:43:58 INFO - 1499283838857 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"334bbacd-b7b6-44be-8b88-92f629f0c0cc","ELEMENT":"334bbacd-b7b6-44be-8b88-92f629f0c0cc"}}]
12:43:58 INFO - 1499283838858 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"334bbacd-b7b6-44be-8b88-92f629f0c0cc"}]
12:43:58 INFO - 1499283838896 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/clicks.html"
12:43:58 INFO - 1499283838903 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/clicks.html"
12:43:58 INFO - 1499283838903 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/clicks.html"
12:43:58 INFO - 1499283838910 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/test.html"
12:43:58 INFO - 1499283838916 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/test.html"
12:43:58 INFO - 1499283838918 Marionette TRACE 358 <- [1,4,null,{}]
12:43:58 INFO - 1499283838921 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:43:58 INFO - 1499283838924 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"98fc5413-e5c5-4755-8fc2-d0344e3cb2b8","ELEMENT":"98fc5413-e5c5-4755-8fc2-d0344e3cb2b8"}}]
12:43:58 INFO - 1499283838924 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:43:58 INFO - 1499283838925 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:43:58 INFO - 1499283838926 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}]
12:43:58 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499283838928 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:43:58 INFO - 1499283838929 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:43:58 INFO - 1499283838930 Marionette TRACE 358 <- [1,8,null,{}]
12:43:58 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 143ms
12:43:58 INFO - TEST-START | test_click.py TestClick.test_container_element
12:43:58 INFO - 1499283838935 Marionette DEBUG Closed connection 358
12:43:58 INFO - 1499283838937 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49773
12:43:58 INFO - 1499283838939 Marionette DEBUG Closed connection 359
12:43:58 INFO - 1499283838939 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49774
12:43:58 INFO - 1499283838940 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:58 INFO - 1499283838941 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838943 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838947 Marionette TRACE 360 <- [1,1,null,{"sessionId":"26b231f8-76ea-4ea3-bd17-4e2c7511f4e1","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838948 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:43:58 INFO - 1499283838948 Marionette TRACE 360 <- [1,2,null,{}]
12:43:58 INFO - 1499283838949 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:43:58 INFO - 1499283838949 Marionette TRACE 360 <- [1,3,null,{}]
12:43:58 INFO - 1499283838950 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:43:58 INFO - 1499283838951 Marionette TRACE 360 <- [1,4,null,{}]
12:43:58 INFO - 1499283838953 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}]
12:43:58 INFO - TEST-START: test_click.py TestClick.test_container_element1499283838955 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:43:58 INFO - 1499283838956 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:43:58 INFO - 1499283838957 Marionette TRACE 360 <- [1,6,null,{}]
12:43:58 INFO - 1499283838958 Marionette DEBUG Closed connection 360
12:43:58 INFO - 1499283838959 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49775
12:43:58 INFO - 1499283838959 Marionette DEBUG Closed connection 361
12:43:58 INFO - 1499283838960 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49776
12:43:58 INFO - 1499283838961 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:58 INFO - 1499283838961 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838964 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838966 Marionette TRACE 362 <- [1,1,null,{"sessionId":"87e3becd-bcde-42a0-90a0-f65c919d5f0a","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838976 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:43:58 INFO - 1499283838977 Marionette TRACE 362 <- [1,2,null,{}]
12:43:58 INFO - 1499283838978 Marionette DEBUG Closed connection 362
12:43:58 INFO - 1499283838979 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49777
12:43:58 INFO - 1499283838980 Marionette DEBUG Closed connection 363
12:43:58 INFO - 1499283838980 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49778
12:43:58 INFO - 1499283838981 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:43:58 INFO - 1499283838982 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:58 INFO - 1499283838984 Marionette DEBUG Register listener.js for window 4294967297
12:43:58 INFO - 1499283838987 Marionette TRACE 364 <- [1,1,null,{"sessionId":"36db24a4-e799-4159-96de-53082583dcf2","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:58 INFO - 1499283838988 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"}]
12:43:58 INFO - 1499283838990 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/test.html"
12:43:58 INFO - 1499283838991 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/test.html"
12:43:58 INFO - 1499283838991 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/test.html"
12:43:58 INFO - 1499283838997 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"
12:43:59 INFO - 1499283839001 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"
12:43:59 INFO - 1499283839010 Marionette TRACE 364 <- [1,2,null,{}]
12:43:59 INFO - 1499283839014 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:43:59 INFO - 1499283839022 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"63194c88-69fe-4a05-9550-060fe7155297","ELEMENT":"63194c88-69fe-4a05-9550-060fe7155297"}}]
12:43:59 INFO - 1499283839023 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"63194c88-69fe-4a05-9550-060fe7155297"}]
12:43:59 INFO - 1499283839258 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:43:59 INFO - 1499283839259 Marionette TRACE 364 <- [1,4,null,{}]
12:43:59 INFO - 1499283839261 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"63194c88-69fe-4a05-9550-060fe7155297","name":"selected"}]
12:43:59 INFO - 1499283839265 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:43:59 INFO - 1499283839266 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}]
12:43:59 INFO - TEST-END: test_click.py TestClick.test_container_element1499283839269 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:43:59 INFO - 1499283839270 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:43:59 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 339ms
12:43:59 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:43:59 INFO - 1499283839271 Marionette TRACE 364 <- [1,7,null,{}]
12:43:59 INFO - 1499283839272 Marionette DEBUG Closed connection 364
12:43:59 INFO - 1499283839273 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49779
12:43:59 INFO - 1499283839274 Marionette DEBUG Closed connection 365
12:43:59 INFO - 1499283839274 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49780
12:43:59 INFO - 1499283839275 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839275 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839278 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839280 Marionette TRACE 366 <- [1,1,null,{"sessionId":"555f4581-0496-4f03-a31f-240905aa841b","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839282 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:43:59 INFO - 1499283839283 Marionette TRACE 366 <- [1,2,null,{}]
12:43:59 INFO - 1499283839284 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:43:59 INFO - 1499283839284 Marionette TRACE 366 <- [1,3,null,{}]
12:43:59 INFO - 1499283839285 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:43:59 INFO - 1499283839285 Marionette TRACE 366 <- [1,4,null,{}]
12:43:59 INFO - 1499283839287 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}]
12:43:59 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499283839289 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:43:59 INFO - 1499283839290 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:43:59 INFO - 1499283839291 Marionette TRACE 366 <- [1,6,null,{}]
12:43:59 INFO - 1499283839292 Marionette DEBUG Closed connection 366
12:43:59 INFO - 1499283839293 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49781
12:43:59 INFO - 1499283839293 Marionette DEBUG Closed connection 367
12:43:59 INFO - 1499283839294 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49782
12:43:59 INFO - 1499283839295 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839296 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839298 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839301 Marionette TRACE 368 <- [1,1,null,{"sessionId":"54821c43-d106-465a-9b01-41f08c122e15","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839302 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:43:59 INFO - 1499283839303 Marionette TRACE 368 <- [1,2,null,{}]
12:43:59 INFO - 1499283839304 Marionette DEBUG Closed connection 368
12:43:59 INFO - 1499283839305 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49783
12:43:59 INFO - 1499283839305 Marionette DEBUG Closed connection 369
12:43:59 INFO - 1499283839306 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49784
12:43:59 INFO - 1499283839307 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:43:59 INFO - 1499283839308 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839310 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839313 Marionette TRACE 370 <- [1,1,null,{"sessionId":"c497bba2-b242-468f-afdf-89c9a205cc3d","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839314 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"}]
12:43:59 INFO - 1499283839316 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"
12:43:59 INFO - 1499283839317 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"
12:43:59 INFO - 1499283839318 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"
12:43:59 INFO - 1499283839323 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"
12:43:59 INFO - 1499283839326 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"
12:43:59 INFO - 1499283839327 Marionette TRACE 370 <- [1,2,null,{}]
12:43:59 INFO - 1499283839329 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:43:59 INFO - 1499283839335 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f8150afe-00d8-44af-861c-855d31a5e9f3","ELEMENT":"f8150afe-00d8-44af-861c-855d31a5e9f3"}}]
12:43:59 INFO - 1499283839336 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"f8150afe-00d8-44af-861c-855d31a5e9f3"}]
12:43:59 INFO - 1499283839573 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:43:59 INFO - 1499283839574 Marionette TRACE 370 <- [1,4,null,{}]
12:43:59 INFO - 1499283839576 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"f8150afe-00d8-44af-861c-855d31a5e9f3","name":"selected"}]
12:43:59 INFO - 1499283839579 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:43:59 INFO - 1499283839581 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}]
12:43:59 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499283839584 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:43:59 INFO - 1499283839584 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:43:59 INFO - 1499283839586 Marionette TRACE 370 <- [1,7,null,{}]
12:43:59 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 315ms
12:43:59 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:43:59 INFO - 1499283839587 Marionette DEBUG Closed connection 370
12:43:59 INFO - 1499283839589 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49785
12:43:59 INFO - 1499283839590 Marionette DEBUG Closed connection 371
12:43:59 INFO - 1499283839590 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49786
12:43:59 INFO - 1499283839591 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839591 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839594 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839596 Marionette TRACE 372 <- [1,1,null,{"sessionId":"6c53dc33-1897-402f-9bf7-270b93ea4ab0","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839597 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:43:59 INFO - 1499283839598 Marionette TRACE 372 <- [1,2,null,{}]
12:43:59 INFO - 1499283839599 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:43:59 INFO - 1499283839599 Marionette TRACE 372 <- [1,3,null,{}]
12:43:59 INFO - 1499283839600 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:43:59 INFO - 1499283839600 Marionette TRACE 372 <- [1,4,null,{}]
12:43:59 INFO - 1499283839602 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}]
12:43:59 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499283839604 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:43:59 INFO - 1499283839605 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:43:59 INFO - 1499283839606 Marionette TRACE 372 <- [1,6,null,{}]
12:43:59 INFO - 1499283839608 Marionette DEBUG Closed connection 372
12:43:59 INFO - 1499283839608 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49787
12:43:59 INFO - 1499283839609 Marionette DEBUG Closed connection 373
12:43:59 INFO - 1499283839609 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49788
12:43:59 INFO - 1499283839610 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839611 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839613 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839616 Marionette TRACE 374 <- [1,1,null,{"sessionId":"b2cb4e7f-ce76-4021-aeff-bac21c6bf2cd","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839617 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:43:59 INFO - 1499283839618 Marionette TRACE 374 <- [1,2,null,{}]
12:43:59 INFO - 1499283839620 Marionette DEBUG Closed connection 374
12:43:59 INFO - 1499283839620 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49789
12:43:59 INFO - 1499283839621 Marionette DEBUG Closed connection 375
12:43:59 INFO - 1499283839621 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49790
12:43:59 INFO - 1499283839622 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:43:59 INFO - 1499283839623 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839625 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839627 Marionette TRACE 376 <- [1,1,null,{"sessionId":"62b3fb28-344f-46e7-b21c-99a52c2ea2d6","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839629 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"}]
12:43:59 INFO - 1499283839630 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"
12:43:59 INFO - 1499283839632 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"
12:43:59 INFO - 1499283839632 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"
12:43:59 INFO - 1499283839643 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"
12:43:59 INFO - 1499283839645 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"
12:43:59 INFO - 1499283839646 Marionette TRACE 376 <- [1,2,null,{}]
12:43:59 INFO - 1499283839653 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:43:59 INFO - 1499283839655 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7232a1f4-515c-4b0f-a6a6-222b7947afb4","ELEMENT":"7232a1f4-515c-4b0f-a6a6-222b7947afb4"}}]
12:43:59 INFO - 1499283839656 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7232a1f4-515c-4b0f-a6a6-222b7947afb4"}]
12:43:59 INFO - 1499283839897 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:43:59 INFO - 1499283839898 Marionette TRACE 376 <- [1,4,null,{}]
12:43:59 INFO - 1499283839899 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}]
12:43:59 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499283839902 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:43:59 INFO - 1499283839903 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:43:59 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 317ms
12:43:59 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:43:59 INFO - 1499283839904 Marionette TRACE 376 <- [1,6,null,{}]
12:43:59 INFO - 1499283839905 Marionette DEBUG Closed connection 376
12:43:59 INFO - 1499283839906 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49791
12:43:59 INFO - 1499283839907 Marionette DEBUG Closed connection 377
12:43:59 INFO - 1499283839907 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49792
12:43:59 INFO - 1499283839908 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839909 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839911 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839914 Marionette TRACE 378 <- [1,1,null,{"sessionId":"18d2fa2d-6c8e-4919-91f6-d372623c5430","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839915 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:43:59 INFO - 1499283839915 Marionette TRACE 378 <- [1,2,null,{}]
12:43:59 INFO - 1499283839916 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:43:59 INFO - 1499283839916 Marionette TRACE 378 <- [1,3,null,{}]
12:43:59 INFO - 1499283839917 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:43:59 INFO - 1499283839917 Marionette TRACE 378 <- [1,4,null,{}]
12:43:59 INFO - 1499283839919 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}]
12:43:59 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499283839922 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:43:59 INFO - 1499283839923 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:43:59 INFO - 1499283839924 Marionette TRACE 378 <- [1,6,null,{}]
12:43:59 INFO - 1499283839925 Marionette DEBUG Closed connection 378
12:43:59 INFO - 1499283839925 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49793
12:43:59 INFO - 1499283839926 Marionette DEBUG Closed connection 379
12:43:59 INFO - 1499283839927 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49794
12:43:59 INFO - 1499283839928 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:43:59 INFO - 1499283839928 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839930 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839933 Marionette TRACE 380 <- [1,1,null,{"sessionId":"e259c6f6-5ccb-4d1f-96a9-3cc3dc003bdc","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839934 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:43:59 INFO - 1499283839935 Marionette TRACE 380 <- [1,2,null,{}]
12:43:59 INFO - 1499283839936 Marionette DEBUG Closed connection 380
12:43:59 INFO - 1499283839937 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49795
12:43:59 INFO - 1499283839937 Marionette DEBUG Closed connection 381
12:43:59 INFO - 1499283839938 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49796
12:43:59 INFO - 1499283839939 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:43:59 INFO - 1499283839939 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:43:59 INFO - 1499283839941 Marionette DEBUG Register listener.js for window 4294967297
12:43:59 INFO - 1499283839944 Marionette TRACE 382 <- [1,1,null,{"sessionId":"efc37f66-a4bb-40f9-b11b-31fd13ed8723","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:43:59 INFO - 1499283839945 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"}]
12:43:59 INFO - 1499283839947 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"
12:43:59 INFO - 1499283839948 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"
12:43:59 INFO - 1499283839948 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"
12:43:59 INFO - 1499283839954 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"
12:43:59 INFO - 1499283839957 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"
12:43:59 INFO - 1499283839958 Marionette TRACE 382 <- [1,2,null,{}]
12:43:59 INFO - 1499283839961 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:43:59 INFO - 1499283839963 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9a82486b-1f71-453f-a662-c42cf8e43a80","ELEMENT":"9a82486b-1f71-453f-a662-c42cf8e43a80"}}]
12:43:59 INFO - 1499283839964 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"9a82486b-1f71-453f-a662-c42cf8e43a80"}]
12:44:00 INFO - 1499283840203 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:00 INFO - 1499283840204 Marionette TRACE 382 <- [1,4,null,{}]
12:44:00 INFO - 1499283840205 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}]
12:44:00 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499283840208 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:44:00 INFO - 1499283840208 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:44:00 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 305ms
12:44:00 INFO - TEST-START | test_click.py TestClick.test_input_file
12:44:00 INFO - 1499283840210 Marionette TRACE 382 <- [1,6,null,{}]
12:44:00 INFO - 1499283840211 Marionette DEBUG Closed connection 382
12:44:00 INFO - 1499283840212 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49797
12:44:00 INFO - 1499283840212 Marionette DEBUG Closed connection 383
12:44:00 INFO - 1499283840213 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49798
12:44:00 INFO - 1499283840214 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840215 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840217 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840219 Marionette TRACE 384 <- [1,1,null,{"sessionId":"129224a0-ea40-476c-8d21-53d7ba45c57b","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840220 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:44:00 INFO - 1499283840221 Marionette TRACE 384 <- [1,2,null,{}]
12:44:00 INFO - 1499283840222 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:00 INFO - 1499283840222 Marionette TRACE 384 <- [1,3,null,{}]
12:44:00 INFO - 1499283840223 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:00 INFO - 1499283840223 Marionette TRACE 384 <- [1,4,null,{}]
12:44:00 INFO - 1499283840225 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}]
12:44:00 INFO - TEST-START: test_click.py TestClick.test_input_file1499283840227 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:44:00 INFO - 1499283840228 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:44:00 INFO - 1499283840229 Marionette TRACE 384 <- [1,6,null,{}]
12:44:00 INFO - 1499283840231 Marionette DEBUG Closed connection 384
12:44:00 INFO - 1499283840231 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49799
12:44:00 INFO - 1499283840232 Marionette DEBUG Closed connection 385
12:44:00 INFO - 1499283840232 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49800
12:44:00 INFO - 1499283840233 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840234 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840236 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840238 Marionette TRACE 386 <- [1,1,null,{"sessionId":"ead3e13b-be34-4beb-9ae1-58466701b21d","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840239 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:44:00 INFO - 1499283840240 Marionette TRACE 386 <- [1,2,null,{}]
12:44:00 INFO - 1499283840242 Marionette DEBUG Closed connection 386
12:44:00 INFO - 1499283840242 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49801
12:44:00 INFO - 1499283840243 Marionette DEBUG Closed connection 387
12:44:00 INFO - 1499283840244 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49802
12:44:00 INFO - 1499283840245 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:00 INFO - 1499283840245 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840247 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840250 Marionette TRACE 388 <- [1,1,null,{"sessionId":"9ffe1610-38d4-44b5-9a1e-15b3b31f0a31","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840251 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:44:00 INFO - 1499283840252 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"
12:44:00 INFO - 1499283840254 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"
12:44:00 INFO - 1499283840254 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"
12:44:00 INFO - 1499283840259 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:00 INFO - 1499283840263 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:00 INFO - 1499283840264 Marionette TRACE 388 <- [1,2,null,{}]
12:44:00 INFO - 1499283840270 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:44:00 INFO - 1499283840273 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"56a1272e-eaf1-43c7-9571-60c7c2240ab1","ELEMENT":"56a1272e-eaf1-43c7-9571-60c7c2240ab1"}}]
12:44:00 INFO - 1499283840273 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"56a1272e-eaf1-43c7-9571-60c7c2240ab1"}]
12:44:00 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 101ms
12:44:00 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:44:00 INFO - 1499283840305 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:44:00 INFO - 1499283840307 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}]
12:44:00 INFO - TEST-END: test_click.py TestClick.test_input_file1499283840309 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:44:00 INFO - 1499283840310 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:44:00 INFO - 1499283840311 Marionette TRACE 388 <- [1,6,null,{}]
12:44:00 INFO - 1499283840313 Marionette DEBUG Closed connection 388
12:44:00 INFO - 1499283840314 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49803
12:44:00 INFO - 1499283840314 Marionette DEBUG Closed connection 389
12:44:00 INFO - 1499283840315 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49804
12:44:00 INFO - 1499283840316 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840316 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840319 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840322 Marionette TRACE 390 <- [1,1,null,{"sessionId":"f1110747-39d2-4fb7-b2f1-73c707ae22ea","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840323 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:44:00 INFO - 1499283840323 Marionette TRACE 390 <- [1,2,null,{}]
12:44:00 INFO - 1499283840324 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:00 INFO - 1499283840324 Marionette TRACE 390 <- [1,3,null,{}]
12:44:00 INFO - 1499283840325 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:00 INFO - 1499283840326 Marionette TRACE 390 <- [1,4,null,{}]
12:44:00 INFO - 1499283840328 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}]
12:44:00 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499283840330 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:44:00 INFO - 1499283840331 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:44:00 INFO - 1499283840332 Marionette TRACE 390 <- [1,6,null,{}]
12:44:00 INFO - 1499283840334 Marionette DEBUG Closed connection 390
12:44:00 INFO - 1499283840334 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49805
12:44:00 INFO - 1499283840335 Marionette DEBUG Closed connection 391
12:44:00 INFO - 1499283840335 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49806
12:44:00 INFO - 1499283840336 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840337 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840339 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840341 Marionette TRACE 392 <- [1,1,null,{"sessionId":"84be2113-7d31-48b2-bc00-e4f332128323","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840342 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:44:00 INFO - 1499283840343 Marionette TRACE 392 <- [1,2,null,{}]
12:44:00 INFO - 1499283840345 Marionette DEBUG Closed connection 392
12:44:00 INFO - 1499283840345 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49807
12:44:00 INFO - 1499283840346 Marionette DEBUG Closed connection 393
12:44:00 INFO - 1499283840347 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49808
12:44:00 INFO - 1499283840347 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:00 INFO - 1499283840348 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840350 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840353 Marionette TRACE 394 <- [1,1,null,{"sessionId":"24427b54-096b-41e6-9618-ad6832bff875","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840354 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"}]
12:44:00 INFO - 1499283840356 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:00 INFO - 1499283840357 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:00 INFO - 1499283840358 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:00 INFO - 1499283840363 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"
12:44:00 INFO - 1499283840366 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"
12:44:00 INFO - 1499283840371 Marionette TRACE 394 <- [1,2,null,{}]
12:44:00 INFO - 1499283840373 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:44:00 INFO - 1499283840375 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"138467b6-9619-430d-9af9-6dcb4022126b","ELEMENT":"138467b6-9619-430d-9af9-6dcb4022126b"}}]
12:44:00 INFO - 1499283840376 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:44:00 INFO - 1499283840378 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"af3b10ee-9aa5-4926-ab52-9a7e77488176","ELEMENT":"af3b10ee-9aa5-4926-ab52-9a7e77488176"}}]
12:44:00 INFO - 1499283840379 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"138467b6-9619-430d-9af9-6dcb4022126b"}]
12:44:00 INFO - 1499283840614 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:00 INFO - 1499283840615 Marionette TRACE 394 <- [1,5,null,{}]
12:44:00 INFO - 1499283840616 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"af3b10ee-9aa5-4926-ab52-9a7e77488176"}]
12:44:00 INFO - 1499283840685 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:44:00 INFO - 1499283840690 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
12:44:00 INFO - 1499283840693 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:44:00 INFO - 1499283840696 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}]
12:44:00 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499283840700 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:44:00 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 405ms
12:44:00 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:44:00 INFO - 1499283840714 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:44:00 INFO - 1499283840717 Marionette TRACE 394 <- [1,9,null,{}]
12:44:00 INFO - 1499283840721 Marionette DEBUG Closed connection 394
12:44:00 INFO - 1499283840722 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49809
12:44:00 INFO - 1499283840723 Marionette DEBUG Closed connection 395
12:44:00 INFO - 1499283840724 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49810
12:44:00 INFO - 1499283840726 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840729 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840732 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840736 Marionette TRACE 396 <- [1,1,null,{"sessionId":"794ab72d-3717-412a-8ca6-449145932ac3","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840738 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:44:00 INFO - 1499283840739 Marionette TRACE 396 <- [1,2,null,{}]
12:44:00 INFO - 1499283840740 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:00 INFO - 1499283840741 Marionette TRACE 396 <- [1,3,null,{}]
12:44:00 INFO - 1499283840742 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:00 INFO - 1499283840743 Marionette TRACE 396 <- [1,4,null,{}]
12:44:00 INFO - 1499283840744 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}]
12:44:00 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499283840748 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:44:00 INFO - 1499283840750 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:44:00 INFO - 1499283840751 Marionette TRACE 396 <- [1,6,null,{}]
12:44:00 INFO - 1499283840753 Marionette DEBUG Closed connection 396
12:44:00 INFO - 1499283840754 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49811
12:44:00 INFO - 1499283840755 Marionette DEBUG Closed connection 397
12:44:00 INFO - 1499283840756 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49812
12:44:00 INFO - 1499283840757 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:00 INFO - 1499283840757 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840760 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840764 Marionette TRACE 398 <- [1,1,null,{"sessionId":"7d4ff331-9bb7-49e1-babd-d6da69698e1e","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840767 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:44:00 INFO - 1499283840769 Marionette TRACE 398 <- [1,2,null,{}]
12:44:00 INFO - 1499283840771 Marionette DEBUG Closed connection 398
12:44:00 INFO - 1499283840771 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49813
12:44:00 INFO - 1499283840772 Marionette DEBUG Closed connection 399
12:44:00 INFO - 1499283840773 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49814
12:44:00 INFO - 1499283840774 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:00 INFO - 1499283840775 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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}
12:44:00 INFO - 1499283840777 Marionette DEBUG Register listener.js for window 4294967297
12:44:00 INFO - 1499283840781 Marionette TRACE 400 <- [1,1,null,{"sessionId":"cd029e2b-5a71-4d12-88b8-557724531e87","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":1316,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-063.001\\AppData\\Local\\Temp\\tmppgz4js.mozrunner","moz:accessibilityChecks":false}}]
12:44:00 INFO - 1499283840782 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"}]
12:44:00 INFO - 1499283840784 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"
12:44:00 INFO - 1499283840785 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"
12:44:00 INFO - 1499283840786 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"
12:44:00 INFO - 1499283840792 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"
12:44:00 INFO - 1499283840794 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"
12:44:00 INFO - 1499283840804 Marionette TRACE 400 <- [1,2,null,{}]
12:44:00 INFO - 1499283840809 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:44:00 INFO - 1499283840811 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b30eff79-5830-4342-ae30-682e9be989df","ELEMENT":"b30eff79-5830-4342-ae30-682e9be989df"}}]
12:44:00 INFO - 1499283840812 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"b30eff79-5830-4342-ae30-682e9be989df"}]
12:44:00 INFO - 1499283840845 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:44:00 INFO - 1499283840846 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"b30eff79-5830-4342-ae30-682e9be989df"}]
12:44:00 INFO - 1499283840861 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element