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]
21:19:27 INFO - 1499833167680 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}]
21:19:27 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499833167683 Marionette TRACE 352 <- [1,5,null,{"value":null}]
21:19:27 INFO - 1499833167683 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
21:19:27 INFO - 1499833167685 Marionette TRACE 352 <- [1,6,null,{}]
21:19:27 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 120ms
21:19:27 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
21:19:27 INFO - 1499833167686 Marionette DEBUG Closed connection 352
21:19:27 INFO - 1499833167688 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49777
21:19:27 INFO - 1499833167688 Marionette DEBUG Closed connection 353
21:19:27 INFO - 1499833167689 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49778
21:19:27 INFO - 1499833167690 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:27 INFO - 1499833167690 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167693 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167696 Marionette TRACE 354 <- [1,1,null,{"sessionId":"7631e4c2-8a75-4c34-8b58-454e8d230b0e","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167697 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
21:19:27 INFO - 1499833167697 Marionette TRACE 354 <- [1,2,null,{}]
21:19:27 INFO - 1499833167698 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:27 INFO - 1499833167698 Marionette TRACE 354 <- [1,3,null,{}]
21:19:27 INFO - 1499833167699 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:27 INFO - 1499833167699 Marionette TRACE 354 <- [1,4,null,{}]
21:19:27 INFO - 1499833167701 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}]
21:19:27 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499833167703 Marionette TRACE 354 <- [1,5,null,{"value":null}]
21:19:27 INFO - 1499833167704 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
21:19:27 INFO - 1499833167705 Marionette TRACE 354 <- [1,6,null,{}]
21:19:27 INFO - 1499833167707 Marionette DEBUG Closed connection 354
21:19:27 INFO - 1499833167707 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49779
21:19:27 INFO - 1499833167708 Marionette DEBUG Closed connection 355
21:19:27 INFO - 1499833167708 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49780
21:19:27 INFO - 1499833167709 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:27 INFO - 1499833167710 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167712 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167715 Marionette TRACE 356 <- [1,1,null,{"sessionId":"cb771aa3-9952-42e8-bd73-c31671f578e2","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167716 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
21:19:27 INFO - 1499833167717 Marionette TRACE 356 <- [1,2,null,{}]
21:19:27 INFO - 1499833167718 Marionette DEBUG Closed connection 356
21:19:27 INFO - 1499833167719 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49781
21:19:27 INFO - 1499833167719 Marionette DEBUG Closed connection 357
21:19:27 INFO - 1499833167720 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49782
21:19:27 INFO - 1499833167721 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:27 INFO - 1499833167721 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167723 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167733 Marionette TRACE 358 <- [1,1,null,{"sessionId":"5b2aa415-e9de-444c-a58f-dfb32261e830","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167735 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49337/clicks.html"}]
21:19:27 INFO - 1499833167737 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/hidden.html"
21:19:27 INFO - 1499833167743 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/hidden.html"
21:19:27 INFO - 1499833167743 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/hidden.html"
21:19:27 INFO - 1499833167748 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/clicks.html"
21:19:27 INFO - 1499833167753 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/clicks.html"
21:19:27 INFO - 1499833167755 Marionette TRACE 358 <- [1,2,null,{}]
21:19:27 INFO - 1499833167759 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
21:19:27 INFO - 1499833167761 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"59edf7da-16fc-4388-8924-77abbb526e9f","ELEMENT":"59edf7da-16fc-4388-8924-77abbb526e9f"}}]
21:19:27 INFO - 1499833167762 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"59edf7da-16fc-4388-8924-77abbb526e9f"}]
21:19:27 INFO - 1499833167801 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/clicks.html"
21:19:27 INFO - 1499833167808 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/clicks.html"
21:19:27 INFO - 1499833167808 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/clicks.html"
21:19:27 INFO - 1499833167814 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/test.html"
21:19:27 INFO - 1499833167816 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/test.html"
21:19:27 INFO - 1499833167828 Marionette TRACE 358 <- [1,4,null,{}]
21:19:27 INFO - 1499833167833 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
21:19:27 INFO - 1499833167837 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"67b8a3c5-e8da-4bbd-bcf8-a788cbb72202","ELEMENT":"67b8a3c5-e8da-4bbd-bcf8-a788cbb72202"}}]
21:19:27 INFO - 1499833167839 Marionette TRACE 358 -> [0,6,"getTitle",{}]
21:19:27 INFO - 1499833167839 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
21:19:27 INFO - 1499833167840 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}]
21:19:27 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499833167843 Marionette TRACE 358 <- [1,7,null,{"value":null}]
21:19:27 INFO - 1499833167844 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
21:19:27 INFO - 1499833167845 Marionette TRACE 358 <- [1,8,null,{}]
21:19:27 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 159ms
21:19:27 INFO - TEST-START | test_click.py TestClick.test_container_element
21:19:27 INFO - 1499833167846 Marionette DEBUG Closed connection 358
21:19:27 INFO - 1499833167847 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49785
21:19:27 INFO - 1499833167848 Marionette DEBUG Closed connection 359
21:19:27 INFO - 1499833167848 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49786
21:19:27 INFO - 1499833167849 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:27 INFO - 1499833167850 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167852 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167855 Marionette TRACE 360 <- [1,1,null,{"sessionId":"da5fcd57-88c1-4446-befd-6a8038446092","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167856 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
21:19:27 INFO - 1499833167856 Marionette TRACE 360 <- [1,2,null,{}]
21:19:27 INFO - 1499833167857 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:27 INFO - 1499833167858 Marionette TRACE 360 <- [1,3,null,{}]
21:19:27 INFO - 1499833167859 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:27 INFO - 1499833167859 Marionette TRACE 360 <- [1,4,null,{}]
21:19:27 INFO - 1499833167861 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}]
21:19:27 INFO - TEST-START: test_click.py TestClick.test_container_element1499833167863 Marionette TRACE 360 <- [1,5,null,{"value":null}]
21:19:27 INFO - 1499833167864 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
21:19:27 INFO - 1499833167865 Marionette TRACE 360 <- [1,6,null,{}]
21:19:27 INFO - 1499833167866 Marionette DEBUG Closed connection 360
21:19:27 INFO - 1499833167867 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49787
21:19:27 INFO - 1499833167867 Marionette DEBUG Closed connection 361
21:19:27 INFO - 1499833167868 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49788
21:19:27 INFO - 1499833167869 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:27 INFO - 1499833167869 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167872 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167874 Marionette TRACE 362 <- [1,1,null,{"sessionId":"eb03c870-e28e-40ad-b8b1-8db71b1fc78d","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167875 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
21:19:27 INFO - 1499833167876 Marionette TRACE 362 <- [1,2,null,{}]
21:19:27 INFO - 1499833167878 Marionette DEBUG Closed connection 362
21:19:27 INFO - 1499833167878 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49789
21:19:27 INFO - 1499833167879 Marionette DEBUG Closed connection 363
21:19:27 INFO - 1499833167879 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49790
21:19:27 INFO - 1499833167880 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:27 INFO - 1499833167881 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:27 INFO - 1499833167883 Marionette DEBUG Register listener.js for window 4294967297
21:19:27 INFO - 1499833167886 Marionette TRACE 364 <- [1,1,null,{"sessionId":"c6c8cba8-56fd-460f-b823-12e24c1224f7","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:27 INFO - 1499833167887 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"}]
21:19:27 INFO - 1499833167889 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/test.html"
21:19:27 INFO - 1499833167890 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/test.html"
21:19:27 INFO - 1499833167890 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/test.html"
21:19:27 INFO - 1499833167896 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"
21:19:27 INFO - 1499833167898 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"
21:19:27 INFO - 1499833167908 Marionette TRACE 364 <- [1,2,null,{}]
21:19:27 INFO - 1499833167914 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:19:27 INFO - 1499833167916 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fa8c8e58-91e9-4434-a7a5-67aa1fecf018","ELEMENT":"fa8c8e58-91e9-4434-a7a5-67aa1fecf018"}}]
21:19:27 INFO - 1499833167921 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"fa8c8e58-91e9-4434-a7a5-67aa1fecf018"}]
21:19:28 INFO - 1499833168170 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:19:28 INFO - 1499833168171 Marionette TRACE 364 <- [1,4,null,{}]
21:19:28 INFO - 1499833168172 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"fa8c8e58-91e9-4434-a7a5-67aa1fecf018","name":"selected"}]
21:19:28 INFO - 1499833168176 Marionette TRACE 364 <- [1,5,null,{"value":true}]
21:19:28 INFO - 1499833168178 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}]
21:19:28 INFO - TEST-END: test_click.py TestClick.test_container_element1499833168181 Marionette TRACE 364 <- [1,6,null,{"value":null}]
21:19:28 INFO - 1499833168182 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
21:19:28 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 337ms
21:19:28 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
21:19:28 INFO - 1499833168183 Marionette TRACE 364 <- [1,7,null,{}]
21:19:28 INFO - 1499833168185 Marionette DEBUG Closed connection 364
21:19:28 INFO - 1499833168185 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49791
21:19:28 INFO - 1499833168186 Marionette DEBUG Closed connection 365
21:19:28 INFO - 1499833168187 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49792
21:19:28 INFO - 1499833168188 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168188 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168190 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168193 Marionette TRACE 366 <- [1,1,null,{"sessionId":"18fe88a8-01ca-4039-b582-113cae3e31f7","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168194 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
21:19:28 INFO - 1499833168195 Marionette TRACE 366 <- [1,2,null,{}]
21:19:28 INFO - 1499833168196 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:28 INFO - 1499833168196 Marionette TRACE 366 <- [1,3,null,{}]
21:19:28 INFO - 1499833168197 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:28 INFO - 1499833168197 Marionette TRACE 366 <- [1,4,null,{}]
21:19:28 INFO - 1499833168199 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}]
21:19:28 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499833168201 Marionette TRACE 366 <- [1,5,null,{"value":null}]
21:19:28 INFO - 1499833168202 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
21:19:28 INFO - 1499833168204 Marionette TRACE 366 <- [1,6,null,{}]
21:19:28 INFO - 1499833168205 Marionette DEBUG Closed connection 366
21:19:28 INFO - 1499833168205 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49793
21:19:28 INFO - 1499833168206 Marionette DEBUG Closed connection 367
21:19:28 INFO - 1499833168207 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49794
21:19:28 INFO - 1499833168208 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168208 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168210 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168213 Marionette TRACE 368 <- [1,1,null,{"sessionId":"145236f8-4b99-4a55-8a18-6bdf9b4656c7","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168214 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
21:19:28 INFO - 1499833168215 Marionette TRACE 368 <- [1,2,null,{}]
21:19:28 INFO - 1499833168216 Marionette DEBUG Closed connection 368
21:19:28 INFO - 1499833168217 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49795
21:19:28 INFO - 1499833168218 Marionette DEBUG Closed connection 369
21:19:28 INFO - 1499833168218 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49796
21:19:28 INFO - 1499833168219 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:28 INFO - 1499833168220 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168222 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168225 Marionette TRACE 370 <- [1,1,null,{"sessionId":"b42d02e1-d797-4871-bff6-e12b35050e4c","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168226 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"}]
21:19:28 INFO - 1499833168227 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"
21:19:28 INFO - 1499833168229 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"
21:19:28 INFO - 1499833168229 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"
21:19:28 INFO - 1499833168236 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"
21:19:28 INFO - 1499833168237 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"
21:19:28 INFO - 1499833168242 Marionette TRACE 370 <- [1,2,null,{}]
21:19:28 INFO - 1499833168245 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:19:28 INFO - 1499833168248 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4e884806-2ffb-413d-84f8-c294991285db","ELEMENT":"4e884806-2ffb-413d-84f8-c294991285db"}}]
21:19:28 INFO - 1499833168249 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"4e884806-2ffb-413d-84f8-c294991285db"}]
21:19:28 INFO - 1499833168502 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:19:28 INFO - 1499833168503 Marionette TRACE 370 <- [1,4,null,{}]
21:19:28 INFO - 1499833168504 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"4e884806-2ffb-413d-84f8-c294991285db","name":"selected"}]
21:19:28 INFO - 1499833168507 Marionette TRACE 370 <- [1,5,null,{"value":true}]
21:19:28 INFO - 1499833168509 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}]
21:19:28 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499833168511 Marionette TRACE 370 <- [1,6,null,{"value":null}]
21:19:28 INFO - 1499833168512 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
21:19:28 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 329ms
21:19:28 INFO - TEST-START | test_click.py TestClick.test_css_transforms
21:19:28 INFO - 1499833168513 Marionette TRACE 370 <- [1,7,null,{}]
21:19:28 INFO - 1499833168514 Marionette DEBUG Closed connection 370
21:19:28 INFO - 1499833168515 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49797
21:19:28 INFO - 1499833168516 Marionette DEBUG Closed connection 371
21:19:28 INFO - 1499833168517 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49798
21:19:28 INFO - 1499833168517 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168518 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168520 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168523 Marionette TRACE 372 <- [1,1,null,{"sessionId":"13bcfb19-553f-4643-a4bc-750958a0c4a0","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168524 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
21:19:28 INFO - 1499833168524 Marionette TRACE 372 <- [1,2,null,{}]
21:19:28 INFO - 1499833168525 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:28 INFO - 1499833168525 Marionette TRACE 372 <- [1,3,null,{}]
21:19:28 INFO - 1499833168527 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:28 INFO - 1499833168527 Marionette TRACE 372 <- [1,4,null,{}]
21:19:28 INFO - 1499833168529 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}]
21:19:28 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499833168531 Marionette TRACE 372 <- [1,5,null,{"value":null}]
21:19:28 INFO - 1499833168532 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
21:19:28 INFO - 1499833168533 Marionette TRACE 372 <- [1,6,null,{}]
21:19:28 INFO - 1499833168534 Marionette DEBUG Closed connection 372
21:19:28 INFO - 1499833168535 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49799
21:19:28 INFO - 1499833168535 Marionette DEBUG Closed connection 373
21:19:28 INFO - 1499833168536 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49800
21:19:28 INFO - 1499833168537 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168537 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168539 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168542 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c6f6816b-bd3b-42ac-8ac4-111285d6b3d1","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168543 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
21:19:28 INFO - 1499833168544 Marionette TRACE 374 <- [1,2,null,{}]
21:19:28 INFO - 1499833168546 Marionette DEBUG Closed connection 374
21:19:28 INFO - 1499833168546 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49801
21:19:28 INFO - 1499833168547 Marionette DEBUG Closed connection 375
21:19:28 INFO - 1499833168548 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49802
21:19:28 INFO - 1499833168549 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:28 INFO - 1499833168549 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168551 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168554 Marionette TRACE 376 <- [1,1,null,{"sessionId":"81a1177e-65bb-4932-a3e9-5f357a1defd3","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168556 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"}]
21:19:28 INFO - 1499833168558 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"
21:19:28 INFO - 1499833168561 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"
21:19:28 INFO - 1499833168561 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"
21:19:28 INFO - 1499833168570 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"
21:19:28 INFO - 1499833168573 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"
21:19:28 INFO - 1499833168576 Marionette TRACE 376 <- [1,2,null,{}]
21:19:28 INFO - 1499833168580 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
21:19:28 INFO - 1499833168582 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cdeb6564-d0a0-4b34-8e7b-8d16aa3adb87","ELEMENT":"cdeb6564-d0a0-4b34-8e7b-8d16aa3adb87"}}]
21:19:28 INFO - 1499833168583 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"cdeb6564-d0a0-4b34-8e7b-8d16aa3adb87"}]
21:19:28 INFO - 1499833168819 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:19:28 INFO - 1499833168820 Marionette TRACE 376 <- [1,4,null,{}]
21:19:28 INFO - 1499833168821 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}]
21:19:28 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499833168824 Marionette TRACE 376 <- [1,5,null,{"value":null}]
21:19:28 INFO - 1499833168824 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
21:19:28 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 311ms
21:19:28 INFO - 1499833168826 Marionette TRACE 376 <- [1,6,null,{}]
21:19:28 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
21:19:28 INFO - 1499833168827 Marionette DEBUG Closed connection 376
21:19:28 INFO - 1499833168829 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49803
21:19:28 INFO - 1499833168829 Marionette DEBUG Closed connection 377
21:19:28 INFO - 1499833168830 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49804
21:19:28 INFO - 1499833168831 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168831 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168833 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168836 Marionette TRACE 378 <- [1,1,null,{"sessionId":"bc685bfc-5535-4a0b-b796-781f95fb1e8a","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168837 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
21:19:28 INFO - 1499833168838 Marionette TRACE 378 <- [1,2,null,{}]
21:19:28 INFO - 1499833168839 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:28 INFO - 1499833168839 Marionette TRACE 378 <- [1,3,null,{}]
21:19:28 INFO - 1499833168840 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:28 INFO - 1499833168840 Marionette TRACE 378 <- [1,4,null,{}]
21:19:28 INFO - 1499833168842 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}]
21:19:28 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499833168844 Marionette TRACE 378 <- [1,5,null,{"value":null}]
21:19:28 INFO - 1499833168846 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
21:19:28 INFO - 1499833168847 Marionette TRACE 378 <- [1,6,null,{}]
21:19:28 INFO - 1499833168848 Marionette DEBUG Closed connection 378
21:19:28 INFO - 1499833168848 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49805
21:19:28 INFO - 1499833168849 Marionette DEBUG Closed connection 379
21:19:28 INFO - 1499833168850 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49806
21:19:28 INFO - 1499833168851 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:28 INFO - 1499833168851 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168853 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168856 Marionette TRACE 380 <- [1,1,null,{"sessionId":"ed9a8542-71fb-4277-9a36-c39215aef143","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168857 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
21:19:28 INFO - 1499833168858 Marionette TRACE 380 <- [1,2,null,{}]
21:19:28 INFO - 1499833168860 Marionette DEBUG Closed connection 380
21:19:28 INFO - 1499833168860 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49807
21:19:28 INFO - 1499833168861 Marionette DEBUG Closed connection 381
21:19:28 INFO - 1499833168862 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49808
21:19:28 INFO - 1499833168863 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:28 INFO - 1499833168863 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:28 INFO - 1499833168865 Marionette DEBUG Register listener.js for window 4294967297
21:19:28 INFO - 1499833168868 Marionette TRACE 382 <- [1,1,null,{"sessionId":"605ffc5f-0f9d-408a-9e5e-f941bee04ff7","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:28 INFO - 1499833168870 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"}]
21:19:28 INFO - 1499833168871 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"
21:19:28 INFO - 1499833168873 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"
21:19:28 INFO - 1499833168873 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"
21:19:28 INFO - 1499833168878 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"
21:19:28 INFO - 1499833168881 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"
21:19:28 INFO - 1499833168883 Marionette TRACE 382 <- [1,2,null,{}]
21:19:28 INFO - 1499833168891 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
21:19:28 INFO - 1499833168894 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"41e31a16-847a-415e-8369-914a5a649372","ELEMENT":"41e31a16-847a-415e-8369-914a5a649372"}}]
21:19:28 INFO - 1499833168894 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"41e31a16-847a-415e-8369-914a5a649372"}]
21:19:29 INFO - 1499833169136 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:19:29 INFO - 1499833169137 Marionette TRACE 382 <- [1,4,null,{}]
21:19:29 INFO - 1499833169138 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}]
21:19:29 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499833169141 Marionette TRACE 382 <- [1,5,null,{"value":null}]
21:19:29 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 316ms
21:19:29 INFO - 1499833169142 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
21:19:29 INFO - 1499833169143 Marionette TRACE 382 <- [1,6,null,{}]
21:19:29 INFO - TEST-START | test_click.py TestClick.test_input_file
21:19:29 INFO - 1499833169144 Marionette DEBUG Closed connection 382
21:19:29 INFO - 1499833169145 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49809
21:19:29 INFO - 1499833169146 Marionette DEBUG Closed connection 383
21:19:29 INFO - 1499833169147 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49810
21:19:29 INFO - 1499833169148 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169148 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169150 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169153 Marionette TRACE 384 <- [1,1,null,{"sessionId":"f3b9eea6-4382-44d4-add8-567593a87f57","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169154 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
21:19:29 INFO - 1499833169154 Marionette TRACE 384 <- [1,2,null,{}]
21:19:29 INFO - 1499833169155 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:29 INFO - 1499833169156 Marionette TRACE 384 <- [1,3,null,{}]
21:19:29 INFO - 1499833169157 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:29 INFO - 1499833169157 Marionette TRACE 384 <- [1,4,null,{}]
21:19:29 INFO - 1499833169159 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}]
21:19:29 INFO - TEST-START: test_click.py TestClick.test_input_file1499833169161 Marionette TRACE 384 <- [1,5,null,{"value":null}]
21:19:29 INFO - 1499833169162 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
21:19:29 INFO - 1499833169164 Marionette TRACE 384 <- [1,6,null,{}]
21:19:29 INFO - 1499833169165 Marionette DEBUG Closed connection 384
21:19:29 INFO - 1499833169165 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49811
21:19:29 INFO - 1499833169166 Marionette DEBUG Closed connection 385
21:19:29 INFO - 1499833169167 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49812
21:19:29 INFO - 1499833169168 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169168 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169170 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169180 Marionette TRACE 386 <- [1,1,null,{"sessionId":"18de8980-b09f-4671-9fb3-6448bf174858","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169181 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
21:19:29 INFO - 1499833169183 Marionette TRACE 386 <- [1,2,null,{}]
21:19:29 INFO - 1499833169184 Marionette DEBUG Closed connection 386
21:19:29 INFO - 1499833169184 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49813
21:19:29 INFO - 1499833169185 Marionette DEBUG Closed connection 387
21:19:29 INFO - 1499833169186 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49814
21:19:29 INFO - 1499833169187 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:29 INFO - 1499833169187 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169189 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169192 Marionette TRACE 388 <- [1,1,null,{"sessionId":"30452fdc-8d45-4525-b526-ceb9039e4915","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169193 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
21:19:29 INFO - 1499833169195 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"
21:19:29 INFO - 1499833169196 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"
21:19:29 INFO - 1499833169197 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"
21:19:29 INFO - 1499833169205 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:19:29 INFO - 1499833169206 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:19:29 INFO - 1499833169211 Marionette TRACE 388 <- [1,2,null,{}]
21:19:29 INFO - 1499833169214 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
21:19:29 INFO - 1499833169217 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b62e3dbe-5d02-43ba-a302-f29dd09f9ffe","ELEMENT":"b62e3dbe-5d02-43ba-a302-f29dd09f9ffe"}}]
21:19:29 INFO - 1499833169221 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"b62e3dbe-5d02-43ba-a302-f29dd09f9ffe"}]
21:19:29 INFO - 1499833169246 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]
21:19:29 INFO - 1499833169248 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}]
21:19:29 INFO - TEST-END: test_click.py TestClick.test_input_file1499833169250 Marionette TRACE 388 <- [1,5,null,{"value":null}]
21:19:29 INFO - 1499833169251 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
21:19:29 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 109ms
21:19:29 INFO - TEST-START | test_click.py TestClick.test_obscured_element
21:19:29 INFO - 1499833169252 Marionette TRACE 388 <- [1,6,null,{}]
21:19:29 INFO - 1499833169253 Marionette DEBUG Closed connection 388
21:19:29 INFO - 1499833169254 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49815
21:19:29 INFO - 1499833169255 Marionette DEBUG Closed connection 389
21:19:29 INFO - 1499833169255 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49816
21:19:29 INFO - 1499833169257 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169257 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169260 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169262 Marionette TRACE 390 <- [1,1,null,{"sessionId":"56aae3be-670e-4b83-ac04-7184d5de138d","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169263 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
21:19:29 INFO - 1499833169264 Marionette TRACE 390 <- [1,2,null,{}]
21:19:29 INFO - 1499833169265 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:29 INFO - 1499833169265 Marionette TRACE 390 <- [1,3,null,{}]
21:19:29 INFO - 1499833169266 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:29 INFO - 1499833169266 Marionette TRACE 390 <- [1,4,null,{}]
21:19:29 INFO - 1499833169268 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}]
21:19:29 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499833169270 Marionette TRACE 390 <- [1,5,null,{"value":null}]
21:19:29 INFO - 1499833169271 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
21:19:29 INFO - 1499833169272 Marionette TRACE 390 <- [1,6,null,{}]
21:19:29 INFO - 1499833169273 Marionette DEBUG Closed connection 390
21:19:29 INFO - 1499833169274 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49817
21:19:29 INFO - 1499833169275 Marionette DEBUG Closed connection 391
21:19:29 INFO - 1499833169276 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49818
21:19:29 INFO - 1499833169276 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169277 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169279 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169282 Marionette TRACE 392 <- [1,1,null,{"sessionId":"2a124477-dc67-46e6-a57c-b5a1554a184c","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169283 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
21:19:29 INFO - 1499833169284 Marionette TRACE 392 <- [1,2,null,{}]
21:19:29 INFO - 1499833169285 Marionette DEBUG Closed connection 392
21:19:29 INFO - 1499833169286 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49819
21:19:29 INFO - 1499833169286 Marionette DEBUG Closed connection 393
21:19:29 INFO - 1499833169287 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49820
21:19:29 INFO - 1499833169288 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:29 INFO - 1499833169288 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169290 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169293 Marionette TRACE 394 <- [1,1,null,{"sessionId":"94f7fb9c-90d9-4a0a-beba-791bbc8fccea","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169294 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"}]
21:19:29 INFO - 1499833169295 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:19:29 INFO - 1499833169297 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:19:29 INFO - 1499833169297 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:19:29 INFO - 1499833169303 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"
21:19:29 INFO - 1499833169305 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"
21:19:29 INFO - 1499833169308 Marionette TRACE 394 <- [1,2,null,{}]
21:19:29 INFO - 1499833169311 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
21:19:29 INFO - 1499833169313 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d513a103-0e64-4f3d-ad6c-b774073a3066","ELEMENT":"d513a103-0e64-4f3d-ad6c-b774073a3066"}}]
21:19:29 INFO - 1499833169314 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
21:19:29 INFO - 1499833169316 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1eb2ec28-e9aa-42eb-b3d2-281c86ef421f","ELEMENT":"1eb2ec28-e9aa-42eb-b3d2-281c86ef421f"}}]
21:19:29 INFO - 1499833169316 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"d513a103-0e64-4f3d-ad6c-b774073a3066"}]
21:19:29 INFO - 1499833169555 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:19:29 INFO - 1499833169555 Marionette TRACE 394 <- [1,5,null,{}]
21:19:29 INFO - 1499833169557 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"1eb2ec28-e9aa-42eb-b3d2-281c86ef421f"}]
21:19:29 INFO - 1499833169570 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]
21:19:29 INFO - 1499833169572 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
21:19:29 INFO - 1499833169575 Marionette TRACE 394 <- [1,7,null,{"value":false}]
21:19:29 INFO - 1499833169576 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}]
21:19:29 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499833169578 Marionette TRACE 394 <- [1,8,null,{"value":null}]
21:19:29 INFO - 1499833169580 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
21:19:29 INFO - 1499833169581 Marionette TRACE 394 <- [1,9,null,{}]
21:19:29 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 329ms
21:19:29 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
21:19:29 INFO - 1499833169582 Marionette DEBUG Closed connection 394
21:19:29 INFO - 1499833169583 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49821
21:19:29 INFO - 1499833169584 Marionette DEBUG Closed connection 395
21:19:29 INFO - 1499833169585 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49822
21:19:29 INFO - 1499833169585 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169586 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169588 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169591 Marionette TRACE 396 <- [1,1,null,{"sessionId":"20b32fb9-806f-46b9-a71e-25920c27fa71","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169592 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
21:19:29 INFO - 1499833169592 Marionette TRACE 396 <- [1,2,null,{}]
21:19:29 INFO - 1499833169593 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:19:29 INFO - 1499833169594 Marionette TRACE 396 <- [1,3,null,{}]
21:19:29 INFO - 1499833169595 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
21:19:29 INFO - 1499833169595 Marionette TRACE 396 <- [1,4,null,{}]
21:19:29 INFO - 1499833169597 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}]
21:19:29 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499833169599 Marionette TRACE 396 <- [1,5,null,{"value":null}]
21:19:29 INFO - 1499833169600 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
21:19:29 INFO - 1499833169601 Marionette TRACE 396 <- [1,6,null,{}]
21:19:29 INFO - 1499833169603 Marionette DEBUG Closed connection 396
21:19:29 INFO - 1499833169603 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49823
21:19:29 INFO - 1499833169604 Marionette DEBUG Closed connection 397
21:19:29 INFO - 1499833169604 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49824
21:19:29 INFO - 1499833169605 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:19:29 INFO - 1499833169605 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169607 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169610 Marionette TRACE 398 <- [1,1,null,{"sessionId":"db101e51-dd53-4325-a24c-7bc616ba0cc7","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169611 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
21:19:29 INFO - 1499833169612 Marionette TRACE 398 <- [1,2,null,{}]
21:19:29 INFO - 1499833169613 Marionette DEBUG Closed connection 398
21:19:29 INFO - 1499833169614 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49825
21:19:29 INFO - 1499833169615 Marionette DEBUG Closed connection 399
21:19:29 INFO - 1499833169615 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49826
21:19:29 INFO - 1499833169616 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:19:29 INFO - 1499833169617 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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}
21:19:29 INFO - 1499833169619 Marionette DEBUG Register listener.js for window 4294967297
21:19:29 INFO - 1499833169622 Marionette TRACE 400 <- [1,1,null,{"sessionId":"4a0e6ab6-bd52-4cf6-9050-3ef879d2a45e","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":1772,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmprsaebp.mozrunner","moz:accessibilityChecks":false}}]
21:19:29 INFO - 1499833169623 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"}]
21:19:29 INFO - 1499833169624 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"
21:19:29 INFO - 1499833169626 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"
21:19:29 INFO - 1499833169626 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"
21:19:29 INFO - 1499833169632 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"
21:19:29 INFO - 1499833169634 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"
21:19:29 INFO - 1499833169640 Marionette TRACE 400 <- [1,2,null,{}]
21:19:29 INFO - 1499833169643 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
21:19:29 INFO - 1499833169645 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0a9b9305-bc9a-4a1d-89a4-d1348fa21d3d","ELEMENT":"0a9b9305-bc9a-4a1d-89a4-d1348fa21d3d"}}]
21:19:29 INFO - 1499833169647 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0a9b9305-bc9a-4a1d-89a4-d1348fa21d3d"}]
21:19:29 INFO - 1499833169669 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
21:19:29 INFO - 1499833169670 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0a9b9305-bc9a-4a1d-89a4-d1348fa21d3d"}]
21:19:29 INFO - 1499833169684 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element