could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
21:45:29 INFO - 1500093929153 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
21:45:29 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500093929155 Marionette TRACE 352 <- [1,5,null,{"value":null}]
21:45:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 129ms
21:45:29 INFO - 1500093929157 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
21:45:29 INFO - 1500093929158 Marionette TRACE 352 <- [1,6,null,{}]
21:45:29 INFO - 1500093929160 Marionette DEBUG Closed connection 352
21:45:29 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
21:45:29 INFO - 1500093929162 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49763
21:45:29 INFO - 1500093929162 Marionette DEBUG Closed connection 353
21:45:29 INFO - 1500093929163 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49764
21:45:29 INFO - 1500093929164 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929164 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929166 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929169 Marionette TRACE 354 <- [1,1,null,{"sessionId":"9a5ce937-7d72-4a7d-866d-9765f8f98275","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929171 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
21:45:29 INFO - 1500093929171 Marionette TRACE 354 <- [1,2,null,{}]
21:45:29 INFO - 1500093929172 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:29 INFO - 1500093929173 Marionette TRACE 354 <- [1,3,null,{}]
21:45:29 INFO - 1500093929174 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:29 INFO - 1500093929174 Marionette TRACE 354 <- [1,4,null,{}]
21:45:29 INFO - 1500093929175 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
21:45:29 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500093929177 Marionette TRACE 354 <- [1,5,null,{"value":null}]
21:45:29 INFO - 1500093929178 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
21:45:29 INFO - 1500093929179 Marionette TRACE 354 <- [1,6,null,{}]
21:45:29 INFO - 1500093929181 Marionette DEBUG Closed connection 354
21:45:29 INFO - 1500093929182 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49765
21:45:29 INFO - 1500093929183 Marionette DEBUG Closed connection 355
21:45:29 INFO - 1500093929183 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49766
21:45:29 INFO - 1500093929184 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929184 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929186 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929189 Marionette TRACE 356 <- [1,1,null,{"sessionId":"f1599c1a-4a2f-43b6-9b4e-944819291dc9","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929191 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
21:45:29 INFO - 1500093929192 Marionette TRACE 356 <- [1,2,null,{}]
21:45:29 INFO - 1500093929193 Marionette DEBUG Closed connection 356
21:45:29 INFO - 1500093929194 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49767
21:45:29 INFO - 1500093929194 Marionette DEBUG Closed connection 357
21:45:29 INFO - 1500093929195 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49768
21:45:29 INFO - 1500093929196 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:29 INFO - 1500093929196 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929198 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929201 Marionette TRACE 358 <- [1,1,null,{"sessionId":"b4f7c6f6-67b0-4cc5-a7a0-08d9731d0271","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929203 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49337/clicks.html"}]
21:45:29 INFO - 1500093929204 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/hidden.html"
21:45:29 INFO - 1500093929208 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/hidden.html"
21:45:29 INFO - 1500093929208 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/hidden.html"
21:45:29 INFO - 1500093929218 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/clicks.html"
21:45:29 INFO - 1500093929222 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/clicks.html"
21:45:29 INFO - 1500093929230 Marionette TRACE 358 <- [1,2,null,{}]
21:45:29 INFO - 1500093929231 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
21:45:29 INFO - 1500093929233 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bf14dfcc-f6f8-47bd-b215-48d37007e222","ELEMENT":"bf14dfcc-f6f8-47bd-b215-48d37007e222"}}]
21:45:29 INFO - 1500093929234 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"bf14dfcc-f6f8-47bd-b215-48d37007e222"}]
21:45:29 INFO - 1500093929279 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/clicks.html"
21:45:29 INFO - 1500093929284 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/clicks.html"
21:45:29 INFO - 1500093929284 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/clicks.html"
21:45:29 INFO - 1500093929300 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49337/test.html"
21:45:29 INFO - 1500093929302 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49337/test.html"
21:45:29 INFO - 1500093929304 Marionette TRACE 358 <- [1,4,null,{}]
21:45:29 INFO - 1500093929311 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
21:45:29 INFO - 1500093929312 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4b6b3cb6-03a5-4127-aecd-63e0c1da2278","ELEMENT":"4b6b3cb6-03a5-4127-aecd-63e0c1da2278"}}]
21:45:29 INFO - 1500093929314 Marionette TRACE 358 -> [0,6,"getTitle",{}]
21:45:29 INFO - 1500093929314 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
21:45:29 INFO - 1500093929315 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
21:45:29 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500093929317 Marionette TRACE 358 <- [1,7,null,{"value":null}]
21:45:29 INFO - 1500093929318 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
21:45:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 160ms
21:45:29 INFO - TEST-START | test_click.py TestClick.test_container_element
21:45:29 INFO - 1500093929319 Marionette TRACE 358 <- [1,8,null,{}]
21:45:29 INFO - 1500093929321 Marionette DEBUG Closed connection 358
21:45:29 INFO - 1500093929323 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49771
21:45:29 INFO - 1500093929323 Marionette DEBUG Closed connection 359
21:45:29 INFO - 1500093929324 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49772
21:45:29 INFO - 1500093929325 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929325 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929328 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929330 Marionette TRACE 360 <- [1,1,null,{"sessionId":"c0eba552-4226-4a39-8086-3e99481f13e7","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929332 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
21:45:29 INFO - 1500093929332 Marionette TRACE 360 <- [1,2,null,{}]
21:45:29 INFO - 1500093929333 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:29 INFO - 1500093929333 Marionette TRACE 360 <- [1,3,null,{}]
21:45:29 INFO - 1500093929334 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:29 INFO - 1500093929334 Marionette TRACE 360 <- [1,4,null,{}]
21:45:29 INFO - 1500093929336 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
21:45:29 INFO - TEST-START: test_click.py TestClick.test_container_element1500093929340 Marionette TRACE 360 <- [1,5,null,{"value":null}]
21:45:29 INFO - 1500093929341 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
21:45:29 INFO - 1500093929342 Marionette TRACE 360 <- [1,6,null,{}]
21:45:29 INFO - 1500093929344 Marionette DEBUG Closed connection 360
21:45:29 INFO - 1500093929344 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49773
21:45:29 INFO - 1500093929345 Marionette DEBUG Closed connection 361
21:45:29 INFO - 1500093929345 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49774
21:45:29 INFO - 1500093929346 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929347 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929349 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929351 Marionette TRACE 362 <- [1,1,null,{"sessionId":"9ca91670-2ffc-46c4-a8b9-45b2632f878e","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929353 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
21:45:29 INFO - 1500093929354 Marionette TRACE 362 <- [1,2,null,{}]
21:45:29 INFO - 1500093929357 Marionette DEBUG Closed connection 362
21:45:29 INFO - 1500093929358 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49775
21:45:29 INFO - 1500093929358 Marionette DEBUG Closed connection 363
21:45:29 INFO - 1500093929359 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49776
21:45:29 INFO - 1500093929360 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:29 INFO - 1500093929360 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929362 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929365 Marionette TRACE 364 <- [1,1,null,{"sessionId":"ca41a8b1-7c0d-4116-ab3c-ab3d79993aff","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929366 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
21:45:29 INFO - 1500093929367 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49337/test.html"
21:45:29 INFO - 1500093929369 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49337/test.html"
21:45:29 INFO - 1500093929369 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49337/test.html"
21:45:29 INFO - 1500093929391 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929393 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929396 Marionette TRACE 364 <- [1,2,null,{}]
21:45:29 INFO - 1500093929398 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:45:29 INFO - 1500093929399 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"37ffe3b5-ef9b-45d8-90f2-1e0bf6f62a14","ELEMENT":"37ffe3b5-ef9b-45d8-90f2-1e0bf6f62a14"}}]
21:45:29 INFO - 1500093929400 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"37ffe3b5-ef9b-45d8-90f2-1e0bf6f62a14"}]
21:45:29 INFO - 1500093929638 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:45:29 INFO - 1500093929639 Marionette TRACE 364 <- [1,4,null,{}]
21:45:29 INFO - 1500093929640 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"37ffe3b5-ef9b-45d8-90f2-1e0bf6f62a14","name":"selected"}]
21:45:29 INFO - 1500093929644 Marionette TRACE 364 <- [1,5,null,{"value":true}]
21:45:29 INFO - 1500093929645 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
21:45:29 INFO - TEST-END: test_click.py TestClick.test_container_element1500093929647 Marionette TRACE 364 <- [1,6,null,{"value":null}]
21:45:29 INFO - 1500093929648 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
21:45:29 INFO - 1500093929650 Marionette TRACE 364 <- [1,7,null,{}]
21:45:29 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 330ms
21:45:29 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
21:45:29 INFO - 1500093929651 Marionette DEBUG Closed connection 364
21:45:29 INFO - 1500093929652 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49777
21:45:29 INFO - 1500093929653 Marionette DEBUG Closed connection 365
21:45:29 INFO - 1500093929653 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49778
21:45:29 INFO - 1500093929654 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929655 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929657 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929660 Marionette TRACE 366 <- [1,1,null,{"sessionId":"b55424ea-4c9a-48dd-8935-429823327d1c","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929661 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
21:45:29 INFO - 1500093929662 Marionette TRACE 366 <- [1,2,null,{}]
21:45:29 INFO - 1500093929663 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:29 INFO - 1500093929663 Marionette TRACE 366 <- [1,3,null,{}]
21:45:29 INFO - 1500093929664 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:29 INFO - 1500093929665 Marionette TRACE 366 <- [1,4,null,{}]
21:45:29 INFO - 1500093929667 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
21:45:29 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500093929669 Marionette TRACE 366 <- [1,5,null,{"value":null}]
21:45:29 INFO - 1500093929670 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
21:45:29 INFO - 1500093929671 Marionette TRACE 366 <- [1,6,null,{}]
21:45:29 INFO - 1500093929673 Marionette DEBUG Closed connection 366
21:45:29 INFO - 1500093929674 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49779
21:45:29 INFO - 1500093929674 Marionette DEBUG Closed connection 367
21:45:29 INFO - 1500093929675 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49780
21:45:29 INFO - 1500093929676 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929676 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929678 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929681 Marionette TRACE 368 <- [1,1,null,{"sessionId":"5cc4a87d-8289-4892-9163-9d1fc33b2019","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929683 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
21:45:29 INFO - 1500093929684 Marionette TRACE 368 <- [1,2,null,{}]
21:45:29 INFO - 1500093929686 Marionette DEBUG Closed connection 368
21:45:29 INFO - 1500093929686 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49781
21:45:29 INFO - 1500093929687 Marionette DEBUG Closed connection 369
21:45:29 INFO - 1500093929687 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49782
21:45:29 INFO - 1500093929688 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:29 INFO - 1500093929690 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929692 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929694 Marionette TRACE 370 <- [1,1,null,{"sessionId":"d444743b-dc07-42c9-9fa5-cf92f9f5573f","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929696 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
21:45:29 INFO - 1500093929697 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929699 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929699 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929723 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929725 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:29 INFO - 1500093929728 Marionette TRACE 370 <- [1,2,null,{}]
21:45:29 INFO - 1500093929729 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:45:29 INFO - 1500093929731 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e91cbbf3-26d0-434e-a7fa-e1f31a982bca","ELEMENT":"e91cbbf3-26d0-434e-a7fa-e1f31a982bca"}}]
21:45:29 INFO - 1500093929732 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"e91cbbf3-26d0-434e-a7fa-e1f31a982bca"}]
21:45:29 INFO - 1500093929971 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:45:29 INFO - 1500093929972 Marionette TRACE 370 <- [1,4,null,{}]
21:45:29 INFO - 1500093929973 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"e91cbbf3-26d0-434e-a7fa-e1f31a982bca","name":"selected"}]
21:45:29 INFO - 1500093929977 Marionette TRACE 370 <- [1,5,null,{"value":true}]
21:45:29 INFO - 1500093929978 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
21:45:29 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500093929981 Marionette TRACE 370 <- [1,6,null,{"value":null}]
21:45:29 INFO - 1500093929982 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
21:45:29 INFO - 1500093929983 Marionette TRACE 370 <- [1,7,null,{}]
21:45:29 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 333ms
21:45:29 INFO - TEST-START | test_click.py TestClick.test_css_transforms
21:45:29 INFO - 1500093929985 Marionette DEBUG Closed connection 370
21:45:29 INFO - 1500093929986 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49783
21:45:29 INFO - 1500093929987 Marionette DEBUG Closed connection 371
21:45:29 INFO - 1500093929988 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49784
21:45:29 INFO - 1500093929988 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:29 INFO - 1500093929989 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:29 INFO - 1500093929991 Marionette DEBUG Register listener.js for window 15
21:45:29 INFO - 1500093929994 Marionette TRACE 372 <- [1,1,null,{"sessionId":"eb63157d-5d67-4b84-98d3-a44ee192ee8a","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:29 INFO - 1500093929996 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
21:45:29 INFO - 1500093929996 Marionette TRACE 372 <- [1,2,null,{}]
21:45:30 INFO - 1500093929997 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:30 INFO - 1500093929997 Marionette TRACE 372 <- [1,3,null,{}]
21:45:30 INFO - 1500093929998 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:30 INFO - 1500093929999 Marionette TRACE 372 <- [1,4,null,{}]
21:45:30 INFO - 1500093930000 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
21:45:30 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500093930003 Marionette TRACE 372 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930004 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930005 Marionette TRACE 372 <- [1,6,null,{}]
21:45:30 INFO - 1500093930007 Marionette DEBUG Closed connection 372
21:45:30 INFO - 1500093930007 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49785
21:45:30 INFO - 1500093930008 Marionette DEBUG Closed connection 373
21:45:30 INFO - 1500093930008 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49786
21:45:30 INFO - 1500093930009 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930010 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930012 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930014 Marionette TRACE 374 <- [1,1,null,{"sessionId":"2454681b-4f63-4201-96f2-45ffa6963f20","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930016 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
21:45:30 INFO - 1500093930017 Marionette TRACE 374 <- [1,2,null,{}]
21:45:30 INFO - 1500093930019 Marionette DEBUG Closed connection 374
21:45:30 INFO - 1500093930019 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49787
21:45:30 INFO - 1500093930020 Marionette DEBUG Closed connection 375
21:45:30 INFO - 1500093930020 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49788
21:45:30 INFO - 1500093930021 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:30 INFO - 1500093930022 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930024 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930026 Marionette TRACE 376 <- [1,1,null,{"sessionId":"22ae13c7-1c13-493a-b7e8-0c759b1f776e","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930028 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
21:45:30 INFO - 1500093930029 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930031 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930031 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930048 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
21:45:30 INFO - 1500093930051 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
21:45:30 INFO - 1500093930053 Marionette TRACE 376 <- [1,2,null,{}]
21:45:30 INFO - 1500093930059 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
21:45:30 INFO - 1500093930061 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5c9585b0-2f91-4254-bef5-fc0f9ffbf468","ELEMENT":"5c9585b0-2f91-4254-bef5-fc0f9ffbf468"}}]
21:45:30 INFO - 1500093930062 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"5c9585b0-2f91-4254-bef5-fc0f9ffbf468"}]
21:45:30 INFO - 1500093930302 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:45:30 INFO - 1500093930303 Marionette TRACE 376 <- [1,4,null,{}]
21:45:30 INFO - 1500093930305 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
21:45:30 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500093930307 Marionette TRACE 376 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930308 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930309 Marionette TRACE 376 <- [1,6,null,{}]
21:45:30 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 324ms
21:45:30 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
21:45:30 INFO - 1500093930311 Marionette DEBUG Closed connection 376
21:45:30 INFO - 1500093930311 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49789
21:45:30 INFO - 1500093930312 Marionette DEBUG Closed connection 377
21:45:30 INFO - 1500093930313 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49790
21:45:30 INFO - 1500093930314 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930314 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930316 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930319 Marionette TRACE 378 <- [1,1,null,{"sessionId":"273c0576-0679-4d9b-8f64-fd897885da02","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930321 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
21:45:30 INFO - 1500093930321 Marionette TRACE 378 <- [1,2,null,{}]
21:45:30 INFO - 1500093930322 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:30 INFO - 1500093930322 Marionette TRACE 378 <- [1,3,null,{}]
21:45:30 INFO - 1500093930323 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:30 INFO - 1500093930323 Marionette TRACE 378 <- [1,4,null,{}]
21:45:30 INFO - 1500093930325 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
21:45:30 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500093930327 Marionette TRACE 378 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930327 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930328 Marionette TRACE 378 <- [1,6,null,{}]
21:45:30 INFO - 1500093930330 Marionette DEBUG Closed connection 378
21:45:30 INFO - 1500093930330 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49791
21:45:30 INFO - 1500093930331 Marionette DEBUG Closed connection 379
21:45:30 INFO - 1500093930331 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49792
21:45:30 INFO - 1500093930332 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930333 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930335 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930337 Marionette TRACE 380 <- [1,1,null,{"sessionId":"4ed2061c-cfd0-4d84-b870-f579ac9b0946","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930339 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
21:45:30 INFO - 1500093930340 Marionette TRACE 380 <- [1,2,null,{}]
21:45:30 INFO - 1500093930341 Marionette DEBUG Closed connection 380
21:45:30 INFO - 1500093930342 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49793
21:45:30 INFO - 1500093930342 Marionette DEBUG Closed connection 381
21:45:30 INFO - 1500093930343 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49794
21:45:30 INFO - 1500093930344 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:30 INFO - 1500093930344 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930346 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930348 Marionette TRACE 382 <- [1,1,null,{"sessionId":"3449c00c-62ab-4d05-8130-cbce43888abb","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930350 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
21:45:30 INFO - 1500093930351 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
21:45:30 INFO - 1500093930353 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
21:45:30 INFO - 1500093930353 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
21:45:30 INFO - 1500093930368 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930370 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930378 Marionette TRACE 382 <- [1,2,null,{}]
21:45:30 INFO - 1500093930380 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
21:45:30 INFO - 1500093930382 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ce0eac7e-5ede-45d6-b792-f6ab1e8dbb66","ELEMENT":"ce0eac7e-5ede-45d6-b792-f6ab1e8dbb66"}}]
21:45:30 INFO - 1500093930383 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"ce0eac7e-5ede-45d6-b792-f6ab1e8dbb66"}]
21:45:30 INFO - 1500093930620 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:45:30 INFO - 1500093930621 Marionette TRACE 382 <- [1,4,null,{}]
21:45:30 INFO - 1500093930622 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
21:45:30 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500093930624 Marionette TRACE 382 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930626 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930627 Marionette TRACE 382 <- [1,6,null,{}]
21:45:30 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 317ms
21:45:30 INFO - TEST-START | test_click.py TestClick.test_input_file
21:45:30 INFO - 1500093930628 Marionette DEBUG Closed connection 382
21:45:30 INFO - 1500093930629 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49795
21:45:30 INFO - 1500093930630 Marionette DEBUG Closed connection 383
21:45:30 INFO - 1500093930630 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49796
21:45:30 INFO - 1500093930631 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930632 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930634 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930636 Marionette TRACE 384 <- [1,1,null,{"sessionId":"3b183573-6de2-4b21-9af2-7b5a0eabe144","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930638 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
21:45:30 INFO - 1500093930638 Marionette TRACE 384 <- [1,2,null,{}]
21:45:30 INFO - 1500093930639 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:30 INFO - 1500093930640 Marionette TRACE 384 <- [1,3,null,{}]
21:45:30 INFO - 1500093930640 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:30 INFO - 1500093930641 Marionette TRACE 384 <- [1,4,null,{}]
21:45:30 INFO - 1500093930642 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
21:45:30 INFO - TEST-START: test_click.py TestClick.test_input_file1500093930644 Marionette TRACE 384 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930645 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930646 Marionette TRACE 384 <- [1,6,null,{}]
21:45:30 INFO - 1500093930648 Marionette DEBUG Closed connection 384
21:45:30 INFO - 1500093930649 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49797
21:45:30 INFO - 1500093930649 Marionette DEBUG Closed connection 385
21:45:30 INFO - 1500093930650 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49798
21:45:30 INFO - 1500093930651 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930651 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930653 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930655 Marionette TRACE 386 <- [1,1,null,{"sessionId":"03051380-da78-469c-9091-5d8a355674b9","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930657 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
21:45:30 INFO - 1500093930658 Marionette TRACE 386 <- [1,2,null,{}]
21:45:30 INFO - 1500093930660 Marionette DEBUG Closed connection 386
21:45:30 INFO - 1500093930660 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49799
21:45:30 INFO - 1500093930661 Marionette DEBUG Closed connection 387
21:45:30 INFO - 1500093930661 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49800
21:45:30 INFO - 1500093930662 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:30 INFO - 1500093930663 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930665 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930667 Marionette TRACE 388 <- [1,1,null,{"sessionId":"c3361520-9010-40fd-9d61-9b04ee220c90","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930669 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
21:45:30 INFO - 1500093930670 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930672 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930672 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
21:45:30 INFO - 1500093930681 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:45:30 INFO - 1500093930684 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:45:30 INFO - 1500093930686 Marionette TRACE 388 <- [1,2,null,{}]
21:45:30 INFO - 1500093930694 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
21:45:30 INFO - 1500093930696 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"398a5034-d627-405a-af5e-4f242c5b1af4","ELEMENT":"398a5034-d627-405a-af5e-4f242c5b1af4"}}]
21:45:30 INFO - 1500093930697 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"398a5034-d627-405a-af5e-4f242c5b1af4"}]
21:45:30 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 108ms
21:45:30 INFO - TEST-START | test_click.py TestClick.test_obscured_element
21:45:30 INFO - 1500093930729 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
21:45:30 INFO - 1500093930731 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
21:45:30 INFO - TEST-END: test_click.py TestClick.test_input_file1500093930733 Marionette TRACE 388 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930734 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930735 Marionette TRACE 388 <- [1,6,null,{}]
21:45:30 INFO - 1500093930736 Marionette DEBUG Closed connection 388
21:45:30 INFO - 1500093930737 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49801
21:45:30 INFO - 1500093930739 Marionette DEBUG Closed connection 389
21:45:30 INFO - 1500093930739 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49802
21:45:30 INFO - 1500093930740 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930740 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930742 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930745 Marionette TRACE 390 <- [1,1,null,{"sessionId":"ac2a32fd-25cd-4fbb-8d30-5c0cf272800c","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930746 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
21:45:30 INFO - 1500093930747 Marionette TRACE 390 <- [1,2,null,{}]
21:45:30 INFO - 1500093930747 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:30 INFO - 1500093930747 Marionette TRACE 390 <- [1,3,null,{}]
21:45:30 INFO - 1500093930749 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:30 INFO - 1500093930749 Marionette TRACE 390 <- [1,4,null,{}]
21:45:30 INFO - 1500093930750 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
21:45:30 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500093930752 Marionette TRACE 390 <- [1,5,null,{"value":null}]
21:45:30 INFO - 1500093930753 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
21:45:30 INFO - 1500093930754 Marionette TRACE 390 <- [1,6,null,{}]
21:45:30 INFO - 1500093930756 Marionette DEBUG Closed connection 390
21:45:30 INFO - 1500093930756 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49803
21:45:30 INFO - 1500093930757 Marionette DEBUG Closed connection 391
21:45:30 INFO - 1500093930757 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49804
21:45:30 INFO - 1500093930758 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:30 INFO - 1500093930758 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930760 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930763 Marionette TRACE 392 <- [1,1,null,{"sessionId":"4078cd06-5c51-453c-a5d1-9c7f4136f20f","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930764 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
21:45:30 INFO - 1500093930765 Marionette TRACE 392 <- [1,2,null,{}]
21:45:30 INFO - 1500093930767 Marionette DEBUG Closed connection 392
21:45:30 INFO - 1500093930767 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49805
21:45:30 INFO - 1500093930768 Marionette DEBUG Closed connection 393
21:45:30 INFO - 1500093930769 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49806
21:45:30 INFO - 1500093930769 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:30 INFO - 1500093930770 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:30 INFO - 1500093930772 Marionette DEBUG Register listener.js for window 15
21:45:30 INFO - 1500093930774 Marionette TRACE 394 <- [1,1,null,{"sessionId":"809f15fe-6222-4e1e-9598-678e1702ee90","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:30 INFO - 1500093930776 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
21:45:30 INFO - 1500093930777 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:45:30 INFO - 1500093930779 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:45:30 INFO - 1500093930779 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:45:30 INFO - 1500093930795 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
21:45:30 INFO - 1500093930797 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
21:45:30 INFO - 1500093930799 Marionette TRACE 394 <- [1,2,null,{}]
21:45:30 INFO - 1500093930800 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
21:45:30 INFO - 1500093930801 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2759a563-6f41-4c58-a5cf-68ab430f4d21","ELEMENT":"2759a563-6f41-4c58-a5cf-68ab430f4d21"}}]
21:45:30 INFO - 1500093930802 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
21:45:30 INFO - 1500093930808 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c3fa132d-07ae-42b9-bd71-b9934bf85503","ELEMENT":"c3fa132d-07ae-42b9-bd71-b9934bf85503"}}]
21:45:30 INFO - 1500093930809 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"2759a563-6f41-4c58-a5cf-68ab430f4d21"}]
21:45:31 INFO - 1500093931043 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:45:31 INFO - 1500093931044 Marionette TRACE 394 <- [1,5,null,{}]
21:45:31 INFO - 1500093931045 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"c3fa132d-07ae-42b9-bd71-b9934bf85503"}]
21:45:31 INFO - 1500093931059 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
21:45:31 INFO - 1500093931061 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
21:45:31 INFO - 1500093931063 Marionette TRACE 394 <- [1,7,null,{"value":false}]
21:45:31 INFO - 1500093931064 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
21:45:31 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500093931067 Marionette TRACE 394 <- [1,8,null,{"value":null}]
21:45:31 INFO - 1500093931068 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
21:45:31 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 333ms
21:45:31 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
21:45:31 INFO - 1500093931069 Marionette TRACE 394 <- [1,9,null,{}]
21:45:31 INFO - 1500093931070 Marionette DEBUG Closed connection 394
21:45:31 INFO - 1500093931072 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49807
21:45:31 INFO - 1500093931072 Marionette DEBUG Closed connection 395
21:45:31 INFO - 1500093931073 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49808
21:45:31 INFO - 1500093931074 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:31 INFO - 1500093931075 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:31 INFO - 1500093931077 Marionette DEBUG Register listener.js for window 15
21:45:31 INFO - 1500093931085 Marionette TRACE 396 <- [1,1,null,{"sessionId":"7b730b1c-8fb6-4052-9fec-9233db920bd2","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:31 INFO - 1500093931087 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
21:45:31 INFO - 1500093931088 Marionette TRACE 396 <- [1,2,null,{}]
21:45:31 INFO - 1500093931089 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:45:31 INFO - 1500093931089 Marionette TRACE 396 <- [1,3,null,{}]
21:45:31 INFO - 1500093931090 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
21:45:31 INFO - 1500093931090 Marionette TRACE 396 <- [1,4,null,{}]
21:45:31 INFO - 1500093931092 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
21:45:31 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500093931094 Marionette TRACE 396 <- [1,5,null,{"value":null}]
21:45:31 INFO - 1500093931094 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
21:45:31 INFO - 1500093931095 Marionette TRACE 396 <- [1,6,null,{}]
21:45:31 INFO - 1500093931097 Marionette DEBUG Closed connection 396
21:45:31 INFO - 1500093931097 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49809
21:45:31 INFO - 1500093931098 Marionette DEBUG Closed connection 397
21:45:31 INFO - 1500093931099 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49810
21:45:31 INFO - 1500093931099 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:45:31 INFO - 1500093931100 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:31 INFO - 1500093931102 Marionette DEBUG Register listener.js for window 15
21:45:31 INFO - 1500093931104 Marionette TRACE 398 <- [1,1,null,{"sessionId":"42650b59-161d-4bb6-956a-840b8e85dd04","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:31 INFO - 1500093931106 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
21:45:31 INFO - 1500093931107 Marionette TRACE 398 <- [1,2,null,{}]
21:45:31 INFO - 1500093931108 Marionette DEBUG Closed connection 398
21:45:31 INFO - 1500093931109 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49811
21:45:31 INFO - 1500093931109 Marionette DEBUG Closed connection 399
21:45:31 INFO - 1500093931111 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49812
21:45:31 INFO - 1500093931112 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:45:31 INFO - 1500093931112 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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}
21:45:31 INFO - 1500093931114 Marionette DEBUG Register listener.js for window 15
21:45:31 INFO - 1500093931117 Marionette TRACE 400 <- [1,1,null,{"sessionId":"dab3f11b-7f1d-4da0-9bc0-44987c5e986c","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":4020,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmpjoezb9.mozrunner","moz:accessibilityChecks":false}}]
21:45:31 INFO - 1500093931119 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
21:45:31 INFO - 1500093931120 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
21:45:31 INFO - 1500093931122 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
21:45:31 INFO - 1500093931122 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
21:45:31 INFO - 1500093931133 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
21:45:31 INFO - 1500093931136 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
21:45:31 INFO - 1500093931138 Marionette TRACE 400 <- [1,2,null,{}]
21:45:31 INFO - 1500093931146 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
21:45:31 INFO - 1500093931147 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5fe4258b-27c7-4d27-aae1-c2f342ecc1b4","ELEMENT":"5fe4258b-27c7-4d27-aae1-c2f342ecc1b4"}}]
21:45:31 INFO - 1500093931149 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"5fe4258b-27c7-4d27-aae1-c2f342ecc1b4"}]
21:45:31 INFO - 1500093931170 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
21:45:31 INFO - 1500093931172 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"5fe4258b-27c7-4d27-aae1-c2f342ecc1b4"}]
21:45:31 INFO - 1500093931185 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element