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]
04:15:19 INFO - 1499339719674 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}]
04:15:19 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499339719677 Marionette TRACE 352 <- [1,5,null,{"value":null}]
04:15:19 INFO - 1499339719678 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
04:15:19 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
04:15:19 INFO - 1499339719680 Marionette TRACE 352 <- [1,6,null,{}]
04:15:19 INFO - 1499339719682 Marionette DEBUG Closed connection 352
04:15:19 INFO - 1499339719683 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49768
04:15:19 INFO - 1499339719684 Marionette DEBUG Closed connection 353
04:15:19 INFO - 1499339719685 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49769
04:15:19 INFO - 1499339719686 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:19 INFO - 1499339719686 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719689 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719693 Marionette TRACE 354 <- [1,1,null,{"sessionId":"962e0406-34ee-420a-b6e6-1a166e9964f1","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719694 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
04:15:19 INFO - 1499339719694 Marionette TRACE 354 <- [1,2,null,{}]
04:15:19 INFO - 1499339719696 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:19 INFO - 1499339719696 Marionette TRACE 354 <- [1,3,null,{}]
04:15:19 INFO - 1499339719697 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:19 INFO - 1499339719697 Marionette TRACE 354 <- [1,4,null,{}]
04:15:19 INFO - 1499339719699 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}]
04:15:19 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499339719701 Marionette TRACE 354 <- [1,5,null,{"value":null}]
04:15:19 INFO - 1499339719702 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
04:15:19 INFO - 1499339719704 Marionette TRACE 354 <- [1,6,null,{}]
04:15:19 INFO - 1499339719706 Marionette DEBUG Closed connection 354
04:15:19 INFO - 1499339719706 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49770
04:15:19 INFO - 1499339719707 Marionette DEBUG Closed connection 355
04:15:19 INFO - 1499339719708 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49771
04:15:19 INFO - 1499339719709 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:19 INFO - 1499339719709 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719712 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719715 Marionette TRACE 356 <- [1,1,null,{"sessionId":"f8dfbc4e-b20d-4c12-9f3f-9ef9b6f9cb3b","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719717 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
04:15:19 INFO - 1499339719718 Marionette TRACE 356 <- [1,2,null,{}]
04:15:19 INFO - 1499339719720 Marionette DEBUG Closed connection 356
04:15:19 INFO - 1499339719721 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49772
04:15:19 INFO - 1499339719722 Marionette DEBUG Closed connection 357
04:15:19 INFO - 1499339719722 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49773
04:15:19 INFO - 1499339719723 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:19 INFO - 1499339719724 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719727 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719730 Marionette TRACE 358 <- [1,1,null,{"sessionId":"e240cc45-30db-49f2-8214-3f0e1a6b8ecd","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719731 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49331/clicks.html"}]
04:15:19 INFO - 1499339719733 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/hidden.html"
04:15:19 INFO - 1499339719742 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/hidden.html"
04:15:19 INFO - 1499339719743 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/hidden.html"
04:15:19 INFO - 1499339719752 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/clicks.html"
04:15:19 INFO - 1499339719760 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/clicks.html"
04:15:19 INFO - 1499339719761 Marionette TRACE 358 <- [1,2,null,{}]
04:15:19 INFO - 1499339719764 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
04:15:19 INFO - 1499339719766 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"23f8ff7f-2b28-4aaa-9f24-bf70c4728b29","ELEMENT":"23f8ff7f-2b28-4aaa-9f24-bf70c4728b29"}}]
04:15:19 INFO - 1499339719768 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"23f8ff7f-2b28-4aaa-9f24-bf70c4728b29"}]
04:15:19 INFO - 1499339719815 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/clicks.html"
04:15:19 INFO - 1499339719822 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/clicks.html"
04:15:19 INFO - 1499339719823 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/clicks.html"
04:15:19 INFO - 1499339719830 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/test.html"
04:15:19 INFO - 1499339719834 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/test.html"
04:15:19 INFO - 1499339719834 Marionette TRACE 358 <- [1,4,null,{}]
04:15:19 INFO - 1499339719841 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
04:15:19 INFO - 1499339719844 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"aae5a493-e54b-4521-ae34-e9490e37e824","ELEMENT":"aae5a493-e54b-4521-ae34-e9490e37e824"}}]
04:15:19 INFO - 1499339719845 Marionette TRACE 358 -> [0,6,"getTitle",{}]
04:15:19 INFO - 1499339719846 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
04:15:19 INFO - 1499339719847 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}]
04:15:19 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499339719850 Marionette TRACE 358 <- [1,7,null,{"value":null}]
04:15:19 INFO - 1499339719851 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
04:15:19 INFO - 1499339719853 Marionette TRACE 358 <- [1,8,null,{}]
04:15:19 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 175ms
04:15:19 INFO - TEST-START | test_click.py TestClick.test_container_element
04:15:19 INFO - 1499339719858 Marionette DEBUG Closed connection 358
04:15:19 INFO - 1499339719859 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49776
04:15:19 INFO - 1499339719859 Marionette DEBUG Closed connection 359
04:15:19 INFO - 1499339719860 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49777
04:15:19 INFO - 1499339719861 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:19 INFO - 1499339719862 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719865 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719869 Marionette TRACE 360 <- [1,1,null,{"sessionId":"7a28b9fe-8fee-4790-a2bd-ddede2bd467e","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719870 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
04:15:19 INFO - 1499339719871 Marionette TRACE 360 <- [1,2,null,{}]
04:15:19 INFO - 1499339719872 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:19 INFO - 1499339719872 Marionette TRACE 360 <- [1,3,null,{}]
04:15:19 INFO - 1499339719874 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:19 INFO - 1499339719874 Marionette TRACE 360 <- [1,4,null,{}]
04:15:19 INFO - 1499339719876 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}]
04:15:19 INFO - TEST-START: test_click.py TestClick.test_container_element1499339719878 Marionette TRACE 360 <- [1,5,null,{"value":null}]
04:15:19 INFO - 1499339719879 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
04:15:19 INFO - 1499339719881 Marionette TRACE 360 <- [1,6,null,{}]
04:15:19 INFO - 1499339719883 Marionette DEBUG Closed connection 360
04:15:19 INFO - 1499339719883 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49778
04:15:19 INFO - 1499339719884 Marionette DEBUG Closed connection 361
04:15:19 INFO - 1499339719885 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49779
04:15:19 INFO - 1499339719886 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:19 INFO - 1499339719886 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719890 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719893 Marionette TRACE 362 <- [1,1,null,{"sessionId":"cb0dabba-81c9-4b26-9f81-7cc2773d509f","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719895 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
04:15:19 INFO - 1499339719896 Marionette TRACE 362 <- [1,2,null,{}]
04:15:19 INFO - 1499339719898 Marionette DEBUG Closed connection 362
04:15:19 INFO - 1499339719898 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49780
04:15:19 INFO - 1499339719899 Marionette DEBUG Closed connection 363
04:15:19 INFO - 1499339719900 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49781
04:15:19 INFO - 1499339719901 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:19 INFO - 1499339719901 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:19 INFO - 1499339719904 Marionette DEBUG Register listener.js for window 4294967297
04:15:19 INFO - 1499339719907 Marionette TRACE 364 <- [1,1,null,{"sessionId":"d6307a9e-f032-4a69-a112-4357860e9200","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:19 INFO - 1499339719908 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"}]
04:15:19 INFO - 1499339719910 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/test.html"
04:15:19 INFO - 1499339719912 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/test.html"
04:15:19 INFO - 1499339719913 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/test.html"
04:15:19 INFO - 1499339719928 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"
04:15:19 INFO - 1499339719929 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"
04:15:19 INFO - 1499339719934 Marionette TRACE 364 <- [1,2,null,{}]
04:15:19 INFO - 1499339719940 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:15:19 INFO - 1499339719943 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1d9fee61-08ef-42cb-9415-fecc989015d3","ELEMENT":"1d9fee61-08ef-42cb-9415-fecc989015d3"}}]
04:15:19 INFO - 1499339719944 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"1d9fee61-08ef-42cb-9415-fecc989015d3"}]
04:15:20 INFO - 1499339720186 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:15:20 INFO - 1499339720187 Marionette TRACE 364 <- [1,4,null,{}]
04:15:20 INFO - 1499339720188 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"1d9fee61-08ef-42cb-9415-fecc989015d3","name":"selected"}]
04:15:20 INFO - 1499339720250 Marionette TRACE 364 <- [1,5,null,{"value":true}]
04:15:20 INFO - 1499339720256 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}]
04:15:20 INFO - TEST-END: test_click.py TestClick.test_container_element1499339720260 Marionette TRACE 364 <- [1,6,null,{"value":null}]
04:15:20 INFO - 1499339720263 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
04:15:20 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 410ms
04:15:20 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
04:15:20 INFO - 1499339720266 Marionette TRACE 364 <- [1,7,null,{}]
04:15:20 INFO - 1499339720269 Marionette DEBUG Closed connection 364
04:15:20 INFO - 1499339720270 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49782
04:15:20 INFO - 1499339720271 Marionette DEBUG Closed connection 365
04:15:20 INFO - 1499339720272 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49783
04:15:20 INFO - 1499339720274 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:20 INFO - 1499339720278 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720281 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720287 Marionette TRACE 366 <- [1,1,null,{"sessionId":"b3f150c8-3a75-4020-89c9-4d4b4286d57d","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720289 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
04:15:20 INFO - 1499339720290 Marionette TRACE 366 <- [1,2,null,{}]
04:15:20 INFO - 1499339720292 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:20 INFO - 1499339720293 Marionette TRACE 366 <- [1,3,null,{}]
04:15:20 INFO - 1499339720294 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:20 INFO - 1499339720295 Marionette TRACE 366 <- [1,4,null,{}]
04:15:20 INFO - 1499339720298 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}]
04:15:20 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499339720302 Marionette TRACE 366 <- [1,5,null,{"value":null}]
04:15:20 INFO - 1499339720304 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
04:15:20 INFO - 1499339720306 Marionette TRACE 366 <- [1,6,null,{}]
04:15:20 INFO - 1499339720309 Marionette DEBUG Closed connection 366
04:15:20 INFO - 1499339720309 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49784
04:15:20 INFO - 1499339720311 Marionette DEBUG Closed connection 367
04:15:20 INFO - 1499339720312 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49785
04:15:20 INFO - 1499339720313 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:20 INFO - 1499339720314 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720317 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720322 Marionette TRACE 368 <- [1,1,null,{"sessionId":"bf6ad5da-7f48-4737-ba62-20530dc3eb53","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720324 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
04:15:20 INFO - 1499339720326 Marionette TRACE 368 <- [1,2,null,{}]
04:15:20 INFO - 1499339720328 Marionette DEBUG Closed connection 368
04:15:20 INFO - 1499339720329 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49786
04:15:20 INFO - 1499339720330 Marionette DEBUG Closed connection 369
04:15:20 INFO - 1499339720331 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49787
04:15:20 INFO - 1499339720334 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:20 INFO - 1499339720336 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720339 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720343 Marionette TRACE 370 <- [1,1,null,{"sessionId":"2461c235-7cb3-4244-9a4f-5c609a84d287","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720345 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"}]
04:15:20 INFO - 1499339720347 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"
04:15:20 INFO - 1499339720349 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"
04:15:20 INFO - 1499339720349 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"
04:15:20 INFO - 1499339720357 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"
04:15:20 INFO - 1499339720360 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"
04:15:20 INFO - 1499339720373 Marionette TRACE 370 <- [1,2,null,{}]
04:15:20 INFO - 1499339720392 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:15:20 INFO - 1499339720396 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9dcc11d3-bac2-41c5-bc9e-e7bab76744a9","ELEMENT":"9dcc11d3-bac2-41c5-bc9e-e7bab76744a9"}}]
04:15:20 INFO - 1499339720398 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"9dcc11d3-bac2-41c5-bc9e-e7bab76744a9"}]
04:15:20 INFO - 1499339720644 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:15:20 INFO - 1499339720645 Marionette TRACE 370 <- [1,4,null,{}]
04:15:20 INFO - 1499339720647 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"9dcc11d3-bac2-41c5-bc9e-e7bab76744a9","name":"selected"}]
04:15:20 INFO - 1499339720652 Marionette TRACE 370 <- [1,5,null,{"value":true}]
04:15:20 INFO - 1499339720653 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}]
04:15:20 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499339720656 Marionette TRACE 370 <- [1,6,null,{"value":null}]
04:15:20 INFO - 1499339720657 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
04:15:20 INFO - 1499339720659 Marionette TRACE 370 <- [1,7,null,{}]
04:15:20 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 393ms
04:15:20 INFO - TEST-START | test_click.py TestClick.test_css_transforms
04:15:20 INFO - 1499339720661 Marionette DEBUG Closed connection 370
04:15:20 INFO - 1499339720662 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49788
04:15:20 INFO - 1499339720663 Marionette DEBUG Closed connection 371
04:15:20 INFO - 1499339720663 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49789
04:15:20 INFO - 1499339720664 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:20 INFO - 1499339720665 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720668 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720673 Marionette TRACE 372 <- [1,1,null,{"sessionId":"6c707a46-7d05-4dcd-8e4c-85b0fcd3d8ae","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720675 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
04:15:20 INFO - 1499339720676 Marionette TRACE 372 <- [1,2,null,{}]
04:15:20 INFO - 1499339720677 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:20 INFO - 1499339720677 Marionette TRACE 372 <- [1,3,null,{}]
04:15:20 INFO - 1499339720678 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:20 INFO - 1499339720679 Marionette TRACE 372 <- [1,4,null,{}]
04:15:20 INFO - 1499339720681 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}]
04:15:20 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499339720684 Marionette TRACE 372 <- [1,5,null,{"value":null}]
04:15:20 INFO - 1499339720685 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
04:15:20 INFO - 1499339720686 Marionette TRACE 372 <- [1,6,null,{}]
04:15:20 INFO - 1499339720688 Marionette DEBUG Closed connection 372
04:15:20 INFO - 1499339720689 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49790
04:15:20 INFO - 1499339720690 Marionette DEBUG Closed connection 373
04:15:20 INFO - 1499339720690 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49791
04:15:20 INFO - 1499339720691 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:20 INFO - 1499339720692 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720695 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720699 Marionette TRACE 374 <- [1,1,null,{"sessionId":"b9ddbbc5-f9c9-4f32-b954-d0c1dcc137a8","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720701 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
04:15:20 INFO - 1499339720703 Marionette TRACE 374 <- [1,2,null,{}]
04:15:20 INFO - 1499339720706 Marionette DEBUG Closed connection 374
04:15:20 INFO - 1499339720708 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49792
04:15:20 INFO - 1499339720709 Marionette DEBUG Closed connection 375
04:15:20 INFO - 1499339720710 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49793
04:15:20 INFO - 1499339720711 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:20 INFO - 1499339720713 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:20 INFO - 1499339720716 Marionette DEBUG Register listener.js for window 4294967297
04:15:20 INFO - 1499339720720 Marionette TRACE 376 <- [1,1,null,{"sessionId":"edb36c8a-77ea-4f71-942c-ecc6f570fff4","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:20 INFO - 1499339720722 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"}]
04:15:20 INFO - 1499339720724 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"
04:15:20 INFO - 1499339720726 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"
04:15:20 INFO - 1499339720726 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"
04:15:20 INFO - 1499339720733 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"
04:15:20 INFO - 1499339720736 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"
04:15:20 INFO - 1499339720749 Marionette TRACE 376 <- [1,2,null,{}]
04:15:20 INFO - 1499339720756 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
04:15:20 INFO - 1499339720760 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3ed4f22f-01d4-42f2-8c23-f10d339cd2d1","ELEMENT":"3ed4f22f-01d4-42f2-8c23-f10d339cd2d1"}}]
04:15:20 INFO - 1499339720762 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"3ed4f22f-01d4-42f2-8c23-f10d339cd2d1"}]
04:15:21 INFO - 1499339721008 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:15:21 INFO - 1499339721009 Marionette TRACE 376 <- [1,4,null,{}]
04:15:21 INFO - 1499339721011 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}]
04:15:21 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499339721014 Marionette TRACE 376 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721015 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
04:15:21 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 356ms
04:15:21 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
04:15:21 INFO - 1499339721016 Marionette TRACE 376 <- [1,6,null,{}]
04:15:21 INFO - 1499339721018 Marionette DEBUG Closed connection 376
04:15:21 INFO - 1499339721019 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49794
04:15:21 INFO - 1499339721020 Marionette DEBUG Closed connection 377
04:15:21 INFO - 1499339721021 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49795
04:15:21 INFO - 1499339721022 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721023 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721026 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721029 Marionette TRACE 378 <- [1,1,null,{"sessionId":"54469b13-3cdb-4044-a585-0a729ccf1065","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721031 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
04:15:21 INFO - 1499339721032 Marionette TRACE 378 <- [1,2,null,{}]
04:15:21 INFO - 1499339721033 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:21 INFO - 1499339721033 Marionette TRACE 378 <- [1,3,null,{}]
04:15:21 INFO - 1499339721035 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:21 INFO - 1499339721035 Marionette TRACE 378 <- [1,4,null,{}]
04:15:21 INFO - 1499339721037 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}]
04:15:21 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499339721040 Marionette TRACE 378 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721041 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721043 Marionette TRACE 378 <- [1,6,null,{}]
04:15:21 INFO - 1499339721045 Marionette DEBUG Closed connection 378
04:15:21 INFO - 1499339721045 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49796
04:15:21 INFO - 1499339721046 Marionette DEBUG Closed connection 379
04:15:21 INFO - 1499339721047 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49797
04:15:21 INFO - 1499339721048 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721048 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721052 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721055 Marionette TRACE 380 <- [1,1,null,{"sessionId":"89da8ef2-10b5-4b5a-b4f5-e5da994c3783","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721056 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
04:15:21 INFO - 1499339721058 Marionette TRACE 380 <- [1,2,null,{}]
04:15:21 INFO - 1499339721060 Marionette DEBUG Closed connection 380
04:15:21 INFO - 1499339721060 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49798
04:15:21 INFO - 1499339721061 Marionette DEBUG Closed connection 381
04:15:21 INFO - 1499339721062 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49799
04:15:21 INFO - 1499339721063 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:21 INFO - 1499339721064 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721066 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721070 Marionette TRACE 382 <- [1,1,null,{"sessionId":"be125545-7476-4a40-9283-aeaa3e5d4e0a","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721071 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"}]
04:15:21 INFO - 1499339721073 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"
04:15:21 INFO - 1499339721075 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"
04:15:21 INFO - 1499339721075 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"
04:15:21 INFO - 1499339721081 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"
04:15:21 INFO - 1499339721085 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"
04:15:21 INFO - 1499339721094 Marionette TRACE 382 <- [1,2,null,{}]
04:15:21 INFO - 1499339721097 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
04:15:21 INFO - 1499339721100 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9f566958-72b6-4960-a37d-1aa0fe89f9f6","ELEMENT":"9f566958-72b6-4960-a37d-1aa0fe89f9f6"}}]
04:15:21 INFO - 1499339721105 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"9f566958-72b6-4960-a37d-1aa0fe89f9f6"}]
04:15:21 INFO - 1499339721346 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:15:21 INFO - 1499339721348 Marionette TRACE 382 <- [1,4,null,{}]
04:15:21 INFO - 1499339721350 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}]
04:15:21 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499339721352 Marionette TRACE 382 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721353 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721355 Marionette TRACE 382 <- [1,6,null,{}]
04:15:21 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 338ms
04:15:21 INFO - TEST-START | test_click.py TestClick.test_input_file
04:15:21 INFO - 1499339721357 Marionette DEBUG Closed connection 382
04:15:21 INFO - 1499339721358 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49800
04:15:21 INFO - 1499339721359 Marionette DEBUG Closed connection 383
04:15:21 INFO - 1499339721359 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49801
04:15:21 INFO - 1499339721360 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721361 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721364 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721367 Marionette TRACE 384 <- [1,1,null,{"sessionId":"80b3df35-16d7-4caf-99ef-f63574574dd7","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721368 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
04:15:21 INFO - 1499339721369 Marionette TRACE 384 <- [1,2,null,{}]
04:15:21 INFO - 1499339721370 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:21 INFO - 1499339721371 Marionette TRACE 384 <- [1,3,null,{}]
04:15:21 INFO - 1499339721372 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:21 INFO - 1499339721372 Marionette TRACE 384 <- [1,4,null,{}]
04:15:21 INFO - 1499339721374 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}]
04:15:21 INFO - TEST-START: test_click.py TestClick.test_input_file1499339721377 Marionette TRACE 384 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721378 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721379 Marionette TRACE 384 <- [1,6,null,{}]
04:15:21 INFO - 1499339721381 Marionette DEBUG Closed connection 384
04:15:21 INFO - 1499339721382 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49802
04:15:21 INFO - 1499339721383 Marionette DEBUG Closed connection 385
04:15:21 INFO - 1499339721384 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49803
04:15:21 INFO - 1499339721386 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721387 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721391 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721396 Marionette TRACE 386 <- [1,1,null,{"sessionId":"971d222d-2a2e-4339-8595-78109b4f4a98","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721397 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
04:15:21 INFO - 1499339721398 Marionette TRACE 386 <- [1,2,null,{}]
04:15:21 INFO - 1499339721400 Marionette DEBUG Closed connection 386
04:15:21 INFO - 1499339721401 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49804
04:15:21 INFO - 1499339721402 Marionette DEBUG Closed connection 387
04:15:21 INFO - 1499339721403 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49805
04:15:21 INFO - 1499339721404 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:21 INFO - 1499339721404 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721407 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721411 Marionette TRACE 388 <- [1,1,null,{"sessionId":"d69d8f89-1a49-4c68-930c-229e0057190a","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721412 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
04:15:21 INFO - 1499339721414 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"
04:15:21 INFO - 1499339721416 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"
04:15:21 INFO - 1499339721417 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"
04:15:21 INFO - 1499339721423 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:15:21 INFO - 1499339721427 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:15:21 INFO - 1499339721430 Marionette TRACE 388 <- [1,2,null,{}]
04:15:21 INFO - 1499339721433 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
04:15:21 INFO - 1499339721440 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ba5b5634-df83-451f-87c2-64ace2f385c6","ELEMENT":"ba5b5634-df83-451f-87c2-64ace2f385c6"}}]
04:15:21 INFO - 1499339721441 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"ba5b5634-df83-451f-87c2-64ace2f385c6"}]
04:15:21 INFO - 1499339721478 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]
04:15:21 INFO - 1499339721479 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}]
04:15:21 INFO - TEST-END: test_click.py TestClick.test_input_file1499339721482 Marionette TRACE 388 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721484 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721485 Marionette TRACE 388 <- [1,6,null,{}]
04:15:21 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 129ms
04:15:21 INFO - TEST-START | test_click.py TestClick.test_obscured_element
04:15:21 INFO - 1499339721487 Marionette DEBUG Closed connection 388
04:15:21 INFO - 1499339721487 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49806
04:15:21 INFO - 1499339721488 Marionette DEBUG Closed connection 389
04:15:21 INFO - 1499339721489 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49807
04:15:21 INFO - 1499339721491 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721491 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721494 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721497 Marionette TRACE 390 <- [1,1,null,{"sessionId":"9cf6453a-92f5-423f-8ed7-87388d9da778","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721498 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
04:15:21 INFO - 1499339721499 Marionette TRACE 390 <- [1,2,null,{}]
04:15:21 INFO - 1499339721500 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:21 INFO - 1499339721500 Marionette TRACE 390 <- [1,3,null,{}]
04:15:21 INFO - 1499339721501 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:21 INFO - 1499339721502 Marionette TRACE 390 <- [1,4,null,{}]
04:15:21 INFO - 1499339721503 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}]
04:15:21 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499339721506 Marionette TRACE 390 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721507 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721509 Marionette TRACE 390 <- [1,6,null,{}]
04:15:21 INFO - 1499339721511 Marionette DEBUG Closed connection 390
04:15:21 INFO - 1499339721511 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49808
04:15:21 INFO - 1499339721512 Marionette DEBUG Closed connection 391
04:15:21 INFO - 1499339721513 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49809
04:15:21 INFO - 1499339721514 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721514 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721517 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721520 Marionette TRACE 392 <- [1,1,null,{"sessionId":"2e2ec193-5181-4504-b26d-c8191aa7317a","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721522 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
04:15:21 INFO - 1499339721523 Marionette TRACE 392 <- [1,2,null,{}]
04:15:21 INFO - 1499339721525 Marionette DEBUG Closed connection 392
04:15:21 INFO - 1499339721525 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49810
04:15:21 INFO - 1499339721526 Marionette DEBUG Closed connection 393
04:15:21 INFO - 1499339721527 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49811
04:15:21 INFO - 1499339721528 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:21 INFO - 1499339721529 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721532 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721535 Marionette TRACE 394 <- [1,1,null,{"sessionId":"bea3383b-ad3b-44d0-971e-047d4482dd45","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721536 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"}]
04:15:21 INFO - 1499339721538 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:15:21 INFO - 1499339721541 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:15:21 INFO - 1499339721541 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:15:21 INFO - 1499339721548 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"
04:15:21 INFO - 1499339721551 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"
04:15:21 INFO - 1499339721559 Marionette TRACE 394 <- [1,2,null,{}]
04:15:21 INFO - 1499339721562 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
04:15:21 INFO - 1499339721565 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6a9c6292-9b5e-46d2-96cb-59dfac8d5126","ELEMENT":"6a9c6292-9b5e-46d2-96cb-59dfac8d5126"}}]
04:15:21 INFO - 1499339721566 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
04:15:21 INFO - 1499339721571 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fb3d54a1-c314-4c24-9ca2-76a74b8ede58","ELEMENT":"fb3d54a1-c314-4c24-9ca2-76a74b8ede58"}}]
04:15:21 INFO - 1499339721573 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"6a9c6292-9b5e-46d2-96cb-59dfac8d5126"}]
04:15:21 INFO - 1499339721820 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:15:21 INFO - 1499339721821 Marionette TRACE 394 <- [1,5,null,{}]
04:15:21 INFO - 1499339721823 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"fb3d54a1-c314-4c24-9ca2-76a74b8ede58"}]
04:15:21 INFO - 1499339721839 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]
04:15:21 INFO - 1499339721841 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
04:15:21 INFO - 1499339721845 Marionette TRACE 394 <- [1,7,null,{"value":false}]
04:15:21 INFO - 1499339721846 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}]
04:15:21 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499339721849 Marionette TRACE 394 <- [1,8,null,{"value":null}]
04:15:21 INFO - 1499339721849 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
04:15:21 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 365ms
04:15:21 INFO - 1499339721851 Marionette TRACE 394 <- [1,9,null,{}]
04:15:21 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
04:15:21 INFO - 1499339721853 Marionette DEBUG Closed connection 394
04:15:21 INFO - 1499339721854 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49812
04:15:21 INFO - 1499339721855 Marionette DEBUG Closed connection 395
04:15:21 INFO - 1499339721856 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49813
04:15:21 INFO - 1499339721857 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721857 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721860 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721863 Marionette TRACE 396 <- [1,1,null,{"sessionId":"31bb9413-20f3-44ba-850c-25796e495349","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721865 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
04:15:21 INFO - 1499339721865 Marionette TRACE 396 <- [1,2,null,{}]
04:15:21 INFO - 1499339721866 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:15:21 INFO - 1499339721867 Marionette TRACE 396 <- [1,3,null,{}]
04:15:21 INFO - 1499339721868 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
04:15:21 INFO - 1499339721868 Marionette TRACE 396 <- [1,4,null,{}]
04:15:21 INFO - 1499339721870 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}]
04:15:21 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499339721873 Marionette TRACE 396 <- [1,5,null,{"value":null}]
04:15:21 INFO - 1499339721874 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
04:15:21 INFO - 1499339721875 Marionette TRACE 396 <- [1,6,null,{}]
04:15:21 INFO - 1499339721877 Marionette DEBUG Closed connection 396
04:15:21 INFO - 1499339721878 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49814
04:15:21 INFO - 1499339721879 Marionette DEBUG Closed connection 397
04:15:21 INFO - 1499339721879 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49815
04:15:21 INFO - 1499339721880 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:15:21 INFO - 1499339721881 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721884 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721887 Marionette TRACE 398 <- [1,1,null,{"sessionId":"ab60899c-9870-4022-93d4-fc1bd1c73f4e","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721888 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
04:15:21 INFO - 1499339721889 Marionette TRACE 398 <- [1,2,null,{}]
04:15:21 INFO - 1499339721891 Marionette DEBUG Closed connection 398
04:15:21 INFO - 1499339721892 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49816
04:15:21 INFO - 1499339721892 Marionette DEBUG Closed connection 399
04:15:21 INFO - 1499339721893 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49817
04:15:21 INFO - 1499339721894 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:15:21 INFO - 1499339721895 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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}
04:15:21 INFO - 1499339721898 Marionette DEBUG Register listener.js for window 4294967297
04:15:21 INFO - 1499339721902 Marionette TRACE 400 <- [1,1,null,{"sessionId":"8571834c-c924-43d7-a21c-771fd6d1a781","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":3440,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-015.001\\AppData\\Local\\Temp\\tmptufxpn.mozrunner","moz:accessibilityChecks":false}}]
04:15:21 INFO - 1499339721904 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"}]
04:15:21 INFO - 1499339721906 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"
04:15:21 INFO - 1499339721908 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"
04:15:21 INFO - 1499339721908 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"
04:15:21 INFO - 1499339721915 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"
04:15:21 INFO - 1499339721918 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"
04:15:21 INFO - 1499339721932 Marionette TRACE 400 <- [1,2,null,{}]
04:15:21 INFO - 1499339721939 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
04:15:21 INFO - 1499339721942 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"36907273-56a5-4526-93cb-3d235458d1bd","ELEMENT":"36907273-56a5-4526-93cb-3d235458d1bd"}}]
04:15:21 INFO - 1499339721943 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"36907273-56a5-4526-93cb-3d235458d1bd"}]
04:15:21 INFO - 1499339721968 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
04:15:21 INFO - 1499339721969 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"36907273-56a5-4526-93cb-3d235458d1bd"}]
04:15:21 INFO - 1499339721986 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element