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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
02:12:39 INFO - 1501060359168 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}]
02:12:39 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1501060359171 Marionette TRACE 352 <- [1,5,null,{"value":null}]
02:12:39 INFO - 1501060359171 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
02:12:39 INFO - 1501060359173 Marionette TRACE 352 <- [1,6,null,{}]
02:12:39 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 132ms
02:12:39 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
02:12:39 INFO - 1501060359174 Marionette DEBUG Closed connection 352
02:12:39 INFO - 1501060359176 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49765
02:12:39 INFO - 1501060359176 Marionette DEBUG Closed connection 353
02:12:39 INFO - 1501060359177 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49766
02:12:39 INFO - 1501060359178 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359179 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359181 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359192 Marionette TRACE 354 <- [1,1,null,{"sessionId":"98b48356-9dda-4f91-a382-c7c351ccda09","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359193 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
02:12:39 INFO - 1501060359194 Marionette TRACE 354 <- [1,2,null,{}]
02:12:39 INFO - 1501060359195 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:39 INFO - 1501060359195 Marionette TRACE 354 <- [1,3,null,{}]
02:12:39 INFO - 1501060359196 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:39 INFO - 1501060359197 Marionette TRACE 354 <- [1,4,null,{}]
02:12:39 INFO - 1501060359198 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}]
02:12:39 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1501060359201 Marionette TRACE 354 <- [1,5,null,{"value":null}]
02:12:39 INFO - 1501060359202 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
02:12:39 INFO - 1501060359204 Marionette TRACE 354 <- [1,6,null,{}]
02:12:39 INFO - 1501060359205 Marionette DEBUG Closed connection 354
02:12:39 INFO - 1501060359206 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49767
02:12:39 INFO - 1501060359207 Marionette DEBUG Closed connection 355
02:12:39 INFO - 1501060359207 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49768
02:12:39 INFO - 1501060359208 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359209 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359211 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359215 Marionette TRACE 356 <- [1,1,null,{"sessionId":"896d61c3-b4a5-4c4b-8fe0-2fa66ddb4bc3","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359216 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
02:12:39 INFO - 1501060359218 Marionette TRACE 356 <- [1,2,null,{}]
02:12:39 INFO - 1501060359219 Marionette DEBUG Closed connection 356
02:12:39 INFO - 1501060359220 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49769
02:12:39 INFO - 1501060359220 Marionette DEBUG Closed connection 357
02:12:39 INFO - 1501060359221 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49770
02:12:39 INFO - 1501060359222 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:39 INFO - 1501060359223 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359225 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359228 Marionette TRACE 358 <- [1,1,null,{"sessionId":"0d78c4ef-e7c7-49ab-b7ee-b0f706177a15","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359229 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49329/clicks.html"}]
02:12:39 INFO - 1501060359231 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49329/hidden.html"
02:12:39 INFO - 1501060359240 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49329/hidden.html"
02:12:39 INFO - 1501060359240 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49329/hidden.html"
02:12:39 INFO - 1501060359256 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49329/clicks.html"
02:12:39 INFO - 1501060359258 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49329/clicks.html"
02:12:39 INFO - 1501060359265 Marionette TRACE 358 <- [1,2,null,{}]
02:12:39 INFO - 1501060359276 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
02:12:39 INFO - 1501060359278 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9f0f09eb-ce20-4942-8ae9-11dcb70d6208","ELEMENT":"9f0f09eb-ce20-4942-8ae9-11dcb70d6208"}}]
02:12:39 INFO - 1501060359279 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"9f0f09eb-ce20-4942-8ae9-11dcb70d6208"}]
02:12:39 INFO - 1501060359322 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49329/clicks.html"
02:12:39 INFO - 1501060359332 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49329/clicks.html"
02:12:39 INFO - 1501060359332 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49329/clicks.html"
02:12:39 INFO - 1501060359341 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49329/test.html"
02:12:39 INFO - 1501060359347 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49329/test.html"
02:12:39 INFO - 1501060359351 Marionette TRACE 358 <- [1,4,null,{}]
02:12:39 INFO - 1501060359356 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
02:12:39 INFO - 1501060359358 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"afb4a7b4-eb25-4958-b789-a3bc179e22cf","ELEMENT":"afb4a7b4-eb25-4958-b789-a3bc179e22cf"}}]
02:12:39 INFO - 1501060359359 Marionette TRACE 358 -> [0,6,"getTitle",{}]
02:12:39 INFO - 1501060359360 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
02:12:39 INFO - 1501060359361 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}]
02:12:39 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1501060359368 Marionette TRACE 358 <- [1,7,null,{"value":null}]
02:12:39 INFO - 1501060359369 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
02:12:39 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 197ms
02:12:39 INFO - TEST-START | test_click.py TestClick.test_container_element
02:12:39 INFO - 1501060359371 Marionette TRACE 358 <- [1,8,null,{}]
02:12:39 INFO - 1501060359372 Marionette DEBUG Closed connection 358
02:12:39 INFO - 1501060359373 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49773
02:12:39 INFO - 1501060359374 Marionette DEBUG Closed connection 359
02:12:39 INFO - 1501060359374 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49774
02:12:39 INFO - 1501060359376 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359376 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359378 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359382 Marionette TRACE 360 <- [1,1,null,{"sessionId":"15466f97-e865-4740-adeb-f19a4d910ed9","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359383 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
02:12:39 INFO - 1501060359384 Marionette TRACE 360 <- [1,2,null,{}]
02:12:39 INFO - 1501060359385 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:39 INFO - 1501060359385 Marionette TRACE 360 <- [1,3,null,{}]
02:12:39 INFO - 1501060359386 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:39 INFO - 1501060359387 Marionette TRACE 360 <- [1,4,null,{}]
02:12:39 INFO - 1501060359388 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}]
02:12:39 INFO - TEST-START: test_click.py TestClick.test_container_element1501060359391 Marionette TRACE 360 <- [1,5,null,{"value":null}]
02:12:39 INFO - 1501060359392 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
02:12:39 INFO - 1501060359393 Marionette TRACE 360 <- [1,6,null,{}]
02:12:39 INFO - 1501060359395 Marionette DEBUG Closed connection 360
02:12:39 INFO - 1501060359395 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49775
02:12:39 INFO - 1501060359396 Marionette DEBUG Closed connection 361
02:12:39 INFO - 1501060359397 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49776
02:12:39 INFO - 1501060359398 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359399 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359407 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359411 Marionette TRACE 362 <- [1,1,null,{"sessionId":"31b6bbe4-fb4a-4811-99b2-f33bd2e48810","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359412 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
02:12:39 INFO - 1501060359414 Marionette TRACE 362 <- [1,2,null,{}]
02:12:39 INFO - 1501060359416 Marionette DEBUG Closed connection 362
02:12:39 INFO - 1501060359416 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49777
02:12:39 INFO - 1501060359417 Marionette DEBUG Closed connection 363
02:12:39 INFO - 1501060359418 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49778
02:12:39 INFO - 1501060359419 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:39 INFO - 1501060359419 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359422 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359425 Marionette TRACE 364 <- [1,1,null,{"sessionId":"cb943629-9ccb-4cb0-af76-6c3119a67774","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359427 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"}]
02:12:39 INFO - 1501060359429 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49329/test.html"
02:12:39 INFO - 1501060359431 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49329/test.html"
02:12:39 INFO - 1501060359431 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49329/test.html"
02:12:39 INFO - 1501060359437 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"
02:12:39 INFO - 1501060359441 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"
02:12:39 INFO - 1501060359447 Marionette TRACE 364 <- [1,2,null,{}]
02:12:39 INFO - 1501060359456 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
02:12:39 INFO - 1501060359459 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6715aec5-4495-4390-9d61-ccbd80c6b961","ELEMENT":"6715aec5-4495-4390-9d61-ccbd80c6b961"}}]
02:12:39 INFO - 1501060359460 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"6715aec5-4495-4390-9d61-ccbd80c6b961"}]
02:12:39 INFO - 1501060359703 Marionette DEBUG Canceled page load listener because no navigation has been detected
02:12:39 INFO - 1501060359704 Marionette TRACE 364 <- [1,4,null,{}]
02:12:39 INFO - 1501060359705 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"6715aec5-4495-4390-9d61-ccbd80c6b961","name":"selected"}]
02:12:39 INFO - 1501060359710 Marionette TRACE 364 <- [1,5,null,{"value":true}]
02:12:39 INFO - 1501060359712 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}]
02:12:39 INFO - TEST-END: test_click.py TestClick.test_container_element1501060359714 Marionette TRACE 364 <- [1,6,null,{"value":null}]
02:12:39 INFO - 1501060359715 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
02:12:39 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 346ms
02:12:39 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
02:12:39 INFO - 1501060359717 Marionette TRACE 364 <- [1,7,null,{}]
02:12:39 INFO - 1501060359719 Marionette DEBUG Closed connection 364
02:12:39 INFO - 1501060359719 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49779
02:12:39 INFO - 1501060359720 Marionette DEBUG Closed connection 365
02:12:39 INFO - 1501060359721 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49780
02:12:39 INFO - 1501060359722 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359722 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359725 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359728 Marionette TRACE 366 <- [1,1,null,{"sessionId":"6751cb6d-c36b-4569-8fab-cab07ee45b0a","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359729 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
02:12:39 INFO - 1501060359730 Marionette TRACE 366 <- [1,2,null,{}]
02:12:39 INFO - 1501060359732 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:39 INFO - 1501060359733 Marionette TRACE 366 <- [1,3,null,{}]
02:12:39 INFO - 1501060359734 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:39 INFO - 1501060359734 Marionette TRACE 366 <- [1,4,null,{}]
02:12:39 INFO - 1501060359736 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}]
02:12:39 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1501060359739 Marionette TRACE 366 <- [1,5,null,{"value":null}]
02:12:39 INFO - 1501060359740 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
02:12:39 INFO - 1501060359741 Marionette TRACE 366 <- [1,6,null,{}]
02:12:39 INFO - 1501060359742 Marionette DEBUG Closed connection 366
02:12:39 INFO - 1501060359743 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49781
02:12:39 INFO - 1501060359744 Marionette DEBUG Closed connection 367
02:12:39 INFO - 1501060359745 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49782
02:12:39 INFO - 1501060359746 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:39 INFO - 1501060359746 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359748 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359752 Marionette TRACE 368 <- [1,1,null,{"sessionId":"8bfe37d0-5a5e-480d-aad7-c6f48528ccd0","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359753 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
02:12:39 INFO - 1501060359755 Marionette TRACE 368 <- [1,2,null,{}]
02:12:39 INFO - 1501060359756 Marionette DEBUG Closed connection 368
02:12:39 INFO - 1501060359757 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49783
02:12:39 INFO - 1501060359758 Marionette DEBUG Closed connection 369
02:12:39 INFO - 1501060359758 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49784
02:12:39 INFO - 1501060359760 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:39 INFO - 1501060359761 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:39 INFO - 1501060359763 Marionette DEBUG Register listener.js for window 4294967297
02:12:39 INFO - 1501060359766 Marionette TRACE 370 <- [1,1,null,{"sessionId":"fa0857af-115b-46db-ade7-c04dbabb4869","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:39 INFO - 1501060359767 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"}]
02:12:39 INFO - 1501060359770 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"
02:12:39 INFO - 1501060359772 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"
02:12:39 INFO - 1501060359772 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"
02:12:39 INFO - 1501060359779 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"
02:12:39 INFO - 1501060359783 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"
02:12:39 INFO - 1501060359790 Marionette TRACE 370 <- [1,2,null,{}]
02:12:39 INFO - 1501060359794 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
02:12:39 INFO - 1501060359796 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"17d0fd1f-78f6-452d-9813-5ad7a960c8a5","ELEMENT":"17d0fd1f-78f6-452d-9813-5ad7a960c8a5"}}]
02:12:39 INFO - 1501060359801 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"17d0fd1f-78f6-452d-9813-5ad7a960c8a5"}]
02:12:40 INFO - 1501060360046 Marionette DEBUG Canceled page load listener because no navigation has been detected
02:12:40 INFO - 1501060360047 Marionette TRACE 370 <- [1,4,null,{}]
02:12:40 INFO - 1501060360048 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"17d0fd1f-78f6-452d-9813-5ad7a960c8a5","name":"selected"}]
02:12:40 INFO - 1501060360052 Marionette TRACE 370 <- [1,5,null,{"value":true}]
02:12:40 INFO - 1501060360054 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}]
02:12:40 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1501060360056 Marionette TRACE 370 <- [1,6,null,{"value":null}]
02:12:40 INFO - 1501060360057 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
02:12:40 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 342ms
02:12:40 INFO - 1501060360059 Marionette TRACE 370 <- [1,7,null,{}]
02:12:40 INFO - TEST-START | test_click.py TestClick.test_css_transforms
02:12:40 INFO - 1501060360060 Marionette DEBUG Closed connection 370
02:12:40 INFO - 1501060360061 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49785
02:12:40 INFO - 1501060360062 Marionette DEBUG Closed connection 371
02:12:40 INFO - 1501060360062 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49786
02:12:40 INFO - 1501060360063 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360064 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360066 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360070 Marionette TRACE 372 <- [1,1,null,{"sessionId":"d988efd9-f2d9-4f70-a1ed-2ba8d829439d","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360071 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
02:12:40 INFO - 1501060360071 Marionette TRACE 372 <- [1,2,null,{}]
02:12:40 INFO - 1501060360073 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:40 INFO - 1501060360073 Marionette TRACE 372 <- [1,3,null,{}]
02:12:40 INFO - 1501060360074 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:40 INFO - 1501060360074 Marionette TRACE 372 <- [1,4,null,{}]
02:12:40 INFO - 1501060360076 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}]
02:12:40 INFO - TEST-START: test_click.py TestClick.test_css_transforms1501060360079 Marionette TRACE 372 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360080 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
02:12:40 INFO - 1501060360081 Marionette TRACE 372 <- [1,6,null,{}]
02:12:40 INFO - 1501060360083 Marionette DEBUG Closed connection 372
02:12:40 INFO - 1501060360084 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49787
02:12:40 INFO - 1501060360085 Marionette DEBUG Closed connection 373
02:12:40 INFO - 1501060360086 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49788
02:12:40 INFO - 1501060360087 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360087 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360089 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360093 Marionette TRACE 374 <- [1,1,null,{"sessionId":"a512a859-8ce0-49ca-8efb-8f6b11e3e9a5","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360094 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
02:12:40 INFO - 1501060360095 Marionette TRACE 374 <- [1,2,null,{}]
02:12:40 INFO - 1501060360097 Marionette DEBUG Closed connection 374
02:12:40 INFO - 1501060360097 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49789
02:12:40 INFO - 1501060360098 Marionette DEBUG Closed connection 375
02:12:40 INFO - 1501060360099 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49790
02:12:40 INFO - 1501060360100 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:40 INFO - 1501060360100 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360103 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360106 Marionette TRACE 376 <- [1,1,null,{"sessionId":"05236096-7677-4f28-a038-ee5e369f5ef6","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360107 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"}]
02:12:40 INFO - 1501060360109 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"
02:12:40 INFO - 1501060360111 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"
02:12:40 INFO - 1501060360111 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"
02:12:40 INFO - 1501060360119 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"
02:12:40 INFO - 1501060360121 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"
02:12:40 INFO - 1501060360125 Marionette TRACE 376 <- [1,2,null,{}]
02:12:40 INFO - 1501060360130 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
02:12:40 INFO - 1501060360136 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"be932b30-fa50-4b30-9ce5-d2c2c5967249","ELEMENT":"be932b30-fa50-4b30-9ce5-d2c2c5967249"}}]
02:12:40 INFO - 1501060360138 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"be932b30-fa50-4b30-9ce5-d2c2c5967249"}]
02:12:40 INFO - 1501060360384 Marionette DEBUG Canceled page load listener because no navigation has been detected
02:12:40 INFO - 1501060360385 Marionette TRACE 376 <- [1,4,null,{}]
02:12:40 INFO - 1501060360387 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}]
02:12:40 INFO - TEST-END: test_click.py TestClick.test_css_transforms1501060360390 Marionette TRACE 376 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360391 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
02:12:40 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 332ms
02:12:40 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
02:12:40 INFO - 1501060360393 Marionette TRACE 376 <- [1,6,null,{}]
02:12:40 INFO - 1501060360394 Marionette DEBUG Closed connection 376
02:12:40 INFO - 1501060360396 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49791
02:12:40 INFO - 1501060360397 Marionette DEBUG Closed connection 377
02:12:40 INFO - 1501060360397 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49792
02:12:40 INFO - 1501060360398 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360399 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360401 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360405 Marionette TRACE 378 <- [1,1,null,{"sessionId":"ae5fb61d-6abd-4c67-bb88-35f13aed4eb7","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360406 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
02:12:40 INFO - 1501060360407 Marionette TRACE 378 <- [1,2,null,{}]
02:12:40 INFO - 1501060360408 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:40 INFO - 1501060360408 Marionette TRACE 378 <- [1,3,null,{}]
02:12:40 INFO - 1501060360409 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:40 INFO - 1501060360409 Marionette TRACE 378 <- [1,4,null,{}]
02:12:40 INFO - 1501060360411 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}]
02:12:40 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1501060360414 Marionette TRACE 378 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360415 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
02:12:40 INFO - 1501060360416 Marionette TRACE 378 <- [1,6,null,{}]
02:12:40 INFO - 1501060360418 Marionette DEBUG Closed connection 378
02:12:40 INFO - 1501060360419 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49793
02:12:40 INFO - 1501060360420 Marionette DEBUG Closed connection 379
02:12:40 INFO - 1501060360420 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49794
02:12:40 INFO - 1501060360421 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360422 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360424 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360428 Marionette TRACE 380 <- [1,1,null,{"sessionId":"bf5ebe47-36df-4eb9-8045-c9aba4f824f3","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360429 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
02:12:40 INFO - 1501060360430 Marionette TRACE 380 <- [1,2,null,{}]
02:12:40 INFO - 1501060360432 Marionette DEBUG Closed connection 380
02:12:40 INFO - 1501060360432 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49795
02:12:40 INFO - 1501060360433 Marionette DEBUG Closed connection 381
02:12:40 INFO - 1501060360434 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49796
02:12:40 INFO - 1501060360435 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:40 INFO - 1501060360436 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360438 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360449 Marionette TRACE 382 <- [1,1,null,{"sessionId":"2e425227-4fdc-460a-b47c-164bc37f426a","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360450 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"}]
02:12:40 INFO - 1501060360452 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"
02:12:40 INFO - 1501060360454 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"
02:12:40 INFO - 1501060360454 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"
02:12:40 INFO - 1501060360461 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"
02:12:40 INFO - 1501060360464 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"
02:12:40 INFO - 1501060360472 Marionette TRACE 382 <- [1,2,null,{}]
02:12:40 INFO - 1501060360476 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
02:12:40 INFO - 1501060360478 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"815077ce-e76b-4556-b2a1-f0e25062d1bb","ELEMENT":"815077ce-e76b-4556-b2a1-f0e25062d1bb"}}]
02:12:40 INFO - 1501060360479 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"815077ce-e76b-4556-b2a1-f0e25062d1bb"}]
02:12:40 INFO - 1501060360723 Marionette DEBUG Canceled page load listener because no navigation has been detected
02:12:40 INFO - 1501060360724 Marionette TRACE 382 <- [1,4,null,{}]
02:12:40 INFO - 1501060360727 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}]
02:12:40 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1501060360730 Marionette TRACE 382 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360731 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
02:12:40 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 339ms
02:12:40 INFO - TEST-START | test_click.py TestClick.test_input_file
02:12:40 INFO - 1501060360732 Marionette TRACE 382 <- [1,6,null,{}]
02:12:40 INFO - 1501060360734 Marionette DEBUG Closed connection 382
02:12:40 INFO - 1501060360735 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49797
02:12:40 INFO - 1501060360736 Marionette DEBUG Closed connection 383
02:12:40 INFO - 1501060360736 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49798
02:12:40 INFO - 1501060360737 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360738 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360740 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360744 Marionette TRACE 384 <- [1,1,null,{"sessionId":"afa491d7-d99e-414f-9e03-3366fe529b56","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360746 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
02:12:40 INFO - 1501060360746 Marionette TRACE 384 <- [1,2,null,{}]
02:12:40 INFO - 1501060360747 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:40 INFO - 1501060360748 Marionette TRACE 384 <- [1,3,null,{}]
02:12:40 INFO - 1501060360748 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:40 INFO - 1501060360749 Marionette TRACE 384 <- [1,4,null,{}]
02:12:40 INFO - 1501060360751 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}]
02:12:40 INFO - TEST-START: test_click.py TestClick.test_input_file1501060360754 Marionette TRACE 384 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360755 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
02:12:40 INFO - 1501060360756 Marionette TRACE 384 <- [1,6,null,{}]
02:12:40 INFO - 1501060360758 Marionette DEBUG Closed connection 384
02:12:40 INFO - 1501060360759 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49799
02:12:40 INFO - 1501060360759 Marionette DEBUG Closed connection 385
02:12:40 INFO - 1501060360760 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49800
02:12:40 INFO - 1501060360761 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360762 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360764 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360767 Marionette TRACE 386 <- [1,1,null,{"sessionId":"8ddd5217-fd88-49df-a885-0d7a3e03d5fa","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360769 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
02:12:40 INFO - 1501060360770 Marionette TRACE 386 <- [1,2,null,{}]
02:12:40 INFO - 1501060360772 Marionette DEBUG Closed connection 386
02:12:40 INFO - 1501060360772 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49801
02:12:40 INFO - 1501060360773 Marionette DEBUG Closed connection 387
02:12:40 INFO - 1501060360774 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49802
02:12:40 INFO - 1501060360775 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:40 INFO - 1501060360775 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360778 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360781 Marionette TRACE 388 <- [1,1,null,{"sessionId":"91f012a3-a92f-480a-b73c-0e688cf195f7","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360782 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
02:12:40 INFO - 1501060360784 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"
02:12:40 INFO - 1501060360786 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"
02:12:40 INFO - 1501060360786 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"
02:12:40 INFO - 1501060360793 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
02:12:40 INFO - 1501060360797 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
02:12:40 INFO - 1501060360803 Marionette TRACE 388 <- [1,2,null,{}]
02:12:40 INFO - 1501060360806 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
02:12:40 INFO - 1501060360809 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"16a18fe7-4e9c-4c61-80ea-f2b5e5d93a0e","ELEMENT":"16a18fe7-4e9c-4c61-80ea-f2b5e5d93a0e"}}]
02:12:40 INFO - 1501060360810 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"16a18fe7-4e9c-4c61-80ea-f2b5e5d93a0e"}]
02:12:40 INFO - 1501060360846 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
02:12:40 INFO - 1501060360848 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}]
02:12:40 INFO - TEST-END: test_click.py TestClick.test_input_file1501060360852 Marionette TRACE 388 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360853 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
02:12:40 INFO - 1501060360854 Marionette TRACE 388 <- [1,6,null,{}]
02:12:40 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 121ms
02:12:40 INFO - TEST-START | test_click.py TestClick.test_obscured_element
02:12:40 INFO - 1501060360856 Marionette DEBUG Closed connection 388
02:12:40 INFO - 1501060360856 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49803
02:12:40 INFO - 1501060360857 Marionette DEBUG Closed connection 389
02:12:40 INFO - 1501060360858 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49804
02:12:40 INFO - 1501060360859 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360859 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360862 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360865 Marionette TRACE 390 <- [1,1,null,{"sessionId":"86178a24-2019-4d58-82a4-be2ac0726590","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360867 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
02:12:40 INFO - 1501060360868 Marionette TRACE 390 <- [1,2,null,{}]
02:12:40 INFO - 1501060360869 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:40 INFO - 1501060360869 Marionette TRACE 390 <- [1,3,null,{}]
02:12:40 INFO - 1501060360870 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:40 INFO - 1501060360871 Marionette TRACE 390 <- [1,4,null,{}]
02:12:40 INFO - 1501060360873 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}]
02:12:40 INFO - TEST-START: test_click.py TestClick.test_obscured_element1501060360876 Marionette TRACE 390 <- [1,5,null,{"value":null}]
02:12:40 INFO - 1501060360877 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
02:12:40 INFO - 1501060360879 Marionette TRACE 390 <- [1,6,null,{}]
02:12:40 INFO - 1501060360880 Marionette DEBUG Closed connection 390
02:12:40 INFO - 1501060360881 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49805
02:12:40 INFO - 1501060360882 Marionette DEBUG Closed connection 391
02:12:40 INFO - 1501060360882 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49806
02:12:40 INFO - 1501060360883 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:40 INFO - 1501060360884 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360886 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360890 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b5d2ed2c-2d6e-48b9-ae4d-cff4bc0433cd","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360891 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
02:12:40 INFO - 1501060360893 Marionette TRACE 392 <- [1,2,null,{}]
02:12:40 INFO - 1501060360894 Marionette DEBUG Closed connection 392
02:12:40 INFO - 1501060360895 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49807
02:12:40 INFO - 1501060360896 Marionette DEBUG Closed connection 393
02:12:40 INFO - 1501060360896 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49808
02:12:40 INFO - 1501060360897 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:40 INFO - 1501060360898 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:40 INFO - 1501060360900 Marionette DEBUG Register listener.js for window 4294967297
02:12:40 INFO - 1501060360904 Marionette TRACE 394 <- [1,1,null,{"sessionId":"49b54d35-0258-47a8-846b-852c26fdda19","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:40 INFO - 1501060360905 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"}]
02:12:40 INFO - 1501060360907 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
02:12:40 INFO - 1501060360909 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
02:12:40 INFO - 1501060360909 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
02:12:40 INFO - 1501060360916 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"
02:12:40 INFO - 1501060360919 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"
02:12:40 INFO - 1501060360925 Marionette TRACE 394 <- [1,2,null,{}]
02:12:40 INFO - 1501060360928 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
02:12:40 INFO - 1501060360936 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c712eec1-88f9-49e2-bbf5-f1216a23a2ba","ELEMENT":"c712eec1-88f9-49e2-bbf5-f1216a23a2ba"}}]
02:12:40 INFO - 1501060360937 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
02:12:40 INFO - 1501060360939 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"43bd39fe-5900-4d96-a26b-334e58968159","ELEMENT":"43bd39fe-5900-4d96-a26b-334e58968159"}}]
02:12:40 INFO - 1501060360940 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"c712eec1-88f9-49e2-bbf5-f1216a23a2ba"}]
02:12:41 INFO - 1501060361181 Marionette DEBUG Canceled page load listener because no navigation has been detected
02:12:41 INFO - 1501060361182 Marionette TRACE 394 <- [1,5,null,{}]
02:12:41 INFO - 1501060361183 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"43bd39fe-5900-4d96-a26b-334e58968159"}]
02:12:41 INFO - 1501060361200 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
02:12:41 INFO - 1501060361202 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
02:12:41 INFO - 1501060361204 Marionette TRACE 394 <- [1,7,null,{"value":false}]
02:12:41 INFO - 1501060361206 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}]
02:12:41 INFO - TEST-END: test_click.py TestClick.test_obscured_element1501060361209 Marionette TRACE 394 <- [1,8,null,{"value":null}]
02:12:41 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 356ms
02:12:41 INFO - 1501060361210 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
02:12:41 INFO - 1501060361211 Marionette TRACE 394 <- [1,9,null,{}]
02:12:41 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
02:12:41 INFO - 1501060361213 Marionette DEBUG Closed connection 394
02:12:41 INFO - 1501060361214 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49809
02:12:41 INFO - 1501060361215 Marionette DEBUG Closed connection 395
02:12:41 INFO - 1501060361215 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49810
02:12:41 INFO - 1501060361216 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:41 INFO - 1501060361217 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:41 INFO - 1501060361219 Marionette DEBUG Register listener.js for window 4294967297
02:12:41 INFO - 1501060361223 Marionette TRACE 396 <- [1,1,null,{"sessionId":"d4e9053f-824e-4ec7-9fc8-c30132b43758","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:41 INFO - 1501060361224 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
02:12:41 INFO - 1501060361224 Marionette TRACE 396 <- [1,2,null,{}]
02:12:41 INFO - 1501060361225 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
02:12:41 INFO - 1501060361226 Marionette TRACE 396 <- [1,3,null,{}]
02:12:41 INFO - 1501060361227 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
02:12:41 INFO - 1501060361227 Marionette TRACE 396 <- [1,4,null,{}]
02:12:41 INFO - 1501060361229 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}]
02:12:41 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1501060361232 Marionette TRACE 396 <- [1,5,null,{"value":null}]
02:12:41 INFO - 1501060361233 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
02:12:41 INFO - 1501060361234 Marionette TRACE 396 <- [1,6,null,{}]
02:12:41 INFO - 1501060361236 Marionette DEBUG Closed connection 396
02:12:41 INFO - 1501060361236 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49811
02:12:41 INFO - 1501060361237 Marionette DEBUG Closed connection 397
02:12:41 INFO - 1501060361238 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49812
02:12:41 INFO - 1501060361239 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:12:41 INFO - 1501060361239 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:41 INFO - 1501060361242 Marionette DEBUG Register listener.js for window 4294967297
02:12:41 INFO - 1501060361245 Marionette TRACE 398 <- [1,1,null,{"sessionId":"65ccb382-a00d-41ea-a7d0-98c3263a267e","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:41 INFO - 1501060361248 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
02:12:41 INFO - 1501060361250 Marionette TRACE 398 <- [1,2,null,{}]
02:12:41 INFO - 1501060361251 Marionette DEBUG Closed connection 398
02:12:41 INFO - 1501060361252 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49813
02:12:41 INFO - 1501060361253 Marionette DEBUG Closed connection 399
02:12:41 INFO - 1501060361253 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49814
02:12:41 INFO - 1501060361254 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
02:12:41 INFO - 1501060361255 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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}
02:12:41 INFO - 1501060361257 Marionette DEBUG Register listener.js for window 4294967297
02:12:41 INFO - 1501060361261 Marionette TRACE 400 <- [1,1,null,{"sessionId":"0471ed91-f4c7-420a-bc4a-0bef131c51b9","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":2748,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmps9ozep.mozrunner","moz:accessibilityChecks":false}}]
02:12:41 INFO - 1501060361262 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"}]
02:12:41 INFO - 1501060361264 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"
02:12:41 INFO - 1501060361266 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"
02:12:41 INFO - 1501060361266 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"
02:12:41 INFO - 1501060361273 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"
02:12:41 INFO - 1501060361276 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"
02:12:41 INFO - 1501060361280 Marionette TRACE 400 <- [1,2,null,{}]
02:12:41 INFO - 1501060361288 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
02:12:41 INFO - 1501060361291 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6b008c65-366f-414f-9e34-45edf8987836","ELEMENT":"6b008c65-366f-414f-9e34-45edf8987836"}}]
02:12:41 INFO - 1501060361292 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"6b008c65-366f-414f-9e34-45edf8987836"}]
02:12:41 INFO - 1501060361318 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
02:12:41 INFO - 1501060361320 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"6b008c65-366f-414f-9e34-45edf8987836"}]
02:12:41 INFO - 1501060361337 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element