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]
10:53:30 INFO - 1500227610173 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:53:30 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500227610175 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:53:30 INFO - 1500227610176 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:53:30 INFO - 1500227610178 Marionette TRACE 352 <- [1,6,null,{}]
10:53:30 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 148ms
10:53:30 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:53:30 INFO - 1500227610180 Marionette DEBUG Closed connection 352
10:53:30 INFO - 1500227610181 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49759
10:53:30 INFO - 1500227610181 Marionette DEBUG Closed connection 353
10:53:30 INFO - 1500227610182 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49760
10:53:30 INFO - 1500227610183 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610184 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610187 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610190 Marionette TRACE 354 <- [1,1,null,{"sessionId":"5ec23bab-5839-4d57-bb11-3728a56e3d7e","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610193 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:53:30 INFO - 1500227610194 Marionette TRACE 354 <- [1,2,null,{}]
10:53:30 INFO - 1500227610195 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:30 INFO - 1500227610195 Marionette TRACE 354 <- [1,3,null,{}]
10:53:30 INFO - 1500227610196 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:30 INFO - 1500227610197 Marionette TRACE 354 <- [1,4,null,{}]
10:53:30 INFO - 1500227610198 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:53:30 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500227610201 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:53:30 INFO - 1500227610202 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:53:30 INFO - 1500227610203 Marionette TRACE 354 <- [1,6,null,{}]
10:53:30 INFO - 1500227610206 Marionette DEBUG Closed connection 354
10:53:30 INFO - 1500227610206 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49761
10:53:30 INFO - 1500227610207 Marionette DEBUG Closed connection 355
10:53:30 INFO - 1500227610208 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49762
10:53:30 INFO - 1500227610209 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610209 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610212 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610215 Marionette TRACE 356 <- [1,1,null,{"sessionId":"2eb02254-6079-425f-b55d-3a4a4d1bc93f","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610218 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:53:30 INFO - 1500227610220 Marionette TRACE 356 <- [1,2,null,{}]
10:53:30 INFO - 1500227610223 Marionette DEBUG Closed connection 356
10:53:30 INFO - 1500227610224 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49763
10:53:30 INFO - 1500227610224 Marionette DEBUG Closed connection 357
10:53:30 INFO - 1500227610225 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49764
10:53:30 INFO - 1500227610226 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:30 INFO - 1500227610227 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610230 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610233 Marionette TRACE 358 <- [1,1,null,{"sessionId":"03f56f21-4348-42cb-bf01-b5cd96ab20fa","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610235 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49325/clicks.html"}]
10:53:30 INFO - 1500227610237 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49325/hidden.html"
10:53:30 INFO - 1500227610246 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49325/hidden.html"
10:53:30 INFO - 1500227610247 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49325/hidden.html"
10:53:30 INFO - 1500227610267 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49325/clicks.html"
10:53:30 INFO - 1500227610269 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49325/clicks.html"
10:53:30 INFO - 1500227610273 Marionette TRACE 358 <- [1,2,null,{}]
10:53:30 INFO - 1500227610274 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:53:30 INFO - 1500227610282 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6943a9f8-6b50-4110-9e00-4b178e45995f","ELEMENT":"6943a9f8-6b50-4110-9e00-4b178e45995f"}}]
10:53:30 INFO - 1500227610284 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"6943a9f8-6b50-4110-9e00-4b178e45995f"}]
10:53:30 INFO - 1500227610334 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49325/clicks.html"
10:53:30 INFO - 1500227610339 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49325/clicks.html"
10:53:30 INFO - 1500227610340 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49325/clicks.html"
10:53:30 INFO - 1500227610363 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49325/test.html"
10:53:30 INFO - 1500227610365 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49325/test.html"
10:53:30 INFO - 1500227610368 Marionette TRACE 358 <- [1,4,null,{}]
10:53:30 INFO - 1500227610369 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:53:30 INFO - 1500227610372 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"89a726fd-6bd9-4c5b-a1fe-e4b206ff0c4a","ELEMENT":"89a726fd-6bd9-4c5b-a1fe-e4b206ff0c4a"}}]
10:53:30 INFO - 1500227610373 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:53:30 INFO - 1500227610373 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:53:30 INFO - 1500227610381 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:53:30 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500227610384 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:53:30 INFO - 1500227610385 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:53:30 INFO - 1500227610387 Marionette TRACE 358 <- [1,8,null,{}]
10:53:30 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 208ms
10:53:30 INFO - TEST-START | test_click.py TestClick.test_container_element
10:53:30 INFO - 1500227610389 Marionette DEBUG Closed connection 358
10:53:30 INFO - 1500227610389 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49767
10:53:30 INFO - 1500227610390 Marionette DEBUG Closed connection 359
10:53:30 INFO - 1500227610391 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49768
10:53:30 INFO - 1500227610393 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610393 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610396 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610400 Marionette TRACE 360 <- [1,1,null,{"sessionId":"39efab99-e3c9-4e3d-849a-e448a256cfbf","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610402 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:53:30 INFO - 1500227610403 Marionette TRACE 360 <- [1,2,null,{}]
10:53:30 INFO - 1500227610403 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:30 INFO - 1500227610404 Marionette TRACE 360 <- [1,3,null,{}]
10:53:30 INFO - 1500227610405 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:30 INFO - 1500227610405 Marionette TRACE 360 <- [1,4,null,{}]
10:53:30 INFO - 1500227610407 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:53:30 INFO - TEST-START: test_click.py TestClick.test_container_element1500227610412 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:53:30 INFO - 1500227610412 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:53:30 INFO - 1500227610414 Marionette TRACE 360 <- [1,6,null,{}]
10:53:30 INFO - 1500227610416 Marionette DEBUG Closed connection 360
10:53:30 INFO - 1500227610417 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49769
10:53:30 INFO - 1500227610417 Marionette DEBUG Closed connection 361
10:53:30 INFO - 1500227610418 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49770
10:53:30 INFO - 1500227610419 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610420 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610422 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610427 Marionette TRACE 362 <- [1,1,null,{"sessionId":"4faf0e17-11b8-47db-98fa-2d8989db5aca","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610430 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:53:30 INFO - 1500227610431 Marionette TRACE 362 <- [1,2,null,{}]
10:53:30 INFO - 1500227610433 Marionette DEBUG Closed connection 362
10:53:30 INFO - 1500227610434 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49771
10:53:30 INFO - 1500227610435 Marionette DEBUG Closed connection 363
10:53:30 INFO - 1500227610435 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49772
10:53:30 INFO - 1500227610436 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:30 INFO - 1500227610437 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610440 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610444 Marionette TRACE 364 <- [1,1,null,{"sessionId":"bee598a2-2eb1-4699-838c-c28b0ecb4f89","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610447 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:53:30 INFO - 1500227610448 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49325/test.html"
10:53:30 INFO - 1500227610450 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49325/test.html"
10:53:30 INFO - 1500227610451 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49325/test.html"
10:53:30 INFO - 1500227610475 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610482 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610485 Marionette TRACE 364 <- [1,2,null,{}]
10:53:30 INFO - 1500227610486 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:53:30 INFO - 1500227610489 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a4b5dbcc-3751-4d95-b398-da1aa1f7e736","ELEMENT":"a4b5dbcc-3751-4d95-b398-da1aa1f7e736"}}]
10:53:30 INFO - 1500227610496 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"a4b5dbcc-3751-4d95-b398-da1aa1f7e736"}]
10:53:30 INFO - 1500227610741 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:53:30 INFO - 1500227610742 Marionette TRACE 364 <- [1,4,null,{}]
10:53:30 INFO - 1500227610743 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"a4b5dbcc-3751-4d95-b398-da1aa1f7e736","name":"selected"}]
10:53:30 INFO - 1500227610748 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:53:30 INFO - 1500227610749 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:53:30 INFO - TEST-END: test_click.py TestClick.test_container_element1500227610752 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:53:30 INFO - 1500227610753 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:53:30 INFO - 1500227610754 Marionette TRACE 364 <- [1,7,null,{}]
10:53:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 367ms
10:53:30 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:53:30 INFO - 1500227610757 Marionette DEBUG Closed connection 364
10:53:30 INFO - 1500227610757 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49773
10:53:30 INFO - 1500227610758 Marionette DEBUG Closed connection 365
10:53:30 INFO - 1500227610759 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49774
10:53:30 INFO - 1500227610760 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610760 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610763 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610766 Marionette TRACE 366 <- [1,1,null,{"sessionId":"436e48dd-9cd2-4061-a37e-b4ec2ef5d64c","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610768 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:53:30 INFO - 1500227610769 Marionette TRACE 366 <- [1,2,null,{}]
10:53:30 INFO - 1500227610769 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:30 INFO - 1500227610770 Marionette TRACE 366 <- [1,3,null,{}]
10:53:30 INFO - 1500227610771 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:30 INFO - 1500227610772 Marionette TRACE 366 <- [1,4,null,{}]
10:53:30 INFO - 1500227610774 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:53:30 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500227610776 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:53:30 INFO - 1500227610777 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:53:30 INFO - 1500227610779 Marionette TRACE 366 <- [1,6,null,{}]
10:53:30 INFO - 1500227610781 Marionette DEBUG Closed connection 366
10:53:30 INFO - 1500227610781 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49775
10:53:30 INFO - 1500227610782 Marionette DEBUG Closed connection 367
10:53:30 INFO - 1500227610783 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49776
10:53:30 INFO - 1500227610784 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:30 INFO - 1500227610785 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610794 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610799 Marionette TRACE 368 <- [1,1,null,{"sessionId":"28ef9d24-f7ed-4d81-a8c1-a29d4e460735","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610801 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:53:30 INFO - 1500227610802 Marionette TRACE 368 <- [1,2,null,{}]
10:53:30 INFO - 1500227610805 Marionette DEBUG Closed connection 368
10:53:30 INFO - 1500227610805 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49777
10:53:30 INFO - 1500227610806 Marionette DEBUG Closed connection 369
10:53:30 INFO - 1500227610807 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49778
10:53:30 INFO - 1500227610808 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:30 INFO - 1500227610808 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:30 INFO - 1500227610811 Marionette DEBUG Register listener.js for window 15
10:53:30 INFO - 1500227610814 Marionette TRACE 370 <- [1,1,null,{"sessionId":"e0a7a8f7-9262-4fae-a02d-0b3c9b336d86","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:30 INFO - 1500227610816 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:53:30 INFO - 1500227610817 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610820 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610820 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610838 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610842 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:30 INFO - 1500227610853 Marionette TRACE 370 <- [1,2,null,{}]
10:53:30 INFO - 1500227610854 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:53:30 INFO - 1500227610857 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"da8f909c-c4ac-46dc-817e-5768b667f1f1","ELEMENT":"da8f909c-c4ac-46dc-817e-5768b667f1f1"}}]
10:53:30 INFO - 1500227610858 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"da8f909c-c4ac-46dc-817e-5768b667f1f1"}]
10:53:31 INFO - 1500227611103 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:53:31 INFO - 1500227611104 Marionette TRACE 370 <- [1,4,null,{}]
10:53:31 INFO - 1500227611105 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"da8f909c-c4ac-46dc-817e-5768b667f1f1","name":"selected"}]
10:53:31 INFO - 1500227611110 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:53:31 INFO - 1500227611112 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:53:31 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500227611114 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:53:31 INFO - 1500227611116 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:53:31 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 362ms
10:53:31 INFO - 1500227611117 Marionette TRACE 370 <- [1,7,null,{}]
10:53:31 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:53:31 INFO - 1500227611120 Marionette DEBUG Closed connection 370
10:53:31 INFO - 1500227611121 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49779
10:53:31 INFO - 1500227611122 Marionette DEBUG Closed connection 371
10:53:31 INFO - 1500227611122 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49780
10:53:31 INFO - 1500227611123 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611124 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611127 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611130 Marionette TRACE 372 <- [1,1,null,{"sessionId":"753b7bd0-0269-40dc-84de-ee24a62f65fe","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611133 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:53:31 INFO - 1500227611133 Marionette TRACE 372 <- [1,2,null,{}]
10:53:31 INFO - 1500227611134 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:31 INFO - 1500227611135 Marionette TRACE 372 <- [1,3,null,{}]
10:53:31 INFO - 1500227611136 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:31 INFO - 1500227611136 Marionette TRACE 372 <- [1,4,null,{}]
10:53:31 INFO - 1500227611138 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:53:31 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500227611140 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611142 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:53:31 INFO - 1500227611143 Marionette TRACE 372 <- [1,6,null,{}]
10:53:31 INFO - 1500227611145 Marionette DEBUG Closed connection 372
10:53:31 INFO - 1500227611146 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49781
10:53:31 INFO - 1500227611147 Marionette DEBUG Closed connection 373
10:53:31 INFO - 1500227611147 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49782
10:53:31 INFO - 1500227611148 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611149 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611152 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611155 Marionette TRACE 374 <- [1,1,null,{"sessionId":"168fd18a-7399-4cdb-88b4-12387e158a6b","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611158 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:53:31 INFO - 1500227611159 Marionette TRACE 374 <- [1,2,null,{}]
10:53:31 INFO - 1500227611161 Marionette DEBUG Closed connection 374
10:53:31 INFO - 1500227611162 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49783
10:53:31 INFO - 1500227611163 Marionette DEBUG Closed connection 375
10:53:31 INFO - 1500227611163 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49784
10:53:31 INFO - 1500227611164 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:31 INFO - 1500227611165 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611168 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611171 Marionette TRACE 376 <- [1,1,null,{"sessionId":"5310b86e-13af-49be-98bd-707463011c72","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611173 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:53:31 INFO - 1500227611176 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611178 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611179 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611199 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:53:31 INFO - 1500227611202 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:53:31 INFO - 1500227611205 Marionette TRACE 376 <- [1,2,null,{}]
10:53:31 INFO - 1500227611206 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:53:31 INFO - 1500227611220 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2fddc191-15d7-442a-a79b-eb8b6dab3259","ELEMENT":"2fddc191-15d7-442a-a79b-eb8b6dab3259"}}]
10:53:31 INFO - 1500227611221 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"2fddc191-15d7-442a-a79b-eb8b6dab3259"}]
10:53:31 INFO - 1500227611470 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:53:31 INFO - 1500227611471 Marionette TRACE 376 <- [1,4,null,{}]
10:53:31 INFO - 1500227611473 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:53:31 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500227611475 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611476 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:53:31 INFO - 1500227611478 Marionette TRACE 376 <- [1,6,null,{}]
10:53:31 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 360ms
10:53:31 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:53:31 INFO - 1500227611480 Marionette DEBUG Closed connection 376
10:53:31 INFO - 1500227611481 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49785
10:53:31 INFO - 1500227611482 Marionette DEBUG Closed connection 377
10:53:31 INFO - 1500227611482 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49786
10:53:31 INFO - 1500227611483 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611484 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611487 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611490 Marionette TRACE 378 <- [1,1,null,{"sessionId":"5e36a768-781d-4178-a084-fe2942d6fabe","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611492 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:53:31 INFO - 1500227611493 Marionette TRACE 378 <- [1,2,null,{}]
10:53:31 INFO - 1500227611494 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:31 INFO - 1500227611494 Marionette TRACE 378 <- [1,3,null,{}]
10:53:31 INFO - 1500227611495 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:31 INFO - 1500227611496 Marionette TRACE 378 <- [1,4,null,{}]
10:53:31 INFO - 1500227611497 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:53:31 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500227611500 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611501 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:53:31 INFO - 1500227611502 Marionette TRACE 378 <- [1,6,null,{}]
10:53:31 INFO - 1500227611504 Marionette DEBUG Closed connection 378
10:53:31 INFO - 1500227611505 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49787
10:53:31 INFO - 1500227611506 Marionette DEBUG Closed connection 379
10:53:31 INFO - 1500227611506 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49788
10:53:31 INFO - 1500227611507 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611508 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611510 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611513 Marionette TRACE 380 <- [1,1,null,{"sessionId":"a4d3789d-c73b-41fa-9701-6e86b6c42b5d","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611515 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:53:31 INFO - 1500227611517 Marionette TRACE 380 <- [1,2,null,{}]
10:53:31 INFO - 1500227611519 Marionette DEBUG Closed connection 380
10:53:31 INFO - 1500227611519 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49789
10:53:31 INFO - 1500227611520 Marionette DEBUG Closed connection 381
10:53:31 INFO - 1500227611521 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49790
10:53:31 INFO - 1500227611522 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:31 INFO - 1500227611522 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611525 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611528 Marionette TRACE 382 <- [1,1,null,{"sessionId":"be8b8eb4-ce8f-483d-a84c-1dd745fe4e71","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611530 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:53:31 INFO - 1500227611532 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:53:31 INFO - 1500227611534 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:53:31 INFO - 1500227611534 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:53:31 INFO - 1500227611552 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611556 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611559 Marionette TRACE 382 <- [1,2,null,{}]
10:53:31 INFO - 1500227611566 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:53:31 INFO - 1500227611568 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"37f1014d-7c1f-4a84-91bf-9532d8343206","ELEMENT":"37f1014d-7c1f-4a84-91bf-9532d8343206"}}]
10:53:31 INFO - 1500227611569 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"37f1014d-7c1f-4a84-91bf-9532d8343206"}]
10:53:31 INFO - 1500227611815 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:53:31 INFO - 1500227611816 Marionette TRACE 382 <- [1,4,null,{}]
10:53:31 INFO - 1500227611818 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:53:31 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500227611821 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611822 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:53:31 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 345ms
10:53:31 INFO - 1500227611823 Marionette TRACE 382 <- [1,6,null,{}]
10:53:31 INFO - TEST-START | test_click.py TestClick.test_input_file
10:53:31 INFO - 1500227611826 Marionette DEBUG Closed connection 382
10:53:31 INFO - 1500227611827 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49791
10:53:31 INFO - 1500227611828 Marionette DEBUG Closed connection 383
10:53:31 INFO - 1500227611828 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49792
10:53:31 INFO - 1500227611830 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611830 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611833 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611836 Marionette TRACE 384 <- [1,1,null,{"sessionId":"a871c85c-7df1-493e-ba19-ef7ce8283eac","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611838 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:53:31 INFO - 1500227611838 Marionette TRACE 384 <- [1,2,null,{}]
10:53:31 INFO - 1500227611839 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:31 INFO - 1500227611840 Marionette TRACE 384 <- [1,3,null,{}]
10:53:31 INFO - 1500227611841 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:31 INFO - 1500227611841 Marionette TRACE 384 <- [1,4,null,{}]
10:53:31 INFO - 1500227611842 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:53:31 INFO - TEST-START: test_click.py TestClick.test_input_file1500227611845 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611846 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:53:31 INFO - 1500227611847 Marionette TRACE 384 <- [1,6,null,{}]
10:53:31 INFO - 1500227611849 Marionette DEBUG Closed connection 384
10:53:31 INFO - 1500227611850 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49793
10:53:31 INFO - 1500227611851 Marionette DEBUG Closed connection 385
10:53:31 INFO - 1500227611851 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49794
10:53:31 INFO - 1500227611852 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611853 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611856 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611859 Marionette TRACE 386 <- [1,1,null,{"sessionId":"dc3798a7-49b1-4ad4-b867-fb98994f571f","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611861 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:53:31 INFO - 1500227611862 Marionette TRACE 386 <- [1,2,null,{}]
10:53:31 INFO - 1500227611865 Marionette DEBUG Closed connection 386
10:53:31 INFO - 1500227611865 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49795
10:53:31 INFO - 1500227611866 Marionette DEBUG Closed connection 387
10:53:31 INFO - 1500227611867 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49796
10:53:31 INFO - 1500227611868 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:31 INFO - 1500227611875 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611878 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611882 Marionette TRACE 388 <- [1,1,null,{"sessionId":"f5183365-9109-42ac-a5cb-abca752d670e","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611884 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:53:31 INFO - 1500227611885 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611888 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611888 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:53:31 INFO - 1500227611912 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:53:31 INFO - 1500227611914 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:53:31 INFO - 1500227611918 Marionette TRACE 388 <- [1,2,null,{}]
10:53:31 INFO - 1500227611919 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:53:31 INFO - 1500227611921 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"eb1b6553-8c34-47e9-949d-b28dd0370739","ELEMENT":"eb1b6553-8c34-47e9-949d-b28dd0370739"}}]
10:53:31 INFO - 1500227611922 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"eb1b6553-8c34-47e9-949d-b28dd0370739"}]
10:53:31 INFO - 1500227611956 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]
10:53:31 INFO - 1500227611959 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:53:31 INFO - TEST-END: test_click.py TestClick.test_input_file1500227611961 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611962 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:53:31 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 139ms
10:53:31 INFO - 1500227611964 Marionette TRACE 388 <- [1,6,null,{}]
10:53:31 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:53:31 INFO - 1500227611966 Marionette DEBUG Closed connection 388
10:53:31 INFO - 1500227611967 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49797
10:53:31 INFO - 1500227611968 Marionette DEBUG Closed connection 389
10:53:31 INFO - 1500227611969 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49798
10:53:31 INFO - 1500227611970 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611970 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611973 Marionette DEBUG Register listener.js for window 15
10:53:31 INFO - 1500227611976 Marionette TRACE 390 <- [1,1,null,{"sessionId":"3aa81fac-5347-4b4e-a291-59cc4b22767e","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:31 INFO - 1500227611978 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:53:31 INFO - 1500227611979 Marionette TRACE 390 <- [1,2,null,{}]
10:53:31 INFO - 1500227611979 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:31 INFO - 1500227611980 Marionette TRACE 390 <- [1,3,null,{}]
10:53:31 INFO - 1500227611981 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:31 INFO - 1500227611981 Marionette TRACE 390 <- [1,4,null,{}]
10:53:31 INFO - 1500227611983 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:53:31 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500227611985 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:53:31 INFO - 1500227611986 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:53:31 INFO - 1500227611988 Marionette TRACE 390 <- [1,6,null,{}]
10:53:31 INFO - 1500227611990 Marionette DEBUG Closed connection 390
10:53:31 INFO - 1500227611991 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49799
10:53:31 INFO - 1500227611991 Marionette DEBUG Closed connection 391
10:53:31 INFO - 1500227611992 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49800
10:53:31 INFO - 1500227611993 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:31 INFO - 1500227611993 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:31 INFO - 1500227611996 Marionette DEBUG Register listener.js for window 15
10:53:32 INFO - 1500227611999 Marionette TRACE 392 <- [1,1,null,{"sessionId":"5f913b86-b2ed-48d7-aabf-4f8a405e442a","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:32 INFO - 1500227612001 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:53:32 INFO - 1500227612002 Marionette TRACE 392 <- [1,2,null,{}]
10:53:32 INFO - 1500227612005 Marionette DEBUG Closed connection 392
10:53:32 INFO - 1500227612006 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49801
10:53:32 INFO - 1500227612006 Marionette DEBUG Closed connection 393
10:53:32 INFO - 1500227612007 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49802
10:53:32 INFO - 1500227612008 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:32 INFO - 1500227612009 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:32 INFO - 1500227612011 Marionette DEBUG Register listener.js for window 15
10:53:32 INFO - 1500227612014 Marionette TRACE 394 <- [1,1,null,{"sessionId":"5baae1b8-ccec-4e8e-9046-78cf44c44d99","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:32 INFO - 1500227612016 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:53:32 INFO - 1500227612018 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:53:32 INFO - 1500227612020 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:53:32 INFO - 1500227612020 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:53:32 INFO - 1500227612038 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:53:32 INFO - 1500227612041 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:53:32 INFO - 1500227612049 Marionette TRACE 394 <- [1,2,null,{}]
10:53:32 INFO - 1500227612050 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:53:32 INFO - 1500227612053 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"77f61915-12a3-46a1-91af-087d561403af","ELEMENT":"77f61915-12a3-46a1-91af-087d561403af"}}]
10:53:32 INFO - 1500227612054 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:53:32 INFO - 1500227612056 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bac43e26-535c-479a-8600-08b4633643ff","ELEMENT":"bac43e26-535c-479a-8600-08b4633643ff"}}]
10:53:32 INFO - 1500227612057 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"77f61915-12a3-46a1-91af-087d561403af"}]
10:53:32 INFO - 1500227612324 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:53:32 INFO - 1500227612325 Marionette TRACE 394 <- [1,5,null,{}]
10:53:32 INFO - 1500227612327 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"bac43e26-535c-479a-8600-08b4633643ff"}]
10:53:32 INFO - 1500227612347 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]
10:53:32 INFO - 1500227612349 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:53:32 INFO - 1500227612354 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:53:32 INFO - 1500227612356 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:53:32 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500227612361 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:53:32 INFO - 1500227612362 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:53:32 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 401ms
10:53:32 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:53:32 INFO - 1500227612365 Marionette TRACE 394 <- [1,9,null,{}]
10:53:32 INFO - 1500227612369 Marionette DEBUG Closed connection 394
10:53:32 INFO - 1500227612370 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49803
10:53:32 INFO - 1500227612372 Marionette DEBUG Closed connection 395
10:53:32 INFO - 1500227612373 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49804
10:53:32 INFO - 1500227612375 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:32 INFO - 1500227612378 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:32 INFO - 1500227612381 Marionette DEBUG Register listener.js for window 15
10:53:32 INFO - 1500227612388 Marionette TRACE 396 <- [1,1,null,{"sessionId":"e78106ef-8957-4d3f-aea9-417b276f6f88","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:32 INFO - 1500227612392 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:53:32 INFO - 1500227612393 Marionette TRACE 396 <- [1,2,null,{}]
10:53:32 INFO - 1500227612394 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:53:32 INFO - 1500227612395 Marionette TRACE 396 <- [1,3,null,{}]
10:53:32 INFO - 1500227612396 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:53:32 INFO - 1500227612397 Marionette TRACE 396 <- [1,4,null,{}]
10:53:32 INFO - 1500227612399 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:53:32 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500227612403 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:53:32 INFO - 1500227612404 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:53:32 INFO - 1500227612407 Marionette TRACE 396 <- [1,6,null,{}]
10:53:32 INFO - 1500227612410 Marionette DEBUG Closed connection 396
10:53:32 INFO - 1500227612411 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49805
10:53:32 INFO - 1500227612447 Marionette DEBUG Closed connection 397
10:53:32 INFO - 1500227612447 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49806
10:53:32 INFO - 1500227612454 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:53:32 INFO - 1500227612456 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:32 INFO - 1500227612459 Marionette DEBUG Register listener.js for window 15
10:53:32 INFO - 1500227612465 Marionette TRACE 398 <- [1,1,null,{"sessionId":"d3cc9ac3-709f-4778-9a80-4d2bedcf588a","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:32 INFO - 1500227612468 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:53:32 INFO - 1500227612470 Marionette TRACE 398 <- [1,2,null,{}]
10:53:32 INFO - 1500227612473 Marionette DEBUG Closed connection 398
10:53:32 INFO - 1500227612474 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49807
10:53:32 INFO - 1500227612475 Marionette DEBUG Closed connection 399
10:53:32 INFO - 1500227612476 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49808
10:53:32 INFO - 1500227612477 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:53:32 INFO - 1500227612478 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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}
10:53:32 INFO - 1500227612481 Marionette DEBUG Register listener.js for window 15
10:53:32 INFO - 1500227612485 Marionette TRACE 400 <- [1,1,null,{"sessionId":"3295e622-d3f3-48d2-92a2-be35c7ab16f6","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":2384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-214.001\\AppData\\Local\\Temp\\tmpw5lxez.mozrunner","moz:accessibilityChecks":false}}]
10:53:32 INFO - 1500227612488 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:53:32 INFO - 1500227612490 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:53:32 INFO - 1500227612495 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:53:32 INFO - 1500227612495 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:53:32 INFO - 1500227612519 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:53:32 INFO - 1500227612522 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:53:32 INFO - 1500227612526 Marionette TRACE 400 <- [1,2,null,{}]
10:53:32 INFO - 1500227612539 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:53:32 INFO - 1500227612543 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"497e53c8-2099-4d37-a6aa-65860e5c3af0","ELEMENT":"497e53c8-2099-4d37-a6aa-65860e5c3af0"}}]
10:53:32 INFO - 1500227612544 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"497e53c8-2099-4d37-a6aa-65860e5c3af0"}]
10:53:32 INFO - 1500227612570 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:53:32 INFO - 1500227612571 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"497e53c8-2099-4d37-a6aa-65860e5c3af0"}]
10:53:32 INFO - 1500227612593 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element