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:1330:5\n"},null]
10:16:36 INFO - 1499102196882 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:16:36 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499102196885 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:16:36 INFO - 1499102196886 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:16:36 INFO - 1499102196888 Marionette TRACE 352 <- [1,6,null,{}]
10:16:36 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 146ms
10:16:36 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:16:36 INFO - 1499102196890 Marionette DEBUG Closed connection 352
10:16:36 INFO - 1499102196891 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49753
10:16:36 INFO - 1499102196892 Marionette DEBUG Closed connection 353
10:16:36 INFO - 1499102196892 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49754
10:16:36 INFO - 1499102196893 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:36 INFO - 1499102196894 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:36 INFO - 1499102196896 Marionette DEBUG Register listener.js for window 12
10:16:36 INFO - 1499102196900 Marionette TRACE 354 <- [1,1,null,{"sessionId":"e8bd1134-98e7-41bb-9459-c0ba98559d1f","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:36 INFO - 1499102196901 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:16:36 INFO - 1499102196901 Marionette TRACE 354 <- [1,2,null,{}]
10:16:36 INFO - 1499102196902 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:36 INFO - 1499102196902 Marionette TRACE 354 <- [1,3,null,{}]
10:16:36 INFO - 1499102196903 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:36 INFO - 1499102196904 Marionette TRACE 354 <- [1,4,null,{}]
10:16:36 INFO - 1499102196905 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:16:36 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499102196908 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:16:36 INFO - 1499102196908 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:16:36 INFO - 1499102196910 Marionette TRACE 354 <- [1,6,null,{}]
10:16:36 INFO - 1499102196912 Marionette DEBUG Closed connection 354
10:16:36 INFO - 1499102196913 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49755
10:16:36 INFO - 1499102196913 Marionette DEBUG Closed connection 355
10:16:36 INFO - 1499102196914 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49756
10:16:36 INFO - 1499102196915 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:36 INFO - 1499102196916 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:36 INFO - 1499102196918 Marionette DEBUG Register listener.js for window 12
10:16:36 INFO - 1499102196922 Marionette TRACE 356 <- [1,1,null,{"sessionId":"27ceab05-80f0-451a-b0b4-7834d3639fbc","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:36 INFO - 1499102196923 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:16:36 INFO - 1499102196924 Marionette TRACE 356 <- [1,2,null,{}]
10:16:36 INFO - 1499102196927 Marionette DEBUG Closed connection 356
10:16:36 INFO - 1499102196927 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49757
10:16:36 INFO - 1499102196928 Marionette DEBUG Closed connection 357
10:16:36 INFO - 1499102196928 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49758
10:16:36 INFO - 1499102196930 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:36 INFO - 1499102196931 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:36 INFO - 1499102196934 Marionette DEBUG Register listener.js for window 12
10:16:36 INFO - 1499102196937 Marionette TRACE 358 <- [1,1,null,{"sessionId":"3b78a696-0fa7-4058-b659-2dda93330bae","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:36 INFO - 1499102196938 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49327/clicks.html"}]
10:16:36 INFO - 1499102196940 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/hidden.html"
10:16:36 INFO - 1499102196944 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/hidden.html"
10:16:36 INFO - 1499102196945 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/hidden.html"
10:16:36 INFO - 1499102196964 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/clicks.html"
10:16:36 INFO - 1499102196973 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/clicks.html"
10:16:36 INFO - 1499102196977 Marionette TRACE 358 <- [1,2,null,{}]
10:16:36 INFO - 1499102196978 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:16:36 INFO - 1499102196980 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cfd5628c-288d-4684-8b40-93e38cf94dc1","ELEMENT":"cfd5628c-288d-4684-8b40-93e38cf94dc1"}}]
10:16:36 INFO - 1499102196981 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"cfd5628c-288d-4684-8b40-93e38cf94dc1"}]
10:16:37 INFO - 1499102197030 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/clicks.html"
10:16:37 INFO - 1499102197039 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/clicks.html"
10:16:37 INFO - 1499102197039 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/clicks.html"
10:16:37 INFO - 1499102197059 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/test.html"
10:16:37 INFO - 1499102197061 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/test.html"
10:16:37 INFO - 1499102197063 Marionette TRACE 358 <- [1,4,null,{}]
10:16:37 INFO - 1499102197064 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:16:37 INFO - 1499102197073 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4b31e945-18eb-4aa5-8172-0a7dbe96ea3e","ELEMENT":"4b31e945-18eb-4aa5-8172-0a7dbe96ea3e"}}]
10:16:37 INFO - 1499102197074 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:16:37 INFO - 1499102197075 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:16:37 INFO - 1499102197077 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:16:37 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499102197080 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:16:37 INFO - 1499102197081 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:16:37 INFO - 1499102197082 Marionette TRACE 358 <- [1,8,null,{}]
10:16:37 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 194ms
10:16:37 INFO - TEST-START | test_click.py TestClick.test_container_element
10:16:37 INFO - 1499102197085 Marionette DEBUG Closed connection 358
10:16:37 INFO - 1499102197086 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49761
10:16:37 INFO - 1499102197087 Marionette DEBUG Closed connection 359
10:16:37 INFO - 1499102197087 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49762
10:16:37 INFO - 1499102197088 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197089 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197092 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197096 Marionette TRACE 360 <- [1,1,null,{"sessionId":"5043e885-a593-4633-a9b3-dc1c118d5cad","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197097 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:16:37 INFO - 1499102197097 Marionette TRACE 360 <- [1,2,null,{}]
10:16:37 INFO - 1499102197098 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:37 INFO - 1499102197099 Marionette TRACE 360 <- [1,3,null,{}]
10:16:37 INFO - 1499102197099 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:37 INFO - 1499102197100 Marionette TRACE 360 <- [1,4,null,{}]
10:16:37 INFO - 1499102197102 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:16:37 INFO - TEST-START: test_click.py TestClick.test_container_element1499102197105 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:16:37 INFO - 1499102197106 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:16:37 INFO - 1499102197107 Marionette TRACE 360 <- [1,6,null,{}]
10:16:37 INFO - 1499102197110 Marionette DEBUG Closed connection 360
10:16:37 INFO - 1499102197110 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49763
10:16:37 INFO - 1499102197111 Marionette DEBUG Closed connection 361
10:16:37 INFO - 1499102197111 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49764
10:16:37 INFO - 1499102197112 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197113 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197116 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197120 Marionette TRACE 362 <- [1,1,null,{"sessionId":"2a3ad4cc-b435-4f2d-a1cf-e3d3bb26ddc0","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197121 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:16:37 INFO - 1499102197122 Marionette TRACE 362 <- [1,2,null,{}]
10:16:37 INFO - 1499102197124 Marionette DEBUG Closed connection 362
10:16:37 INFO - 1499102197124 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49765
10:16:37 INFO - 1499102197125 Marionette DEBUG Closed connection 363
10:16:37 INFO - 1499102197126 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49766
10:16:37 INFO - 1499102197127 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:37 INFO - 1499102197127 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197130 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197140 Marionette TRACE 364 <- [1,1,null,{"sessionId":"c46e53cb-9d99-4fda-b9cf-1cdf1ff57d4c","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197142 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:16:37 INFO - 1499102197143 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/test.html"
10:16:37 INFO - 1499102197145 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/test.html"
10:16:37 INFO - 1499102197145 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/test.html"
10:16:37 INFO - 1499102197171 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197172 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197176 Marionette TRACE 364 <- [1,2,null,{}]
10:16:37 INFO - 1499102197177 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:16:37 INFO - 1499102197180 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0031cde8-ae21-46eb-98ff-85846c011d87","ELEMENT":"0031cde8-ae21-46eb-98ff-85846c011d87"}}]
10:16:37 INFO - 1499102197181 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"0031cde8-ae21-46eb-98ff-85846c011d87"}]
10:16:37 INFO - 1499102197430 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:16:37 INFO - 1499102197431 Marionette TRACE 364 <- [1,4,null,{}]
10:16:37 INFO - 1499102197432 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"0031cde8-ae21-46eb-98ff-85846c011d87","name":"selected"}]
10:16:37 INFO - 1499102197437 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:16:37 INFO - 1499102197439 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:16:37 INFO - TEST-END: test_click.py TestClick.test_container_element1499102197442 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:16:37 INFO - 1499102197443 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:16:37 INFO - 1499102197445 Marionette TRACE 364 <- [1,7,null,{}]
10:16:37 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 362ms
10:16:37 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:16:37 INFO - 1499102197447 Marionette DEBUG Closed connection 364
10:16:37 INFO - 1499102197449 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49767
10:16:37 INFO - 1499102197450 Marionette DEBUG Closed connection 365
10:16:37 INFO - 1499102197451 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49768
10:16:37 INFO - 1499102197452 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197453 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197456 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197459 Marionette TRACE 366 <- [1,1,null,{"sessionId":"1409d82e-b57d-45f3-a4e9-f147a9addba0","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197460 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:16:37 INFO - 1499102197461 Marionette TRACE 366 <- [1,2,null,{}]
10:16:37 INFO - 1499102197462 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:37 INFO - 1499102197462 Marionette TRACE 366 <- [1,3,null,{}]
10:16:37 INFO - 1499102197463 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:37 INFO - 1499102197463 Marionette TRACE 366 <- [1,4,null,{}]
10:16:37 INFO - 1499102197465 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:16:37 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499102197468 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:16:37 INFO - 1499102197469 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:16:37 INFO - 1499102197470 Marionette TRACE 366 <- [1,6,null,{}]
10:16:37 INFO - 1499102197473 Marionette DEBUG Closed connection 366
10:16:37 INFO - 1499102197474 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49769
10:16:37 INFO - 1499102197474 Marionette DEBUG Closed connection 367
10:16:37 INFO - 1499102197475 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49770
10:16:37 INFO - 1499102197476 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197477 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197480 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197484 Marionette TRACE 368 <- [1,1,null,{"sessionId":"997d4099-2d9c-44e9-8c8a-db69baccc759","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197485 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:16:37 INFO - 1499102197486 Marionette TRACE 368 <- [1,2,null,{}]
10:16:37 INFO - 1499102197489 Marionette DEBUG Closed connection 368
10:16:37 INFO - 1499102197489 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49771
10:16:37 INFO - 1499102197490 Marionette DEBUG Closed connection 369
10:16:37 INFO - 1499102197491 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49772
10:16:37 INFO - 1499102197492 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:37 INFO - 1499102197493 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197496 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197500 Marionette TRACE 370 <- [1,1,null,{"sessionId":"1b98bce3-ab00-4ba8-a4a8-4a5d7b9da8ea","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197502 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:16:37 INFO - 1499102197504 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197507 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197507 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197525 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197529 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197532 Marionette TRACE 370 <- [1,2,null,{}]
10:16:37 INFO - 1499102197541 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:16:37 INFO - 1499102197543 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"26a6de54-9c37-4bbd-b976-da9c217664e4","ELEMENT":"26a6de54-9c37-4bbd-b976-da9c217664e4"}}]
10:16:37 INFO - 1499102197544 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"26a6de54-9c37-4bbd-b976-da9c217664e4"}]
10:16:37 INFO - 1499102197795 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:16:37 INFO - 1499102197796 Marionette TRACE 370 <- [1,4,null,{}]
10:16:37 INFO - 1499102197797 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"26a6de54-9c37-4bbd-b976-da9c217664e4","name":"selected"}]
10:16:37 INFO - 1499102197801 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:16:37 INFO - 1499102197803 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:16:37 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499102197806 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:16:37 INFO - 1499102197807 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:16:37 INFO - 1499102197808 Marionette TRACE 370 <- [1,7,null,{}]
10:16:37 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 363ms
10:16:37 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:16:37 INFO - 1499102197810 Marionette DEBUG Closed connection 370
10:16:37 INFO - 1499102197811 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49773
10:16:37 INFO - 1499102197812 Marionette DEBUG Closed connection 371
10:16:37 INFO - 1499102197812 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49774
10:16:37 INFO - 1499102197814 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197814 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197817 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197820 Marionette TRACE 372 <- [1,1,null,{"sessionId":"c145ee2f-5631-4eb2-b5f9-839311248e50","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197821 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:16:37 INFO - 1499102197822 Marionette TRACE 372 <- [1,2,null,{}]
10:16:37 INFO - 1499102197823 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:37 INFO - 1499102197824 Marionette TRACE 372 <- [1,3,null,{}]
10:16:37 INFO - 1499102197825 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:37 INFO - 1499102197825 Marionette TRACE 372 <- [1,4,null,{}]
10:16:37 INFO - 1499102197827 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:16:37 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499102197829 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:16:37 INFO - 1499102197830 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:16:37 INFO - 1499102197831 Marionette TRACE 372 <- [1,6,null,{}]
10:16:37 INFO - 1499102197833 Marionette DEBUG Closed connection 372
10:16:37 INFO - 1499102197834 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49775
10:16:37 INFO - 1499102197835 Marionette DEBUG Closed connection 373
10:16:37 INFO - 1499102197836 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49776
10:16:37 INFO - 1499102197837 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:37 INFO - 1499102197837 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197840 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197843 Marionette TRACE 374 <- [1,1,null,{"sessionId":"28fcf6a7-9af8-4a0d-845b-613055d63431","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197844 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:16:37 INFO - 1499102197845 Marionette TRACE 374 <- [1,2,null,{}]
10:16:37 INFO - 1499102197847 Marionette DEBUG Closed connection 374
10:16:37 INFO - 1499102197849 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49777
10:16:37 INFO - 1499102197850 Marionette DEBUG Closed connection 375
10:16:37 INFO - 1499102197851 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49778
10:16:37 INFO - 1499102197852 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:37 INFO - 1499102197853 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:37 INFO - 1499102197855 Marionette DEBUG Register listener.js for window 12
10:16:37 INFO - 1499102197859 Marionette TRACE 376 <- [1,1,null,{"sessionId":"0549f54f-8f9a-4e55-acb2-a6671bd265d3","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:37 INFO - 1499102197860 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:16:37 INFO - 1499102197861 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197864 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197864 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:37 INFO - 1499102197886 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:16:37 INFO - 1499102197889 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:16:37 INFO - 1499102197892 Marionette TRACE 376 <- [1,2,null,{}]
10:16:37 INFO - 1499102197893 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:16:37 INFO - 1499102197895 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f27257b3-c4d0-41b5-81cf-dfac7b0ba50f","ELEMENT":"f27257b3-c4d0-41b5-81cf-dfac7b0ba50f"}}]
10:16:37 INFO - 1499102197896 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"f27257b3-c4d0-41b5-81cf-dfac7b0ba50f"}]
10:16:38 INFO - 1499102198139 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:16:38 INFO - 1499102198139 Marionette TRACE 376 <- [1,4,null,{}]
10:16:38 INFO - 1499102198141 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:16:38 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499102198144 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198145 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198146 Marionette TRACE 376 <- [1,6,null,{}]
10:16:38 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 338ms
10:16:38 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:16:38 INFO - 1499102198148 Marionette DEBUG Closed connection 376
10:16:38 INFO - 1499102198150 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49779
10:16:38 INFO - 1499102198151 Marionette DEBUG Closed connection 377
10:16:38 INFO - 1499102198152 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49780
10:16:38 INFO - 1499102198153 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198153 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198156 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198159 Marionette TRACE 378 <- [1,1,null,{"sessionId":"1ef004c7-b6fd-40e8-a597-916e433cdd57","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198160 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:16:38 INFO - 1499102198161 Marionette TRACE 378 <- [1,2,null,{}]
10:16:38 INFO - 1499102198162 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:38 INFO - 1499102198162 Marionette TRACE 378 <- [1,3,null,{}]
10:16:38 INFO - 1499102198163 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:38 INFO - 1499102198163 Marionette TRACE 378 <- [1,4,null,{}]
10:16:38 INFO - 1499102198165 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:16:38 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499102198167 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198168 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198169 Marionette TRACE 378 <- [1,6,null,{}]
10:16:38 INFO - 1499102198171 Marionette DEBUG Closed connection 378
10:16:38 INFO - 1499102198172 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49781
10:16:38 INFO - 1499102198173 Marionette DEBUG Closed connection 379
10:16:38 INFO - 1499102198174 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49782
10:16:38 INFO - 1499102198175 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198176 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198178 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198182 Marionette TRACE 380 <- [1,1,null,{"sessionId":"a53b1026-5b28-4da6-918c-20296c9e702a","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198183 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:16:38 INFO - 1499102198184 Marionette TRACE 380 <- [1,2,null,{}]
10:16:38 INFO - 1499102198186 Marionette DEBUG Closed connection 380
10:16:38 INFO - 1499102198186 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49783
10:16:38 INFO - 1499102198187 Marionette DEBUG Closed connection 381
10:16:38 INFO - 1499102198188 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49784
10:16:38 INFO - 1499102198189 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:38 INFO - 1499102198190 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198193 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198196 Marionette TRACE 382 <- [1,1,null,{"sessionId":"336f1305-0222-4c94-adb6-f0480bf9cf57","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198197 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:16:38 INFO - 1499102198199 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:16:38 INFO - 1499102198201 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:16:38 INFO - 1499102198201 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:16:38 INFO - 1499102198212 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:38 INFO - 1499102198223 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:38 INFO - 1499102198227 Marionette TRACE 382 <- [1,2,null,{}]
10:16:38 INFO - 1499102198228 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:16:38 INFO - 1499102198230 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e165670d-c361-4bb9-b813-c08bc04de821","ELEMENT":"e165670d-c361-4bb9-b813-c08bc04de821"}}]
10:16:38 INFO - 1499102198238 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"e165670d-c361-4bb9-b813-c08bc04de821"}]
10:16:38 INFO - 1499102198488 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:16:38 INFO - 1499102198489 Marionette TRACE 382 <- [1,4,null,{}]
10:16:38 INFO - 1499102198491 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:16:38 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499102198493 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198494 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198496 Marionette TRACE 382 <- [1,6,null,{}]
10:16:38 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 348ms
10:16:38 INFO - TEST-START | test_click.py TestClick.test_input_file
10:16:38 INFO - 1499102198498 Marionette DEBUG Closed connection 382
10:16:38 INFO - 1499102198499 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49785
10:16:38 INFO - 1499102198499 Marionette DEBUG Closed connection 383
10:16:38 INFO - 1499102198500 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49786
10:16:38 INFO - 1499102198501 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198502 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198504 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198507 Marionette TRACE 384 <- [1,1,null,{"sessionId":"541ef28c-b0f1-4e09-ae8e-471601e41a3c","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198508 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:16:38 INFO - 1499102198509 Marionette TRACE 384 <- [1,2,null,{}]
10:16:38 INFO - 1499102198510 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:38 INFO - 1499102198510 Marionette TRACE 384 <- [1,3,null,{}]
10:16:38 INFO - 1499102198511 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:38 INFO - 1499102198512 Marionette TRACE 384 <- [1,4,null,{}]
10:16:38 INFO - 1499102198513 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:16:38 INFO - TEST-START: test_click.py TestClick.test_input_file1499102198516 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198517 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198518 Marionette TRACE 384 <- [1,6,null,{}]
10:16:38 INFO - 1499102198520 Marionette DEBUG Closed connection 384
10:16:38 INFO - 1499102198521 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49787
10:16:38 INFO - 1499102198522 Marionette DEBUG Closed connection 385
10:16:38 INFO - 1499102198522 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49788
10:16:38 INFO - 1499102198524 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198524 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198527 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198530 Marionette TRACE 386 <- [1,1,null,{"sessionId":"fb9973aa-bd07-45c6-8f80-8579eb1c5fad","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198532 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:16:38 INFO - 1499102198533 Marionette TRACE 386 <- [1,2,null,{}]
10:16:38 INFO - 1499102198535 Marionette DEBUG Closed connection 386
10:16:38 INFO - 1499102198536 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49789
10:16:38 INFO - 1499102198537 Marionette DEBUG Closed connection 387
10:16:38 INFO - 1499102198538 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49790
10:16:38 INFO - 1499102198539 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:38 INFO - 1499102198539 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198542 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198545 Marionette TRACE 388 <- [1,1,null,{"sessionId":"42b847ea-5821-4ecf-9f2c-49edf9e0a675","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198547 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:16:38 INFO - 1499102198548 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:38 INFO - 1499102198550 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:38 INFO - 1499102198551 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:16:38 INFO - 1499102198561 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:16:38 INFO - 1499102198572 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:16:38 INFO - 1499102198576 Marionette TRACE 388 <- [1,2,null,{}]
10:16:38 INFO - 1499102198577 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:16:38 INFO - 1499102198580 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"886250b2-e6a0-4bf4-ac36-8dbc6bc4b1b3","ELEMENT":"886250b2-e6a0-4bf4-ac36-8dbc6bc4b1b3"}}]
10:16:38 INFO - 1499102198586 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"886250b2-e6a0-4bf4-ac36-8dbc6bc4b1b3"}]
10:16:38 INFO - 1499102198616 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:1330:5\n"},null]
10:16:38 INFO - 1499102198629 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:16:38 INFO - TEST-END: test_click.py TestClick.test_input_file1499102198632 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198634 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198637 Marionette TRACE 388 <- [1,6,null,{}]
10:16:38 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 141ms
10:16:38 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:16:38 INFO - 1499102198640 Marionette DEBUG Closed connection 388
10:16:38 INFO - 1499102198641 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49791
10:16:38 INFO - 1499102198643 Marionette DEBUG Closed connection 389
10:16:38 INFO - 1499102198643 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49792
10:16:38 INFO - 1499102198645 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198648 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198651 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198663 Marionette TRACE 390 <- [1,1,null,{"sessionId":"64b264b4-e9f4-41c0-9866-6bc3d383e3e2","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198666 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:16:38 INFO - 1499102198668 Marionette TRACE 390 <- [1,2,null,{}]
10:16:38 INFO - 1499102198669 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:38 INFO - 1499102198670 Marionette TRACE 390 <- [1,3,null,{}]
10:16:38 INFO - 1499102198671 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:38 INFO - 1499102198673 Marionette TRACE 390 <- [1,4,null,{}]
10:16:38 INFO - 1499102198675 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:16:38 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499102198679 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:16:38 INFO - 1499102198680 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:16:38 INFO - 1499102198682 Marionette TRACE 390 <- [1,6,null,{}]
10:16:38 INFO - 1499102198685 Marionette DEBUG Closed connection 390
10:16:38 INFO - 1499102198686 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49793
10:16:38 INFO - 1499102198687 Marionette DEBUG Closed connection 391
10:16:38 INFO - 1499102198688 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49794
10:16:38 INFO - 1499102198689 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:38 INFO - 1499102198691 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198694 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198700 Marionette TRACE 392 <- [1,1,null,{"sessionId":"2de8afd5-50a7-408e-ab9b-ae37104da320","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198701 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:16:38 INFO - 1499102198703 Marionette TRACE 392 <- [1,2,null,{}]
10:16:38 INFO - 1499102198706 Marionette DEBUG Closed connection 392
10:16:38 INFO - 1499102198706 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49795
10:16:38 INFO - 1499102198708 Marionette DEBUG Closed connection 393
10:16:38 INFO - 1499102198708 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49796
10:16:38 INFO - 1499102198711 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:38 INFO - 1499102198713 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:38 INFO - 1499102198716 Marionette DEBUG Register listener.js for window 12
10:16:38 INFO - 1499102198721 Marionette TRACE 394 <- [1,1,null,{"sessionId":"f23b3a80-2715-4d68-910c-c456fccd26f8","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:38 INFO - 1499102198722 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:16:38 INFO - 1499102198724 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:16:38 INFO - 1499102198727 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:16:38 INFO - 1499102198728 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:16:38 INFO - 1499102198768 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:16:38 INFO - 1499102198771 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:16:38 INFO - 1499102198775 Marionette TRACE 394 <- [1,2,null,{}]
10:16:38 INFO - 1499102198776 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:16:38 INFO - 1499102198779 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"eb1a1f7e-1934-4702-bc21-d123f890b43c","ELEMENT":"eb1a1f7e-1934-4702-bc21-d123f890b43c"}}]
10:16:38 INFO - 1499102198785 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:16:38 INFO - 1499102198789 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8b1ba95b-57b1-4e03-9345-6eb33d2286f8","ELEMENT":"8b1ba95b-57b1-4e03-9345-6eb33d2286f8"}}]
10:16:38 INFO - 1499102198789 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"eb1a1f7e-1934-4702-bc21-d123f890b43c"}]
10:16:39 INFO - 1499102199038 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:16:39 INFO - 1499102199039 Marionette TRACE 394 <- [1,5,null,{}]
10:16:39 INFO - 1499102199040 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"8b1ba95b-57b1-4e03-9345-6eb33d2286f8"}]
10:16:39 INFO - 1499102199060 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:1330:5\n"},null]
10:16:39 INFO - 1499102199063 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:16:39 INFO - 1499102199066 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:16:39 INFO - 1499102199068 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:16:39 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499102199070 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:16:39 INFO - 1499102199072 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:16:39 INFO - 1499102199073 Marionette TRACE 394 <- [1,9,null,{}]
10:16:39 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 435ms
10:16:39 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:16:39 INFO - 1499102199076 Marionette DEBUG Closed connection 394
10:16:39 INFO - 1499102199076 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49797
10:16:39 INFO - 1499102199077 Marionette DEBUG Closed connection 395
10:16:39 INFO - 1499102199078 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49798
10:16:39 INFO - 1499102199079 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:39 INFO - 1499102199080 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:39 INFO - 1499102199083 Marionette DEBUG Register listener.js for window 12
10:16:39 INFO - 1499102199088 Marionette TRACE 396 <- [1,1,null,{"sessionId":"12518650-7565-49e2-92f5-71df2e73a8ce","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:39 INFO - 1499102199161 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:16:39 INFO - 1499102199163 Marionette TRACE 396 <- [1,2,null,{}]
10:16:39 INFO - 1499102199165 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:16:39 INFO - 1499102199167 Marionette TRACE 396 <- [1,3,null,{}]
10:16:39 INFO - 1499102199168 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:16:39 INFO - 1499102199170 Marionette TRACE 396 <- [1,4,null,{}]
10:16:39 INFO - 1499102199172 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:16:39 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499102199176 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:16:39 INFO - 1499102199177 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:16:39 INFO - 1499102199180 Marionette TRACE 396 <- [1,6,null,{}]
10:16:39 INFO - 1499102199196 Marionette DEBUG Closed connection 396
10:16:39 INFO - 1499102199197 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49799
10:16:39 INFO - 1499102199199 Marionette DEBUG Closed connection 397
10:16:39 INFO - 1499102199199 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49800
10:16:39 INFO - 1499102199201 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:16:39 INFO - 1499102199203 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:39 INFO - 1499102199206 Marionette DEBUG Register listener.js for window 12
10:16:39 INFO - 1499102199213 Marionette TRACE 398 <- [1,1,null,{"sessionId":"699064cc-2479-4853-b9e7-dbd43dd1c417","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:39 INFO - 1499102199214 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:16:39 INFO - 1499102199216 Marionette TRACE 398 <- [1,2,null,{}]
10:16:39 INFO - 1499102199219 Marionette DEBUG Closed connection 398
10:16:39 INFO - 1499102199220 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49801
10:16:39 INFO - 1499102199221 Marionette DEBUG Closed connection 399
10:16:39 INFO - 1499102199222 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49802
10:16:39 INFO - 1499102199224 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:16:39 INFO - 1499102199225 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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}
10:16:39 INFO - 1499102199228 Marionette DEBUG Register listener.js for window 12
10:16:39 INFO - 1499102199233 Marionette TRACE 400 <- [1,1,null,{"sessionId":"7e263317-1de2-4133-a99f-c9e979e592e5","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":1432,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpc24xav.mozrunner","moz:accessibilityChecks":false}}]
10:16:39 INFO - 1499102199239 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:16:39 INFO - 1499102199241 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:16:39 INFO - 1499102199245 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:16:39 INFO - 1499102199245 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:16:39 INFO - 1499102199271 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:16:39 INFO - 1499102199273 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:16:39 INFO - 1499102199278 Marionette TRACE 400 <- [1,2,null,{}]
10:16:39 INFO - 1499102199279 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:16:39 INFO - 1499102199289 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bc5798dd-aea3-4b1b-9942-5f9304c303e0","ELEMENT":"bc5798dd-aea3-4b1b-9942-5f9304c303e0"}}]
10:16:39 INFO - 1499102199291 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"bc5798dd-aea3-4b1b-9942-5f9304c303e0"}]
10:16:39 INFO - 1499102199330 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:16:39 INFO - 1499102199331 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"bc5798dd-aea3-4b1b-9942-5f9304c303e0"}]
10:16:39 INFO - 1499102199353 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element