could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:44:10 INFO - 1499283850042 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499283850044 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499283850045 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 142ms
12:44:10 INFO - 1499283850046 Marionette TRACE 352 <- [1,6,null,{}]
12:44:10 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:44:10 INFO - 1499283850048 Marionette DEBUG Closed connection 352
12:44:10 INFO - 1499283850049 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49748
12:44:10 INFO - 1499283850050 Marionette DEBUG Closed connection 353
12:44:10 INFO - 1499283850050 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49749
12:44:10 INFO - 1499283850051 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850052 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850054 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850057 Marionette TRACE 354 <- [1,1,null,{"sessionId":"de41611d-7e47-44ea-9f0f-ec31d887b19f","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850058 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499283850059 Marionette TRACE 354 <- [1,2,null,{}]
12:44:10 INFO - 1499283850059 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499283850060 Marionette TRACE 354 <- [1,3,null,{}]
12:44:10 INFO - 1499283850061 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499283850061 Marionette TRACE 354 <- [1,4,null,{}]
12:44:10 INFO - 1499283850063 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499283850065 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499283850066 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499283850067 Marionette TRACE 354 <- [1,6,null,{}]
12:44:10 INFO - 1499283850069 Marionette DEBUG Closed connection 354
12:44:10 INFO - 1499283850069 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49750
12:44:10 INFO - 1499283850070 Marionette DEBUG Closed connection 355
12:44:10 INFO - 1499283850070 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49751
12:44:10 INFO - 1499283850071 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850072 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850080 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850084 Marionette TRACE 356 <- [1,1,null,{"sessionId":"e795296a-974c-41d6-9528-91b80a48ef39","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850085 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499283850086 Marionette TRACE 356 <- [1,2,null,{}]
12:44:10 INFO - 1499283850087 Marionette DEBUG Closed connection 356
12:44:10 INFO - 1499283850088 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49752
12:44:10 INFO - 1499283850089 Marionette DEBUG Closed connection 357
12:44:10 INFO - 1499283850089 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49753
12:44:10 INFO - 1499283850090 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499283850091 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850093 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850095 Marionette TRACE 358 <- [1,1,null,{"sessionId":"befb1ace-addf-41d0-acac-8a2b6f01b49e","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850097 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49324/clicks.html"}]
12:44:10 INFO - 1499283850098 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/hidden.html"
12:44:10 INFO - 1499283850102 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/hidden.html"
12:44:10 INFO - 1499283850103 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/hidden.html"
12:44:10 INFO - 1499283850121 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/clicks.html"
12:44:10 INFO - 1499283850123 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/clicks.html"
12:44:10 INFO - 1499283850126 Marionette TRACE 358 <- [1,2,null,{}]
12:44:10 INFO - 1499283850127 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:44:10 INFO - 1499283850129 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"94c8d347-d264-4cf9-8ffe-70549ca05699","ELEMENT":"94c8d347-d264-4cf9-8ffe-70549ca05699"}}]
12:44:10 INFO - 1499283850129 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"94c8d347-d264-4cf9-8ffe-70549ca05699"}]
12:44:10 INFO - 1499283850170 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/clicks.html"
12:44:10 INFO - 1499283850185 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/clicks.html"
12:44:10 INFO - 1499283850185 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/clicks.html"
12:44:10 INFO - 1499283850222 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/test.html"
12:44:10 INFO - 1499283850223 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/test.html"
12:44:10 INFO - 1499283850225 Marionette TRACE 358 <- [1,4,null,{}]
12:44:10 INFO - 1499283850226 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:44:10 INFO - 1499283850228 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a46e7a1f-866c-42cd-930a-b3fae1e4a8e5","ELEMENT":"a46e7a1f-866c-42cd-930a-b3fae1e4a8e5"}}]
12:44:10 INFO - 1499283850229 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:44:10 INFO - 1499283850229 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:44:10 INFO - 1499283850231 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 193ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element
12:44:10 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499283850238 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:44:10 INFO - 1499283850239 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:44:10 INFO - 1499283850240 Marionette TRACE 358 <- [1,8,null,{}]
12:44:10 INFO - 1499283850242 Marionette DEBUG Closed connection 358
12:44:10 INFO - 1499283850242 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49756
12:44:10 INFO - 1499283850243 Marionette DEBUG Closed connection 359
12:44:10 INFO - 1499283850244 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49757
12:44:10 INFO - 1499283850245 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850245 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850248 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850250 Marionette TRACE 360 <- [1,1,null,{"sessionId":"a0867aa2-3795-47b6-aa94-2dbf29ca60ac","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850252 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499283850252 Marionette TRACE 360 <- [1,2,null,{}]
12:44:10 INFO - 1499283850253 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499283850253 Marionette TRACE 360 <- [1,3,null,{}]
12:44:10 INFO - 1499283850254 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499283850255 Marionette TRACE 360 <- [1,4,null,{}]
12:44:10 INFO - 1499283850256 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element1499283850258 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499283850259 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499283850260 Marionette TRACE 360 <- [1,6,null,{}]
12:44:10 INFO - 1499283850262 Marionette DEBUG Closed connection 360
12:44:10 INFO - 1499283850262 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49758
12:44:10 INFO - 1499283850263 Marionette DEBUG Closed connection 361
12:44:10 INFO - 1499283850264 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49759
12:44:10 INFO - 1499283850266 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850266 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850268 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850271 Marionette TRACE 362 <- [1,1,null,{"sessionId":"ed1958e3-dd53-454c-90ab-dd3117527af5","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850273 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499283850274 Marionette TRACE 362 <- [1,2,null,{}]
12:44:10 INFO - 1499283850276 Marionette DEBUG Closed connection 362
12:44:10 INFO - 1499283850276 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49760
12:44:10 INFO - 1499283850277 Marionette DEBUG Closed connection 363
12:44:10 INFO - 1499283850277 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49761
12:44:10 INFO - 1499283850278 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499283850279 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850281 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850284 Marionette TRACE 364 <- [1,1,null,{"sessionId":"98985a3b-5bdc-4707-883d-effdb834944f","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850285 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1499283850286 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/test.html"
12:44:10 INFO - 1499283850288 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/test.html"
12:44:10 INFO - 1499283850288 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/test.html"
12:44:10 INFO - 1499283850307 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850311 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850313 Marionette TRACE 364 <- [1,2,null,{}]
12:44:10 INFO - 1499283850319 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1499283850321 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8e5b0172-f464-416e-9472-d6bdb8ea9a51","ELEMENT":"8e5b0172-f464-416e-9472-d6bdb8ea9a51"}}]
12:44:10 INFO - 1499283850323 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"8e5b0172-f464-416e-9472-d6bdb8ea9a51"}]
12:44:10 INFO - 1499283850567 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:10 INFO - 1499283850568 Marionette TRACE 364 <- [1,4,null,{}]
12:44:10 INFO - 1499283850569 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"8e5b0172-f464-416e-9472-d6bdb8ea9a51","name":"selected"}]
12:44:10 INFO - 1499283850573 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:44:10 INFO - 1499283850575 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_container_element1499283850577 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:44:10 INFO - 1499283850577 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:44:10 INFO - 1499283850578 Marionette TRACE 364 <- [1,7,null,{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 338ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:44:10 INFO - 1499283850580 Marionette DEBUG Closed connection 364
12:44:10 INFO - 1499283850582 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49762
12:44:10 INFO - 1499283850583 Marionette DEBUG Closed connection 365
12:44:10 INFO - 1499283850583 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49763
12:44:10 INFO - 1499283850584 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850585 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850587 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850590 Marionette TRACE 366 <- [1,1,null,{"sessionId":"9d5a6c58-7f44-4419-9c40-1d70a6fce765","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850590 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499283850591 Marionette TRACE 366 <- [1,2,null,{}]
12:44:10 INFO - 1499283850592 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499283850592 Marionette TRACE 366 <- [1,3,null,{}]
12:44:10 INFO - 1499283850593 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499283850593 Marionette TRACE 366 <- [1,4,null,{}]
12:44:10 INFO - 1499283850595 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499283850597 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499283850598 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499283850599 Marionette TRACE 366 <- [1,6,null,{}]
12:44:10 INFO - 1499283850600 Marionette DEBUG Closed connection 366
12:44:10 INFO - 1499283850601 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49764
12:44:10 INFO - 1499283850601 Marionette DEBUG Closed connection 367
12:44:10 INFO - 1499283850602 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49765
12:44:10 INFO - 1499283850603 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850603 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850605 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850609 Marionette TRACE 368 <- [1,1,null,{"sessionId":"67a2acb2-c217-4166-a43f-8868af973a84","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850610 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499283850611 Marionette TRACE 368 <- [1,2,null,{}]
12:44:10 INFO - 1499283850612 Marionette DEBUG Closed connection 368
12:44:10 INFO - 1499283850613 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49766
12:44:10 INFO - 1499283850613 Marionette DEBUG Closed connection 369
12:44:10 INFO - 1499283850614 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49767
12:44:10 INFO - 1499283850615 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499283850616 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850618 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850620 Marionette TRACE 370 <- [1,1,null,{"sessionId":"51cf127a-64da-4f29-928b-13ba2e9a7d94","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850621 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:10 INFO - 1499283850622 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850624 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850624 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850640 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850643 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850645 Marionette TRACE 370 <- [1,2,null,{}]
12:44:10 INFO - 1499283850647 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:44:10 INFO - 1499283850655 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"daa28e5d-4398-4761-b6d9-2b6fecad6a23","ELEMENT":"daa28e5d-4398-4761-b6d9-2b6fecad6a23"}}]
12:44:10 INFO - 1499283850656 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"daa28e5d-4398-4761-b6d9-2b6fecad6a23"}]
12:44:10 INFO - 1499283850894 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:10 INFO - 1499283850894 Marionette TRACE 370 <- [1,4,null,{}]
12:44:10 INFO - 1499283850896 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"daa28e5d-4398-4761-b6d9-2b6fecad6a23","name":"selected"}]
12:44:10 INFO - 1499283850900 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:44:10 INFO - 1499283850902 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
12:44:10 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499283850904 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:44:10 INFO - 1499283850905 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:44:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 326ms
12:44:10 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:44:10 INFO - 1499283850906 Marionette TRACE 370 <- [1,7,null,{}]
12:44:10 INFO - 1499283850908 Marionette DEBUG Closed connection 370
12:44:10 INFO - 1499283850909 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49768
12:44:10 INFO - 1499283850909 Marionette DEBUG Closed connection 371
12:44:10 INFO - 1499283850910 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49769
12:44:10 INFO - 1499283850911 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850911 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850913 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850916 Marionette TRACE 372 <- [1,1,null,{"sessionId":"a29c4ada-247f-41db-a74c-222dd4ae0ae5","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850917 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:44:10 INFO - 1499283850918 Marionette TRACE 372 <- [1,2,null,{}]
12:44:10 INFO - 1499283850919 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:10 INFO - 1499283850919 Marionette TRACE 372 <- [1,3,null,{}]
12:44:10 INFO - 1499283850920 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:10 INFO - 1499283850920 Marionette TRACE 372 <- [1,4,null,{}]
12:44:10 INFO - 1499283850922 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
12:44:10 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499283850923 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:44:10 INFO - 1499283850924 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:44:10 INFO - 1499283850925 Marionette TRACE 372 <- [1,6,null,{}]
12:44:10 INFO - 1499283850927 Marionette DEBUG Closed connection 372
12:44:10 INFO - 1499283850927 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49770
12:44:10 INFO - 1499283850928 Marionette DEBUG Closed connection 373
12:44:10 INFO - 1499283850929 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49771
12:44:10 INFO - 1499283850930 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:10 INFO - 1499283850930 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850932 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850935 Marionette TRACE 374 <- [1,1,null,{"sessionId":"dcf3aec7-eead-4d98-8b1c-0e3d49eee022","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850936 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:44:10 INFO - 1499283850936 Marionette TRACE 374 <- [1,2,null,{}]
12:44:10 INFO - 1499283850938 Marionette DEBUG Closed connection 374
12:44:10 INFO - 1499283850939 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49772
12:44:10 INFO - 1499283850939 Marionette DEBUG Closed connection 375
12:44:10 INFO - 1499283850940 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49773
12:44:10 INFO - 1499283850941 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:10 INFO - 1499283850942 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:10 INFO - 1499283850943 Marionette DEBUG Register listener.js for window 12
12:44:10 INFO - 1499283850946 Marionette TRACE 376 <- [1,1,null,{"sessionId":"5c1ed1dd-5f41-4433-a9b3-dfaadef333df","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:10 INFO - 1499283850947 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
12:44:10 INFO - 1499283850948 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850950 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850950 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:10 INFO - 1499283850974 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:10 INFO - 1499283850977 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:10 INFO - 1499283850979 Marionette TRACE 376 <- [1,2,null,{}]
12:44:10 INFO - 1499283850980 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:44:10 INFO - 1499283850988 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"70c79199-3c8a-4505-8446-98aeebd4717d","ELEMENT":"70c79199-3c8a-4505-8446-98aeebd4717d"}}]
12:44:10 INFO - 1499283850989 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"70c79199-3c8a-4505-8446-98aeebd4717d"}]
12:44:11 INFO - 1499283851225 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499283851225 Marionette TRACE 376 <- [1,4,null,{}]
12:44:11 INFO - 1499283851227 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499283851229 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851230 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 324ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:44:11 INFO - 1499283851231 Marionette TRACE 376 <- [1,6,null,{}]
12:44:11 INFO - 1499283851232 Marionette DEBUG Closed connection 376
12:44:11 INFO - 1499283851233 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49774
12:44:11 INFO - 1499283851234 Marionette DEBUG Closed connection 377
12:44:11 INFO - 1499283851235 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49775
12:44:11 INFO - 1499283851236 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851236 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851238 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851241 Marionette TRACE 378 <- [1,1,null,{"sessionId":"fa735db7-aea9-40a6-997c-6fe5f21b916d","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851242 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499283851242 Marionette TRACE 378 <- [1,2,null,{}]
12:44:11 INFO - 1499283851243 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1499283851244 Marionette TRACE 378 <- [1,3,null,{}]
12:44:11 INFO - 1499283851245 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1499283851245 Marionette TRACE 378 <- [1,4,null,{}]
12:44:11 INFO - 1499283851246 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499283851248 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851249 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499283851250 Marionette TRACE 378 <- [1,6,null,{}]
12:44:11 INFO - 1499283851252 Marionette DEBUG Closed connection 378
12:44:11 INFO - 1499283851252 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49776
12:44:11 INFO - 1499283851253 Marionette DEBUG Closed connection 379
12:44:11 INFO - 1499283851254 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49777
12:44:11 INFO - 1499283851254 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851255 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851257 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851260 Marionette TRACE 380 <- [1,1,null,{"sessionId":"9e8ce132-a8bb-419c-8147-7d1ab7d9e94e","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851260 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1499283851261 Marionette TRACE 380 <- [1,2,null,{}]
12:44:11 INFO - 1499283851263 Marionette DEBUG Closed connection 380
12:44:11 INFO - 1499283851263 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49778
12:44:11 INFO - 1499283851264 Marionette DEBUG Closed connection 381
12:44:11 INFO - 1499283851265 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49779
12:44:11 INFO - 1499283851266 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1499283851266 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851268 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851271 Marionette TRACE 382 <- [1,1,null,{"sessionId":"d83bc20d-db68-4295-9d8e-12abb66f9174","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851272 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:44:11 INFO - 1499283851273 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1499283851275 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1499283851275 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:44:11 INFO - 1499283851291 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1499283851294 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1499283851296 Marionette TRACE 382 <- [1,2,null,{}]
12:44:11 INFO - 1499283851304 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:44:11 INFO - 1499283851306 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8cf16c3a-54ec-48f1-a8a5-2f9355f65afc","ELEMENT":"8cf16c3a-54ec-48f1-a8a5-2f9355f65afc"}}]
12:44:11 INFO - 1499283851307 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"8cf16c3a-54ec-48f1-a8a5-2f9355f65afc"}]
12:44:11 INFO - 1499283851551 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499283851551 Marionette TRACE 382 <- [1,4,null,{}]
12:44:11 INFO - 1499283851553 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499283851555 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851557 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 327ms
12:44:11 INFO - TEST-START | test_click.py TestClick.test_input_file
12:44:11 INFO - 1499283851558 Marionette TRACE 382 <- [1,6,null,{}]
12:44:11 INFO - 1499283851559 Marionette DEBUG Closed connection 382
12:44:11 INFO - 1499283851560 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49780
12:44:11 INFO - 1499283851561 Marionette DEBUG Closed connection 383
12:44:11 INFO - 1499283851561 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49781
12:44:11 INFO - 1499283851562 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851563 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851565 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851567 Marionette TRACE 384 <- [1,1,null,{"sessionId":"c996a618-f6c5-4157-903a-2b8fedda126d","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851568 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499283851569 Marionette TRACE 384 <- [1,2,null,{}]
12:44:11 INFO - 1499283851569 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1499283851570 Marionette TRACE 384 <- [1,3,null,{}]
12:44:11 INFO - 1499283851571 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1499283851571 Marionette TRACE 384 <- [1,4,null,{}]
12:44:11 INFO - 1499283851573 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_input_file1499283851574 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851575 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499283851576 Marionette TRACE 384 <- [1,6,null,{}]
12:44:11 INFO - 1499283851578 Marionette DEBUG Closed connection 384
12:44:11 INFO - 1499283851578 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49782
12:44:11 INFO - 1499283851579 Marionette DEBUG Closed connection 385
12:44:11 INFO - 1499283851580 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49783
12:44:11 INFO - 1499283851581 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851581 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851583 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851586 Marionette TRACE 386 <- [1,1,null,{"sessionId":"6232730c-2384-4dd3-a39c-da7f31c9abc1","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851587 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1499283851588 Marionette TRACE 386 <- [1,2,null,{}]
12:44:11 INFO - 1499283851590 Marionette DEBUG Closed connection 386
12:44:11 INFO - 1499283851590 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49784
12:44:11 INFO - 1499283851591 Marionette DEBUG Closed connection 387
12:44:11 INFO - 1499283851591 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49785
12:44:11 INFO - 1499283851592 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1499283851593 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851595 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851598 Marionette TRACE 388 <- [1,1,null,{"sessionId":"014f84a1-b5df-442f-8600-bc4798446bf2","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851599 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:44:11 INFO - 1499283851600 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1499283851601 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1499283851602 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:44:11 INFO - 1499283851611 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1499283851615 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1499283851623 Marionette TRACE 388 <- [1,2,null,{}]
12:44:11 INFO - 1499283851625 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:44:11 INFO - 1499283851627 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9f35785b-a593-4689-bbcb-6b3ae8bd5c15","ELEMENT":"9f35785b-a593-4689-bbcb-6b3ae8bd5c15"}}]
12:44:11 INFO - 1499283851628 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"9f35785b-a593-4689-bbcb-6b3ae8bd5c15"}]
12:44:11 INFO - 1499283851651 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:44:11 INFO - 1499283851653 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
12:44:11 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 100ms
12:44:11 INFO - TEST-END: test_click.py TestClick.test_input_file1499283851656 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851657 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499283851658 Marionette TRACE 388 <- [1,6,null,{}]
12:44:11 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:44:11 INFO - 1499283851660 Marionette DEBUG Closed connection 388
12:44:11 INFO - 1499283851662 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49786
12:44:11 INFO - 1499283851663 Marionette DEBUG Closed connection 389
12:44:11 INFO - 1499283851663 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49787
12:44:11 INFO - 1499283851664 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851665 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851667 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851670 Marionette TRACE 390 <- [1,1,null,{"sessionId":"64b77281-76c4-44a6-bd53-d99897b7de12","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851671 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:44:11 INFO - 1499283851671 Marionette TRACE 390 <- [1,2,null,{}]
12:44:11 INFO - 1499283851672 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:11 INFO - 1499283851672 Marionette TRACE 390 <- [1,3,null,{}]
12:44:11 INFO - 1499283851673 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:11 INFO - 1499283851674 Marionette TRACE 390 <- [1,4,null,{}]
12:44:11 INFO - 1499283851675 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
12:44:11 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499283851677 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:44:11 INFO - 1499283851678 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:44:11 INFO - 1499283851679 Marionette TRACE 390 <- [1,6,null,{}]
12:44:11 INFO - 1499283851681 Marionette DEBUG Closed connection 390
12:44:11 INFO - 1499283851681 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49788
12:44:11 INFO - 1499283851682 Marionette DEBUG Closed connection 391
12:44:11 INFO - 1499283851683 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49789
12:44:11 INFO - 1499283851684 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:11 INFO - 1499283851684 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851686 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851689 Marionette TRACE 392 <- [1,1,null,{"sessionId":"45792403-ec6a-4867-b9af-2ba658f7b9e7","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851690 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:44:11 INFO - 1499283851691 Marionette TRACE 392 <- [1,2,null,{}]
12:44:11 INFO - 1499283851693 Marionette DEBUG Closed connection 392
12:44:11 INFO - 1499283851693 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49790
12:44:11 INFO - 1499283851694 Marionette DEBUG Closed connection 393
12:44:11 INFO - 1499283851695 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49791
12:44:11 INFO - 1499283851696 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:11 INFO - 1499283851696 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:11 INFO - 1499283851698 Marionette DEBUG Register listener.js for window 12
12:44:11 INFO - 1499283851701 Marionette TRACE 394 <- [1,1,null,{"sessionId":"fb57b9bc-cebe-4541-8483-813266db0df8","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:11 INFO - 1499283851702 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
12:44:11 INFO - 1499283851703 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1499283851705 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1499283851705 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:44:11 INFO - 1499283851721 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:11 INFO - 1499283851723 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:11 INFO - 1499283851725 Marionette TRACE 394 <- [1,2,null,{}]
12:44:11 INFO - 1499283851726 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:44:11 INFO - 1499283851728 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c656bfb-aa62-4de7-b1f2-0fc641b73378","ELEMENT":"8c656bfb-aa62-4de7-b1f2-0fc641b73378"}}]
12:44:11 INFO - 1499283851729 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:44:11 INFO - 1499283851735 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"25303111-5ece-437f-9695-7c7b056cce28","ELEMENT":"25303111-5ece-437f-9695-7c7b056cce28"}}]
12:44:11 INFO - 1499283851737 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"8c656bfb-aa62-4de7-b1f2-0fc641b73378"}]
12:44:11 INFO - 1499283851978 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:44:11 INFO - 1499283851978 Marionette TRACE 394 <- [1,5,null,{}]
12:44:11 INFO - 1499283851979 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"25303111-5ece-437f-9695-7c7b056cce28"}]
12:44:12 INFO - 1499283851992 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
12:44:12 INFO - 1499283851994 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
12:44:12 INFO - 1499283851996 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:44:12 INFO - 1499283851997 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
12:44:12 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499283851999 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:44:12 INFO - 1499283852000 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:44:12 INFO - 1499283852001 Marionette TRACE 394 <- [1,9,null,{}]
12:44:12 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 342ms
12:44:12 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:44:12 INFO - 1499283852003 Marionette DEBUG Closed connection 394
12:44:12 INFO - 1499283852004 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49792
12:44:12 INFO - 1499283852004 Marionette DEBUG Closed connection 395
12:44:12 INFO - 1499283852005 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49793
12:44:12 INFO - 1499283852006 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499283852006 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499283852008 Marionette DEBUG Register listener.js for window 12
12:44:12 INFO - 1499283852011 Marionette TRACE 396 <- [1,1,null,{"sessionId":"9bd41a66-be78-4bb6-b98e-b3922ef9e9d4","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499283852012 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:44:12 INFO - 1499283852013 Marionette TRACE 396 <- [1,2,null,{}]
12:44:12 INFO - 1499283852014 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:44:12 INFO - 1499283852014 Marionette TRACE 396 <- [1,3,null,{}]
12:44:12 INFO - 1499283852015 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:44:12 INFO - 1499283852015 Marionette TRACE 396 <- [1,4,null,{}]
12:44:12 INFO - 1499283852017 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
12:44:12 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499283852019 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:44:12 INFO - 1499283852020 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:44:12 INFO - 1499283852021 Marionette TRACE 396 <- [1,6,null,{}]
12:44:12 INFO - 1499283852023 Marionette DEBUG Closed connection 396
12:44:12 INFO - 1499283852023 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49794
12:44:12 INFO - 1499283852024 Marionette DEBUG Closed connection 397
12:44:12 INFO - 1499283852024 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49795
12:44:12 INFO - 1499283852025 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:44:12 INFO - 1499283852026 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499283852028 Marionette DEBUG Register listener.js for window 12
12:44:12 INFO - 1499283852030 Marionette TRACE 398 <- [1,1,null,{"sessionId":"24d3d932-c4d3-4e76-b4d2-e979dbed8784","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499283852031 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:44:12 INFO - 1499283852032 Marionette TRACE 398 <- [1,2,null,{}]
12:44:12 INFO - 1499283852034 Marionette DEBUG Closed connection 398
12:44:12 INFO - 1499283852034 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49796
12:44:12 INFO - 1499283852035 Marionette DEBUG Closed connection 399
12:44:12 INFO - 1499283852035 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49797
12:44:12 INFO - 1499283852036 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:44:12 INFO - 1499283852037 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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}
12:44:12 INFO - 1499283852039 Marionette DEBUG Register listener.js for window 12
12:44:12 INFO - 1499283852041 Marionette TRACE 400 <- [1,1,null,{"sessionId":"c5418bbe-f739-4663-8fe3-083cc1c0579a","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":2704,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-061.001\\AppData\\Local\\Temp\\tmppdlvvi.mozrunner","moz:accessibilityChecks":false}}]
12:44:12 INFO - 1499283852043 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
12:44:12 INFO - 1499283852044 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1499283852045 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1499283852046 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:44:12 INFO - 1499283852062 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:44:12 INFO - 1499283852065 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:44:12 INFO - 1499283852072 Marionette TRACE 400 <- [1,2,null,{}]
12:44:12 INFO - 1499283852073 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:44:12 INFO - 1499283852075 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7eb7cb47-1cb6-402b-916d-8d49cd7a2da4","ELEMENT":"7eb7cb47-1cb6-402b-916d-8d49cd7a2da4"}}]
12:44:12 INFO - 1499283852076 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"7eb7cb47-1cb6-402b-916d-8d49cd7a2da4"}]
12:44:12 INFO - 1499283852098 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:44:12 INFO - 1499283852100 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"7eb7cb47-1cb6-402b-916d-8d49cd7a2da4"}]
12:44:12 INFO - 1499283852113 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element