could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:44:10 INFO - 1500407050135 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500407050137 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1500407050138 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1500407050139 Marionette TRACE 352 <- [1,6,null,{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 137ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:44:10 INFO - 1500407050141 Marionette DEBUG Closed connection 352
12:44:10 INFO - 1500407050142 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49756
12:44:10 INFO - 1500407050142 Marionette DEBUG Closed connection 353
12:44:10 INFO - 1500407050143 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49757
12:44:10 INFO - 1500407050144 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050144 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050146 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050149 Marionette TRACE 354 <- [1,1,null,{"sessionId":"7fbd2019-4d5e-4486-8f0e-a3ca6acffb09","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050151 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1500407050151 Marionette TRACE 354 <- [1,2,null,{}]
12:44:10 INFO - 1500407050152 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1500407050152 Marionette TRACE 354 <- [1,3,null,{}]
12:44:10 INFO - 1500407050153 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1500407050154 Marionette TRACE 354 <- [1,4,null,{}]
12:44:10 INFO - 1500407050155 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500407050157 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1500407050158 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1500407050159 Marionette TRACE 354 <- [1,6,null,{}]
12:44:10 INFO - 1500407050161 Marionette DEBUG Closed connection 354
12:44:10 INFO - 1500407050161 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49758
12:44:10 INFO - 1500407050162 Marionette DEBUG Closed connection 355
12:44:10 INFO - 1500407050163 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49759
12:44:10 INFO - 1500407050163 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050164 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050166 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050168 Marionette TRACE 356 <- [1,1,null,{"sessionId":"2799fc27-3afe-4d2d-9104-8613795c2e52","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050170 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1500407050171 Marionette TRACE 356 <- [1,2,null,{}]
12:44:10 INFO - 1500407050173 Marionette DEBUG Closed connection 356
12:44:10 INFO - 1500407050173 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49760
12:44:10 INFO - 1500407050174 Marionette DEBUG Closed connection 357
12:44:10 INFO - 1500407050174 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49761
12:44:10 INFO - 1500407050175 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1500407050175 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050177 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050180 Marionette TRACE 358 <- [1,1,null,{"sessionId":"c2d16c25-5520-4635-b2dd-81ab526ac489","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050182 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49328/clicks.html"}]
12:44:10 INFO - 1500407050183 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/hidden.html"
12:44:10 INFO - 1500407050191 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/hidden.html"
12:44:10 INFO - 1500407050191 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/hidden.html"
12:44:10 INFO - 1500407050208 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/clicks.html"
12:44:10 INFO - 1500407050209 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/clicks.html"
12:44:10 INFO - 1500407050212 Marionette TRACE 358 <- [1,2,null,{}]
12:44:10 INFO - 1500407050213 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:44:10 INFO - 1500407050215 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5a1d2f31-0965-4f8a-bd8f-68a638cba4b9","ELEMENT":"5a1d2f31-0965-4f8a-bd8f-68a638cba4b9"}}]
12:44:10 INFO - 1500407050216 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"5a1d2f31-0965-4f8a-bd8f-68a638cba4b9"}]
12:44:10 INFO - 1500407050262 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/clicks.html"
12:44:10 INFO - 1500407050267 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/clicks.html"
12:44:10 INFO - 1500407050267 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/clicks.html"
12:44:10 INFO - 1500407050282 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/test.html"
12:44:10 INFO - 1500407050284 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/test.html"
12:44:10 INFO - 1500407050287 Marionette TRACE 358 <- [1,4,null,{}]
12:44:10 INFO - 1500407050296 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:44:10 INFO - 1500407050298 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f304ef6a-e65c-49db-8233-5fe734f36d80","ELEMENT":"f304ef6a-e65c-49db-8233-5fe734f36d80"}}]
12:44:10 INFO - 1500407050298 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:44:10 INFO - 1500407050299 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:44:10 INFO - 1500407050301 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500407050304 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:44:10 INFO - 1500407050305 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:44:10 INFO - 1500407050306 Marionette TRACE 358 <- [1,8,null,{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 167ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element
12:44:10 INFO - 1500407050308 Marionette DEBUG Closed connection 358
12:44:10 INFO - 1500407050309 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49764
12:44:10 INFO - 1500407050310 Marionette DEBUG Closed connection 359
12:44:10 INFO - 1500407050310 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49765
12:44:10 INFO - 1500407050311 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050312 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050314 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050316 Marionette TRACE 360 <- [1,1,null,{"sessionId":"a8043b59-bf46-40db-8082-6bbbdcaae5c7","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050318 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1500407050318 Marionette TRACE 360 <- [1,2,null,{}]
12:44:10 INFO - 1500407050319 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1500407050320 Marionette TRACE 360 <- [1,3,null,{}]
12:44:10 INFO - 1500407050321 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1500407050321 Marionette TRACE 360 <- [1,4,null,{}]
12:44:10 INFO - 1500407050322 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element1500407050325 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1500407050325 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1500407050326 Marionette TRACE 360 <- [1,6,null,{}]
12:44:10 INFO - 1500407050329 Marionette DEBUG Closed connection 360
12:44:10 INFO - 1500407050329 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49766
12:44:10 INFO - 1500407050330 Marionette DEBUG Closed connection 361
12:44:10 INFO - 1500407050331 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49767
12:44:10 INFO - 1500407050331 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050332 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050334 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050337 Marionette TRACE 362 <- [1,1,null,{"sessionId":"e6610039-ceba-4289-9678-f89de09e8559","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050338 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1500407050339 Marionette TRACE 362 <- [1,2,null,{}]
12:44:10 INFO - 1500407050341 Marionette DEBUG Closed connection 362
12:44:10 INFO - 1500407050341 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49768
12:44:10 INFO - 1500407050342 Marionette DEBUG Closed connection 363
12:44:10 INFO - 1500407050343 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49769
12:44:10 INFO - 1500407050343 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1500407050344 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050346 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050349 Marionette TRACE 364 <- [1,1,null,{"sessionId":"5e609f57-a66a-4d84-8b34-0f69923ae309","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050351 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1500407050352 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/test.html"
12:44:10 INFO - 1500407050354 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/test.html"
12:44:10 INFO - 1500407050354 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/test.html"
12:44:10 INFO - 1500407050366 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050370 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050378 Marionette TRACE 364 <- [1,2,null,{}]
12:44:10 INFO - 1500407050380 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1500407050382 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6dfbf931-e0e9-4a44-82f6-ec218ca35104","ELEMENT":"6dfbf931-e0e9-4a44-82f6-ec218ca35104"}}]
12:44:10 INFO - 1500407050383 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"6dfbf931-e0e9-4a44-82f6-ec218ca35104"}]
12:44:10 INFO - 1500407050619 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:10 INFO - 1500407050620 Marionette TRACE 364 <- [1,4,null,{}]
12:44:10 INFO - 1500407050621 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"6dfbf931-e0e9-4a44-82f6-ec218ca35104","name":"selected"}]
12:44:10 INFO - 1500407050625 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:44:10 INFO - 1500407050626 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_container_element1500407050628 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:44:10 INFO - 1500407050629 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 324ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:44:10 INFO - 1500407050630 Marionette TRACE 364 <- [1,7,null,{}]
12:44:10 INFO - 1500407050632 Marionette DEBUG Closed connection 364
12:44:10 INFO - 1500407050633 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49770
12:44:10 INFO - 1500407050633 Marionette DEBUG Closed connection 365
12:44:10 INFO - 1500407050634 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49771
12:44:10 INFO - 1500407050635 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050635 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050637 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050640 Marionette TRACE 366 <- [1,1,null,{"sessionId":"81f68e0d-6fd1-44df-84b3-0d07cd705de1","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050641 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1500407050642 Marionette TRACE 366 <- [1,2,null,{}]
12:44:10 INFO - 1500407050643 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1500407050643 Marionette TRACE 366 <- [1,3,null,{}]
12:44:10 INFO - 1500407050644 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1500407050645 Marionette TRACE 366 <- [1,4,null,{}]
12:44:10 INFO - 1500407050647 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500407050649 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1500407050650 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1500407050651 Marionette TRACE 366 <- [1,6,null,{}]
12:44:10 INFO - 1500407050652 Marionette DEBUG Closed connection 366
12:44:10 INFO - 1500407050653 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49772
12:44:10 INFO - 1500407050654 Marionette DEBUG Closed connection 367
12:44:10 INFO - 1500407050654 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49773
12:44:10 INFO - 1500407050655 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050655 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050657 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050660 Marionette TRACE 368 <- [1,1,null,{"sessionId":"34d0e666-727d-4716-a1da-8f154aa1fdcd","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050662 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1500407050663 Marionette TRACE 368 <- [1,2,null,{}]
12:44:10 INFO - 1500407050665 Marionette DEBUG Closed connection 368
12:44:10 INFO - 1500407050665 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49774
12:44:10 INFO - 1500407050666 Marionette DEBUG Closed connection 369
12:44:10 INFO - 1500407050667 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49775
12:44:10 INFO - 1500407050668 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1500407050668 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050670 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050681 Marionette TRACE 370 <- [1,1,null,{"sessionId":"1c27e39e-d340-4a1a-a0d2-8323c2fb073c","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050682 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1500407050684 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050685 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050685 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050700 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050702 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1500407050711 Marionette TRACE 370 <- [1,2,null,{}]
12:44:10 INFO - 1500407050713 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1500407050715 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9bd3ebe0-878e-44e0-85a2-c8b7f54d6763","ELEMENT":"9bd3ebe0-878e-44e0-85a2-c8b7f54d6763"}}]
12:44:10 INFO - 1500407050716 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"9bd3ebe0-878e-44e0-85a2-c8b7f54d6763"}]
12:44:10 INFO - 1500407050952 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:10 INFO - 1500407050953 Marionette TRACE 370 <- [1,4,null,{}]
12:44:10 INFO - 1500407050954 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"9bd3ebe0-878e-44e0-85a2-c8b7f54d6763","name":"selected"}]
12:44:10 INFO - 1500407050957 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:44:10 INFO - 1500407050959 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500407050961 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 333ms
12:44:10 INFO - 1500407050962 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:44:10 INFO - 1500407050963 Marionette TRACE 370 <- [1,7,null,{}]
12:44:10 INFO - 1500407050965 Marionette DEBUG Closed connection 370
12:44:10 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:44:10 INFO - 1500407050967 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49776
12:44:10 INFO - 1500407050968 Marionette DEBUG Closed connection 371
12:44:10 INFO - 1500407050968 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49777
12:44:10 INFO - 1500407050969 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050970 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050972 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050974 Marionette TRACE 372 <- [1,1,null,{"sessionId":"0f854892-aeff-411a-9051-25413d10172b","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050976 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1500407050976 Marionette TRACE 372 <- [1,2,null,{}]
12:44:10 INFO - 1500407050977 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1500407050977 Marionette TRACE 372 <- [1,3,null,{}]
12:44:10 INFO - 1500407050978 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1500407050978 Marionette TRACE 372 <- [1,4,null,{}]
12:44:10 INFO - 1500407050980 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500407050982 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1500407050983 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1500407050984 Marionette TRACE 372 <- [1,6,null,{}]
12:44:10 INFO - 1500407050985 Marionette DEBUG Closed connection 372
12:44:10 INFO - 1500407050986 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49778
12:44:10 INFO - 1500407050986 Marionette DEBUG Closed connection 373
12:44:10 INFO - 1500407050987 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49779
12:44:10 INFO - 1500407050988 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1500407050988 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1500407050990 Marionette DEBUG Register listener.js for window 15
12:44:10 INFO - 1500407050992 Marionette TRACE 374 <- [1,1,null,{"sessionId":"ecc1b2bc-262c-4f27-a994-640bea62f80a","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1500407050994 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1500407050995 Marionette TRACE 374 <- [1,2,null,{}]
12:44:11 INFO - 1500407050997 Marionette DEBUG Closed connection 374
12:44:11 INFO - 1500407050997 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49780
12:44:11 INFO - 1500407050998 Marionette DEBUG Closed connection 375
12:44:11 INFO - 1500407050999 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49781
12:44:11 INFO - 1500407051000 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1500407051000 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051002 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051005 Marionette TRACE 376 <- [1,1,null,{"sessionId":"ef9b4654-12b7-427d-b111-d128917a50ff","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051007 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
12:44:11 INFO - 1500407051008 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051009 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051010 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051027 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1500407051029 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1500407051032 Marionette TRACE 376 <- [1,2,null,{}]
12:44:11 INFO - 1500407051034 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:44:11 INFO - 1500407051040 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e2d46a16-5948-4ed9-9ba2-8d193db3b43d","ELEMENT":"e2d46a16-5948-4ed9-9ba2-8d193db3b43d"}}]
12:44:11 INFO - 1500407051042 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"e2d46a16-5948-4ed9-9ba2-8d193db3b43d"}]
12:44:11 INFO - 1500407051284 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1500407051285 Marionette TRACE 376 <- [1,4,null,{}]
12:44:11 INFO - 1500407051286 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500407051289 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051290 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051291 Marionette TRACE 376 <- [1,6,null,{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 326ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:44:11 INFO - 1500407051293 Marionette DEBUG Closed connection 376
12:44:11 INFO - 1500407051294 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49782
12:44:11 INFO - 1500407051295 Marionette DEBUG Closed connection 377
12:44:11 INFO - 1500407051295 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49783
12:44:11 INFO - 1500407051296 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051297 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051299 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051301 Marionette TRACE 378 <- [1,1,null,{"sessionId":"72129c16-f481-4d37-8f80-bd14972893fb","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051303 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1500407051303 Marionette TRACE 378 <- [1,2,null,{}]
12:44:11 INFO - 1500407051304 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1500407051304 Marionette TRACE 378 <- [1,3,null,{}]
12:44:11 INFO - 1500407051305 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1500407051306 Marionette TRACE 378 <- [1,4,null,{}]
12:44:11 INFO - 1500407051307 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500407051309 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051310 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051311 Marionette TRACE 378 <- [1,6,null,{}]
12:44:11 INFO - 1500407051313 Marionette DEBUG Closed connection 378
12:44:11 INFO - 1500407051314 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49784
12:44:11 INFO - 1500407051314 Marionette DEBUG Closed connection 379
12:44:11 INFO - 1500407051315 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49785
12:44:11 INFO - 1500407051316 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051317 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051318 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051321 Marionette TRACE 380 <- [1,1,null,{"sessionId":"4a0a1caa-036e-4e54-86c0-fdb1e236334f","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051323 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1500407051324 Marionette TRACE 380 <- [1,2,null,{}]
12:44:11 INFO - 1500407051325 Marionette DEBUG Closed connection 380
12:44:11 INFO - 1500407051326 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49786
12:44:11 INFO - 1500407051326 Marionette DEBUG Closed connection 381
12:44:11 INFO - 1500407051327 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49787
12:44:11 INFO - 1500407051328 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1500407051328 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051330 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051332 Marionette TRACE 382 <- [1,1,null,{"sessionId":"6ab6753e-614a-43fb-9283-e6626ea986fd","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051334 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:11 INFO - 1500407051335 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1500407051337 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1500407051337 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1500407051346 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051349 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051352 Marionette TRACE 382 <- [1,2,null,{}]
12:44:11 INFO - 1500407051361 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:44:11 INFO - 1500407051363 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ca808150-3a9c-4ce3-8a8e-706dd973eb9f","ELEMENT":"ca808150-3a9c-4ce3-8a8e-706dd973eb9f"}}]
12:44:11 INFO - 1500407051364 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"ca808150-3a9c-4ce3-8a8e-706dd973eb9f"}]
12:44:11 INFO - 1500407051600 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1500407051601 Marionette TRACE 382 <- [1,4,null,{}]
12:44:11 INFO - 1500407051602 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500407051604 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051605 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051606 Marionette TRACE 382 <- [1,6,null,{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 315ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_input_file
12:44:11 INFO - 1500407051608 Marionette DEBUG Closed connection 382
12:44:11 INFO - 1500407051609 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49788
12:44:11 INFO - 1500407051610 Marionette DEBUG Closed connection 383
12:44:11 INFO - 1500407051610 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49789
12:44:11 INFO - 1500407051611 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051612 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051614 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051616 Marionette TRACE 384 <- [1,1,null,{"sessionId":"660cfd4e-043b-410a-a411-9537746cf757","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051618 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1500407051618 Marionette TRACE 384 <- [1,2,null,{}]
12:44:11 INFO - 1500407051619 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1500407051619 Marionette TRACE 384 <- [1,3,null,{}]
12:44:11 INFO - 1500407051620 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1500407051621 Marionette TRACE 384 <- [1,4,null,{}]
12:44:11 INFO - 1500407051622 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_input_file1500407051624 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051625 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051626 Marionette TRACE 384 <- [1,6,null,{}]
12:44:11 INFO - 1500407051628 Marionette DEBUG Closed connection 384
12:44:11 INFO - 1500407051628 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49790
12:44:11 INFO - 1500407051629 Marionette DEBUG Closed connection 385
12:44:11 INFO - 1500407051630 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49791
12:44:11 INFO - 1500407051631 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051631 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051633 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051635 Marionette TRACE 386 <- [1,1,null,{"sessionId":"cf616fbb-c192-45b2-a1f2-aae6ee7b4faa","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051637 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1500407051638 Marionette TRACE 386 <- [1,2,null,{}]
12:44:11 INFO - 1500407051640 Marionette DEBUG Closed connection 386
12:44:11 INFO - 1500407051640 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49792
12:44:11 INFO - 1500407051641 Marionette DEBUG Closed connection 387
12:44:11 INFO - 1500407051641 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49793
12:44:11 INFO - 1500407051642 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1500407051643 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051645 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051647 Marionette TRACE 388 <- [1,1,null,{"sessionId":"d123f27e-0e0f-47ff-aa58-768516b671a5","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051649 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:44:11 INFO - 1500407051650 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051651 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051652 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1500407051667 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1500407051669 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1500407051676 Marionette TRACE 388 <- [1,2,null,{}]
12:44:11 INFO - 1500407051677 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:44:11 INFO - 1500407051679 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dd0e7d56-4223-42a2-8425-e9dd5680c676","ELEMENT":"dd0e7d56-4223-42a2-8425-e9dd5680c676"}}]
12:44:11 INFO - 1500407051680 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"dd0e7d56-4223-42a2-8425-e9dd5680c676"}]
12:44:11 INFO - 1500407051711 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:44:11 INFO - 1500407051713 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_input_file1500407051715 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051716 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051718 Marionette TRACE 388 <- [1,6,null,{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 111ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:44:11 INFO - 1500407051719 Marionette DEBUG Closed connection 388
12:44:11 INFO - 1500407051720 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49794
12:44:11 INFO - 1500407051721 Marionette DEBUG Closed connection 389
12:44:11 INFO - 1500407051722 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49795
12:44:11 INFO - 1500407051723 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051723 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051725 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051728 Marionette TRACE 390 <- [1,1,null,{"sessionId":"cc8e0514-af05-467c-b861-dd242422f148","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051729 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1500407051730 Marionette TRACE 390 <- [1,2,null,{}]
12:44:11 INFO - 1500407051731 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1500407051731 Marionette TRACE 390 <- [1,3,null,{}]
12:44:11 INFO - 1500407051732 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1500407051732 Marionette TRACE 390 <- [1,4,null,{}]
12:44:11 INFO - 1500407051734 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500407051736 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1500407051737 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1500407051738 Marionette TRACE 390 <- [1,6,null,{}]
12:44:11 INFO - 1500407051740 Marionette DEBUG Closed connection 390
12:44:11 INFO - 1500407051741 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49796
12:44:11 INFO - 1500407051741 Marionette DEBUG Closed connection 391
12:44:11 INFO - 1500407051742 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49797
12:44:11 INFO - 1500407051743 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1500407051743 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051745 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051747 Marionette TRACE 392 <- [1,1,null,{"sessionId":"bebad74b-3c46-42db-a6fa-e31981573818","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051749 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1500407051750 Marionette TRACE 392 <- [1,2,null,{}]
12:44:11 INFO - 1500407051752 Marionette DEBUG Closed connection 392
12:44:11 INFO - 1500407051753 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49798
12:44:11 INFO - 1500407051753 Marionette DEBUG Closed connection 393
12:44:11 INFO - 1500407051754 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49799
12:44:11 INFO - 1500407051755 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1500407051755 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1500407051757 Marionette DEBUG Register listener.js for window 15
12:44:11 INFO - 1500407051760 Marionette TRACE 394 <- [1,1,null,{"sessionId":"85e27951-4558-40cc-ad05-f6c741eaf09a","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1500407051761 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
12:44:11 INFO - 1500407051762 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1500407051764 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1500407051764 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1500407051780 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:11 INFO - 1500407051782 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:11 INFO - 1500407051785 Marionette TRACE 394 <- [1,2,null,{}]
12:44:11 INFO - 1500407051791 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:44:11 INFO - 1500407051793 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c87416a6-afb8-43ef-afe4-ba678e88d598","ELEMENT":"c87416a6-afb8-43ef-afe4-ba678e88d598"}}]
12:44:11 INFO - 1500407051794 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:44:11 INFO - 1500407051795 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a0c57ebb-5eb8-403c-8c4a-1427ef1fe220","ELEMENT":"a0c57ebb-5eb8-403c-8c4a-1427ef1fe220"}}]
12:44:11 INFO - 1500407051796 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"c87416a6-afb8-43ef-afe4-ba678e88d598"}]
12:44:12 INFO - 1500407052038 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:12 INFO - 1500407052039 Marionette TRACE 394 <- [1,5,null,{}]
12:44:12 INFO - 1500407052040 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"a0c57ebb-5eb8-403c-8c4a-1427ef1fe220"}]
12:44:12 INFO - 1500407052053 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:44:12 INFO - 1500407052055 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
12:44:12 INFO - 1500407052057 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:44:12 INFO - 1500407052058 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
12:44:12 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500407052060 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:44:12 INFO - 1500407052061 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:44:12 INFO - 1500407052062 Marionette TRACE 394 <- [1,9,null,{}]
12:44:12 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 344ms
12:44:12 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:44:12 INFO - 1500407052064 Marionette DEBUG Closed connection 394
12:44:12 INFO - 1500407052065 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49800
12:44:12 INFO - 1500407052065 Marionette DEBUG Closed connection 395
12:44:12 INFO - 1500407052066 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49801
12:44:12 INFO - 1500407052066 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1500407052067 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1500407052069 Marionette DEBUG Register listener.js for window 15
12:44:12 INFO - 1500407052071 Marionette TRACE 396 <- [1,1,null,{"sessionId":"b005324e-7f57-4da1-9e5e-53425b501bac","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1500407052073 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:44:12 INFO - 1500407052073 Marionette TRACE 396 <- [1,2,null,{}]
12:44:12 INFO - 1500407052074 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:12 INFO - 1500407052074 Marionette TRACE 396 <- [1,3,null,{}]
12:44:12 INFO - 1500407052075 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:12 INFO - 1500407052076 Marionette TRACE 396 <- [1,4,null,{}]
12:44:12 INFO - 1500407052080 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
12:44:12 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500407052082 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1500407052083 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:44:12 INFO - 1500407052084 Marionette TRACE 396 <- [1,6,null,{}]
12:44:12 INFO - 1500407052086 Marionette DEBUG Closed connection 396
12:44:12 INFO - 1500407052086 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49802
12:44:12 INFO - 1500407052087 Marionette DEBUG Closed connection 397
12:44:12 INFO - 1500407052088 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49803
12:44:12 INFO - 1500407052089 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1500407052089 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1500407052091 Marionette DEBUG Register listener.js for window 15
12:44:12 INFO - 1500407052094 Marionette TRACE 398 <- [1,1,null,{"sessionId":"aab6d24f-321a-4c2d-96cb-e0f31f398753","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1500407052096 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:44:12 INFO - 1500407052097 Marionette TRACE 398 <- [1,2,null,{}]
12:44:12 INFO - 1500407052098 Marionette DEBUG Closed connection 398
12:44:12 INFO - 1500407052099 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49804
12:44:12 INFO - 1500407052100 Marionette DEBUG Closed connection 399
12:44:12 INFO - 1500407052100 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49805
12:44:12 INFO - 1500407052101 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:12 INFO - 1500407052102 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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1500407052103 Marionette DEBUG Register listener.js for window 15
12:44:12 INFO - 1500407052106 Marionette TRACE 400 <- [1,1,null,{"sessionId":"825d5f64-504e-44f3-9302-5b05902cbb04","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":3552,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-286.001\\AppData\\Local\\Temp\\tmpoodeiy.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1500407052108 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
12:44:12 INFO - 1500407052109 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1500407052111 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1500407052111 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1500407052128 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:44:12 INFO - 1500407052129 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:44:12 INFO - 1500407052132 Marionette TRACE 400 <- [1,2,null,{}]
12:44:12 INFO - 1500407052133 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:44:12 INFO - 1500407052140 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a31276e0-54bc-4ff1-946b-c38fb55685d6","ELEMENT":"a31276e0-54bc-4ff1-946b-c38fb55685d6"}}]
12:44:12 INFO - 1500407052141 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"a31276e0-54bc-4ff1-946b-c38fb55685d6"}]
12:44:12 INFO - 1500407052164 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:44:12 INFO - 1500407052165 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"a31276e0-54bc-4ff1-946b-c38fb55685d6"}]
12:44:12 INFO - 1500407052178 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element