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]
09:55:10 INFO - 1500310510253 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}]
09:55:10 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500310510256 Marionette TRACE 352 <- [1,5,null,{"value":null}]
09:55:10 INFO - 1500310510257 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
09:55:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 125ms
09:55:10 INFO - 1500310510258 Marionette TRACE 352 <- [1,6,null,{}]
09:55:10 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
09:55:10 INFO - 1500310510260 Marionette DEBUG Closed connection 352
09:55:10 INFO - 1500310510262 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49757
09:55:10 INFO - 1500310510263 Marionette DEBUG Closed connection 353
09:55:10 INFO - 1500310510264 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49758
09:55:10 INFO - 1500310510264 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510265 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510267 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510269 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d9883ce5-6635-4fba-9c75-df8ce50c0f85","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510271 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
09:55:10 INFO - 1500310510272 Marionette TRACE 354 <- [1,2,null,{}]
09:55:10 INFO - 1500310510273 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:10 INFO - 1500310510273 Marionette TRACE 354 <- [1,3,null,{}]
09:55:10 INFO - 1500310510274 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:10 INFO - 1500310510274 Marionette TRACE 354 <- [1,4,null,{}]
09:55:10 INFO - 1500310510276 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}]
09:55:10 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500310510278 Marionette TRACE 354 <- [1,5,null,{"value":null}]
09:55:10 INFO - 1500310510279 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
09:55:10 INFO - 1500310510280 Marionette TRACE 354 <- [1,6,null,{}]
09:55:10 INFO - 1500310510282 Marionette DEBUG Closed connection 354
09:55:10 INFO - 1500310510282 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49759
09:55:10 INFO - 1500310510283 Marionette DEBUG Closed connection 355
09:55:10 INFO - 1500310510283 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49760
09:55:10 INFO - 1500310510284 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510285 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510287 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510289 Marionette TRACE 356 <- [1,1,null,{"sessionId":"ebe49ddf-8c06-4ab6-aa85-5d6117819ccd","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510291 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
09:55:10 INFO - 1500310510292 Marionette TRACE 356 <- [1,2,null,{}]
09:55:10 INFO - 1500310510294 Marionette DEBUG Closed connection 356
09:55:10 INFO - 1500310510294 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49761
09:55:10 INFO - 1500310510295 Marionette DEBUG Closed connection 357
09:55:10 INFO - 1500310510295 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49762
09:55:10 INFO - 1500310510296 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:10 INFO - 1500310510297 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510299 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510301 Marionette TRACE 358 <- [1,1,null,{"sessionId":"9a1b5a76-c5f0-4c72-9346-274cfa07d417","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510303 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49324/clicks.html"}]
09:55:10 INFO - 1500310510304 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/hidden.html"
09:55:10 INFO - 1500310510309 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/hidden.html"
09:55:10 INFO - 1500310510309 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/hidden.html"
09:55:10 INFO - 1500310510319 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/clicks.html"
09:55:10 INFO - 1500310510324 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/clicks.html"
09:55:10 INFO - 1500310510332 Marionette TRACE 358 <- [1,2,null,{}]
09:55:10 INFO - 1500310510333 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:55:10 INFO - 1500310510335 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dd01496e-52bb-40fc-86ee-961585a41644","ELEMENT":"dd01496e-52bb-40fc-86ee-961585a41644"}}]
09:55:10 INFO - 1500310510336 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"dd01496e-52bb-40fc-86ee-961585a41644"}]
09:55:10 INFO - 1500310510382 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/clicks.html"
09:55:10 INFO - 1500310510386 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/clicks.html"
09:55:10 INFO - 1500310510387 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/clicks.html"
09:55:10 INFO - 1500310510402 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/test.html"
09:55:10 INFO - 1500310510405 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/test.html"
09:55:10 INFO - 1500310510413 Marionette TRACE 358 <- [1,4,null,{}]
09:55:10 INFO - 1500310510416 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:55:10 INFO - 1500310510418 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"242de66c-6fb5-49ad-bb06-d0d9fff47ae6","ELEMENT":"242de66c-6fb5-49ad-bb06-d0d9fff47ae6"}}]
09:55:10 INFO - 1500310510419 Marionette TRACE 358 -> [0,6,"getTitle",{}]
09:55:10 INFO - 1500310510419 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
09:55:10 INFO - 1500310510421 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}]
09:55:10 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500310510424 Marionette TRACE 358 <- [1,7,null,{"value":null}]
09:55:10 INFO - 1500310510425 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
09:55:10 INFO - 1500310510426 Marionette TRACE 358 <- [1,8,null,{}]
09:55:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 166ms
09:55:10 INFO - TEST-START | test_click.py TestClick.test_container_element
09:55:10 INFO - 1500310510437 Marionette DEBUG Closed connection 358
09:55:10 INFO - 1500310510438 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49765
09:55:10 INFO - 1500310510440 Marionette DEBUG Closed connection 359
09:55:10 INFO - 1500310510440 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49766
09:55:10 INFO - 1500310510441 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510442 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510444 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510446 Marionette TRACE 360 <- [1,1,null,{"sessionId":"6101e934-58cc-4681-a28c-87c7c2f17163","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510452 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
09:55:10 INFO - 1500310510452 Marionette TRACE 360 <- [1,2,null,{}]
09:55:10 INFO - 1500310510453 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:10 INFO - 1500310510453 Marionette TRACE 360 <- [1,3,null,{}]
09:55:10 INFO - 1500310510454 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:10 INFO - 1500310510454 Marionette TRACE 360 <- [1,4,null,{}]
09:55:10 INFO - 1500310510461 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}]
09:55:10 INFO - TEST-START: test_click.py TestClick.test_container_element1500310510463 Marionette TRACE 360 <- [1,5,null,{"value":null}]
09:55:10 INFO - 1500310510466 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
09:55:10 INFO - 1500310510467 Marionette TRACE 360 <- [1,6,null,{}]
09:55:10 INFO - 1500310510469 Marionette DEBUG Closed connection 360
09:55:10 INFO - 1500310510470 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49767
09:55:10 INFO - 1500310510472 Marionette DEBUG Closed connection 361
09:55:10 INFO - 1500310510472 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49768
09:55:10 INFO - 1500310510473 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510473 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510476 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510478 Marionette TRACE 362 <- [1,1,null,{"sessionId":"b6f5173e-4b38-45b5-8966-18d8b11b7a95","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510480 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
09:55:10 INFO - 1500310510481 Marionette TRACE 362 <- [1,2,null,{}]
09:55:10 INFO - 1500310510483 Marionette DEBUG Closed connection 362
09:55:10 INFO - 1500310510484 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49769
09:55:10 INFO - 1500310510484 Marionette DEBUG Closed connection 363
09:55:10 INFO - 1500310510485 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49770
09:55:10 INFO - 1500310510486 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:10 INFO - 1500310510486 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510488 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510492 Marionette TRACE 364 <- [1,1,null,{"sessionId":"6572d182-0562-4c37-b62a-6813d635e6f4","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510494 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"}]
09:55:10 INFO - 1500310510495 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/test.html"
09:55:10 INFO - 1500310510497 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/test.html"
09:55:10 INFO - 1500310510497 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/test.html"
09:55:10 INFO - 1500310510517 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"
09:55:10 INFO - 1500310510520 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"
09:55:10 INFO - 1500310510523 Marionette TRACE 364 <- [1,2,null,{}]
09:55:10 INFO - 1500310510529 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:55:10 INFO - 1500310510531 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a53c69d3-6890-43ab-b455-61cb74977237","ELEMENT":"a53c69d3-6890-43ab-b455-61cb74977237"}}]
09:55:10 INFO - 1500310510532 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"a53c69d3-6890-43ab-b455-61cb74977237"}]
09:55:10 INFO - 1500310510769 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:55:10 INFO - 1500310510769 Marionette TRACE 364 <- [1,4,null,{}]
09:55:10 INFO - 1500310510770 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"a53c69d3-6890-43ab-b455-61cb74977237","name":"selected"}]
09:55:10 INFO - 1500310510774 Marionette TRACE 364 <- [1,5,null,{"value":true}]
09:55:10 INFO - 1500310510776 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}]
09:55:10 INFO - TEST-END: test_click.py TestClick.test_container_element1500310510778 Marionette TRACE 364 <- [1,6,null,{"value":null}]
09:55:10 INFO - 1500310510779 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
09:55:10 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 352ms
09:55:10 INFO - 1500310510780 Marionette TRACE 364 <- [1,7,null,{}]
09:55:10 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:55:10 INFO - 1500310510782 Marionette DEBUG Closed connection 364
09:55:10 INFO - 1500310510783 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49771
09:55:10 INFO - 1500310510784 Marionette DEBUG Closed connection 365
09:55:10 INFO - 1500310510785 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49772
09:55:10 INFO - 1500310510785 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510786 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510788 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510790 Marionette TRACE 366 <- [1,1,null,{"sessionId":"4dd64bca-ed15-401f-9689-d857254a0dbf","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510792 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
09:55:10 INFO - 1500310510793 Marionette TRACE 366 <- [1,2,null,{}]
09:55:10 INFO - 1500310510793 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:10 INFO - 1500310510794 Marionette TRACE 366 <- [1,3,null,{}]
09:55:10 INFO - 1500310510794 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:10 INFO - 1500310510796 Marionette TRACE 366 <- [1,4,null,{}]
09:55:10 INFO - 1500310510797 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}]
09:55:10 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500310510799 Marionette TRACE 366 <- [1,5,null,{"value":null}]
09:55:10 INFO - 1500310510800 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
09:55:10 INFO - 1500310510801 Marionette TRACE 366 <- [1,6,null,{}]
09:55:10 INFO - 1500310510803 Marionette DEBUG Closed connection 366
09:55:10 INFO - 1500310510803 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49773
09:55:10 INFO - 1500310510804 Marionette DEBUG Closed connection 367
09:55:10 INFO - 1500310510805 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49774
09:55:10 INFO - 1500310510805 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:10 INFO - 1500310510806 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510808 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510811 Marionette TRACE 368 <- [1,1,null,{"sessionId":"020b22ec-da95-44e8-97ed-15c568872193","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510813 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
09:55:10 INFO - 1500310510814 Marionette TRACE 368 <- [1,2,null,{}]
09:55:10 INFO - 1500310510815 Marionette DEBUG Closed connection 368
09:55:10 INFO - 1500310510816 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49775
09:55:10 INFO - 1500310510816 Marionette DEBUG Closed connection 369
09:55:10 INFO - 1500310510817 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49776
09:55:10 INFO - 1500310510818 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:10 INFO - 1500310510819 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:10 INFO - 1500310510821 Marionette DEBUG Register listener.js for window 15
09:55:10 INFO - 1500310510824 Marionette TRACE 370 <- [1,1,null,{"sessionId":"b9b6370a-bf3b-4448-beed-da3a15182125","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:10 INFO - 1500310510826 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"}]
09:55:10 INFO - 1500310510827 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"
09:55:10 INFO - 1500310510829 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"
09:55:10 INFO - 1500310510829 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"
09:55:10 INFO - 1500310510844 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"
09:55:10 INFO - 1500310510846 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"
09:55:10 INFO - 1500310510848 Marionette TRACE 370 <- [1,2,null,{}]
09:55:10 INFO - 1500310510849 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:55:10 INFO - 1500310510851 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d0411a22-37a5-435c-b310-3bac9748b7b4","ELEMENT":"d0411a22-37a5-435c-b310-3bac9748b7b4"}}]
09:55:10 INFO - 1500310510852 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"d0411a22-37a5-435c-b310-3bac9748b7b4"}]
09:55:11 INFO - 1500310511104 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:55:11 INFO - 1500310511105 Marionette TRACE 370 <- [1,4,null,{}]
09:55:11 INFO - 1500310511106 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"d0411a22-37a5-435c-b310-3bac9748b7b4","name":"selected"}]
09:55:11 INFO - 1500310511110 Marionette TRACE 370 <- [1,5,null,{"value":true}]
09:55:11 INFO - 1500310511111 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}]
09:55:11 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500310511113 Marionette TRACE 370 <- [1,6,null,{"value":null}]
09:55:11 INFO - 1500310511114 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
09:55:11 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 335ms
09:55:11 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:55:11 INFO - 1500310511115 Marionette TRACE 370 <- [1,7,null,{}]
09:55:11 INFO - 1500310511117 Marionette DEBUG Closed connection 370
09:55:11 INFO - 1500310511118 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49777
09:55:11 INFO - 1500310511119 Marionette DEBUG Closed connection 371
09:55:11 INFO - 1500310511120 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49778
09:55:11 INFO - 1500310511120 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511121 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511123 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511126 Marionette TRACE 372 <- [1,1,null,{"sessionId":"01513adf-9fbc-4300-9275-3e1d34a2852c","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511127 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
09:55:11 INFO - 1500310511128 Marionette TRACE 372 <- [1,2,null,{}]
09:55:11 INFO - 1500310511129 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:11 INFO - 1500310511129 Marionette TRACE 372 <- [1,3,null,{}]
09:55:11 INFO - 1500310511130 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:11 INFO - 1500310511130 Marionette TRACE 372 <- [1,4,null,{}]
09:55:11 INFO - 1500310511132 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}]
09:55:11 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500310511134 Marionette TRACE 372 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511135 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
09:55:11 INFO - 1500310511136 Marionette TRACE 372 <- [1,6,null,{}]
09:55:11 INFO - 1500310511138 Marionette DEBUG Closed connection 372
09:55:11 INFO - 1500310511138 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49779
09:55:11 INFO - 1500310511139 Marionette DEBUG Closed connection 373
09:55:11 INFO - 1500310511140 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49780
09:55:11 INFO - 1500310511141 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511141 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511143 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511145 Marionette TRACE 374 <- [1,1,null,{"sessionId":"bb8f6663-f74a-46cf-9bda-3819a39f89ef","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511147 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
09:55:11 INFO - 1500310511148 Marionette TRACE 374 <- [1,2,null,{}]
09:55:11 INFO - 1500310511149 Marionette DEBUG Closed connection 374
09:55:11 INFO - 1500310511150 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49781
09:55:11 INFO - 1500310511151 Marionette DEBUG Closed connection 375
09:55:11 INFO - 1500310511151 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49782
09:55:11 INFO - 1500310511152 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:11 INFO - 1500310511153 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511154 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511157 Marionette TRACE 376 <- [1,1,null,{"sessionId":"f19ea2d0-60ca-43f6-a9eb-56f6f4b0fd75","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511158 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"}]
09:55:11 INFO - 1500310511159 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"
09:55:11 INFO - 1500310511161 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"
09:55:11 INFO - 1500310511162 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"
09:55:11 INFO - 1500310511177 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"
09:55:11 INFO - 1500310511179 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"
09:55:11 INFO - 1500310511182 Marionette TRACE 376 <- [1,2,null,{}]
09:55:11 INFO - 1500310511183 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:55:11 INFO - 1500310511185 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b3fc7462-4a2f-431c-93be-7b035f592188","ELEMENT":"b3fc7462-4a2f-431c-93be-7b035f592188"}}]
09:55:11 INFO - 1500310511185 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"b3fc7462-4a2f-431c-93be-7b035f592188"}]
09:55:11 INFO - 1500310511434 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:55:11 INFO - 1500310511435 Marionette TRACE 376 <- [1,4,null,{}]
09:55:11 INFO - 1500310511437 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}]
09:55:11 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500310511439 Marionette TRACE 376 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511440 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
09:55:11 INFO - 1500310511441 Marionette TRACE 376 <- [1,6,null,{}]
09:55:11 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 326ms
09:55:11 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:55:11 INFO - 1500310511443 Marionette DEBUG Closed connection 376
09:55:11 INFO - 1500310511444 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49783
09:55:11 INFO - 1500310511445 Marionette DEBUG Closed connection 377
09:55:11 INFO - 1500310511446 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49784
09:55:11 INFO - 1500310511447 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511447 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511449 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511452 Marionette TRACE 378 <- [1,1,null,{"sessionId":"7f0a2c58-63b7-4be6-8d0d-08860470185f","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511454 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
09:55:11 INFO - 1500310511454 Marionette TRACE 378 <- [1,2,null,{}]
09:55:11 INFO - 1500310511455 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:11 INFO - 1500310511455 Marionette TRACE 378 <- [1,3,null,{}]
09:55:11 INFO - 1500310511455 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:11 INFO - 1500310511456 Marionette TRACE 378 <- [1,4,null,{}]
09:55:11 INFO - 1500310511457 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}]
09:55:11 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500310511459 Marionette TRACE 378 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511460 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
09:55:11 INFO - 1500310511461 Marionette TRACE 378 <- [1,6,null,{}]
09:55:11 INFO - 1500310511463 Marionette DEBUG Closed connection 378
09:55:11 INFO - 1500310511463 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49785
09:55:11 INFO - 1500310511464 Marionette DEBUG Closed connection 379
09:55:11 INFO - 1500310511464 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49786
09:55:11 INFO - 1500310511465 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511465 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511467 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511470 Marionette TRACE 380 <- [1,1,null,{"sessionId":"e0bcf7e6-2895-4271-9aed-6d533e47e893","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511471 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
09:55:11 INFO - 1500310511473 Marionette TRACE 380 <- [1,2,null,{}]
09:55:11 INFO - 1500310511474 Marionette DEBUG Closed connection 380
09:55:11 INFO - 1500310511475 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49787
09:55:11 INFO - 1500310511475 Marionette DEBUG Closed connection 381
09:55:11 INFO - 1500310511476 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49788
09:55:11 INFO - 1500310511477 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:11 INFO - 1500310511477 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511479 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511482 Marionette TRACE 382 <- [1,1,null,{"sessionId":"391934f2-890c-47a2-b8b2-cb29c6b910ca","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511483 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"}]
09:55:11 INFO - 1500310511485 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"
09:55:11 INFO - 1500310511486 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"
09:55:11 INFO - 1500310511487 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"
09:55:11 INFO - 1500310511496 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"
09:55:11 INFO - 1500310511499 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"
09:55:11 INFO - 1500310511501 Marionette TRACE 382 <- [1,2,null,{}]
09:55:11 INFO - 1500310511502 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:55:11 INFO - 1500310511512 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c2738237-2afb-45ec-8f2c-067282096931","ELEMENT":"c2738237-2afb-45ec-8f2c-067282096931"}}]
09:55:11 INFO - 1500310511513 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"c2738237-2afb-45ec-8f2c-067282096931"}]
09:55:11 INFO - 1500310511752 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:55:11 INFO - 1500310511752 Marionette TRACE 382 <- [1,4,null,{}]
09:55:11 INFO - 1500310511754 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}]
09:55:11 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500310511756 Marionette TRACE 382 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511757 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
09:55:11 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 315ms
09:55:11 INFO - TEST-START | test_click.py TestClick.test_input_file
09:55:11 INFO - 1500310511758 Marionette TRACE 382 <- [1,6,null,{}]
09:55:11 INFO - 1500310511760 Marionette DEBUG Closed connection 382
09:55:11 INFO - 1500310511761 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49789
09:55:11 INFO - 1500310511762 Marionette DEBUG Closed connection 383
09:55:11 INFO - 1500310511763 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49790
09:55:11 INFO - 1500310511763 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511764 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511766 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511769 Marionette TRACE 384 <- [1,1,null,{"sessionId":"76ed081e-0ad9-423a-b2f7-5c0affcb8897","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511770 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
09:55:11 INFO - 1500310511771 Marionette TRACE 384 <- [1,2,null,{}]
09:55:11 INFO - 1500310511772 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:11 INFO - 1500310511772 Marionette TRACE 384 <- [1,3,null,{}]
09:55:11 INFO - 1500310511773 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:11 INFO - 1500310511773 Marionette TRACE 384 <- [1,4,null,{}]
09:55:11 INFO - 1500310511774 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}]
09:55:11 INFO - TEST-START: test_click.py TestClick.test_input_file1500310511777 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511777 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:55:11 INFO - 1500310511778 Marionette TRACE 384 <- [1,6,null,{}]
09:55:11 INFO - 1500310511780 Marionette DEBUG Closed connection 384
09:55:11 INFO - 1500310511781 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49791
09:55:11 INFO - 1500310511781 Marionette DEBUG Closed connection 385
09:55:11 INFO - 1500310511782 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49792
09:55:11 INFO - 1500310511783 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511783 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511785 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511787 Marionette TRACE 386 <- [1,1,null,{"sessionId":"a7cee2c7-e320-4f92-a599-ef1a2404f8fb","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511789 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
09:55:11 INFO - 1500310511790 Marionette TRACE 386 <- [1,2,null,{}]
09:55:11 INFO - 1500310511792 Marionette DEBUG Closed connection 386
09:55:11 INFO - 1500310511792 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49793
09:55:11 INFO - 1500310511793 Marionette DEBUG Closed connection 387
09:55:11 INFO - 1500310511793 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49794
09:55:11 INFO - 1500310511794 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:11 INFO - 1500310511795 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511797 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511799 Marionette TRACE 388 <- [1,1,null,{"sessionId":"765387ea-49fe-4203-a4f9-fc16032f08f5","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511801 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:55:11 INFO - 1500310511802 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"
09:55:11 INFO - 1500310511804 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"
09:55:11 INFO - 1500310511804 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"
09:55:11 INFO - 1500310511813 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:55:11 INFO - 1500310511816 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:55:11 INFO - 1500310511819 Marionette TRACE 388 <- [1,2,null,{}]
09:55:11 INFO - 1500310511826 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:55:11 INFO - 1500310511829 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a197defc-0114-4260-b952-7476094b7635","ELEMENT":"a197defc-0114-4260-b952-7476094b7635"}}]
09:55:11 INFO - 1500310511830 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"a197defc-0114-4260-b952-7476094b7635"}]
09:55:11 INFO - 1500310511861 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]
09:55:11 INFO - 1500310511864 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}]
09:55:11 INFO - TEST-END: test_click.py TestClick.test_input_file1500310511866 Marionette TRACE 388 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511867 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
09:55:11 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 111ms
09:55:11 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:55:11 INFO - 1500310511868 Marionette TRACE 388 <- [1,6,null,{}]
09:55:11 INFO - 1500310511884 Marionette DEBUG Closed connection 388
09:55:11 INFO - 1500310511885 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49795
09:55:11 INFO - 1500310511886 Marionette DEBUG Closed connection 389
09:55:11 INFO - 1500310511887 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49796
09:55:11 INFO - 1500310511888 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511888 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511890 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511893 Marionette TRACE 390 <- [1,1,null,{"sessionId":"4cac584d-8803-4b04-91fe-22cf39ba7712","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511894 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
09:55:11 INFO - 1500310511895 Marionette TRACE 390 <- [1,2,null,{}]
09:55:11 INFO - 1500310511895 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:11 INFO - 1500310511896 Marionette TRACE 390 <- [1,3,null,{}]
09:55:11 INFO - 1500310511897 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:11 INFO - 1500310511897 Marionette TRACE 390 <- [1,4,null,{}]
09:55:11 INFO - 1500310511898 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}]
09:55:11 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500310511900 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:55:11 INFO - 1500310511901 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:55:11 INFO - 1500310511902 Marionette TRACE 390 <- [1,6,null,{}]
09:55:11 INFO - 1500310511904 Marionette DEBUG Closed connection 390
09:55:11 INFO - 1500310511905 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49797
09:55:11 INFO - 1500310511905 Marionette DEBUG Closed connection 391
09:55:11 INFO - 1500310511906 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49798
09:55:11 INFO - 1500310511907 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:11 INFO - 1500310511907 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511909 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511912 Marionette TRACE 392 <- [1,1,null,{"sessionId":"87f0360f-d5ac-475c-8406-c9ab272a2a63","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511913 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
09:55:11 INFO - 1500310511914 Marionette TRACE 392 <- [1,2,null,{}]
09:55:11 INFO - 1500310511916 Marionette DEBUG Closed connection 392
09:55:11 INFO - 1500310511917 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49799
09:55:11 INFO - 1500310511917 Marionette DEBUG Closed connection 393
09:55:11 INFO - 1500310511918 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49800
09:55:11 INFO - 1500310511919 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:11 INFO - 1500310511919 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:11 INFO - 1500310511921 Marionette DEBUG Register listener.js for window 15
09:55:11 INFO - 1500310511924 Marionette TRACE 394 <- [1,1,null,{"sessionId":"bdab1d2d-55df-427e-a89d-5e70e5e44ada","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:11 INFO - 1500310511925 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"}]
09:55:11 INFO - 1500310511926 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:55:11 INFO - 1500310511928 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:55:11 INFO - 1500310511929 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:55:11 INFO - 1500310511945 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"
09:55:11 INFO - 1500310511947 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"
09:55:11 INFO - 1500310511949 Marionette TRACE 394 <- [1,2,null,{}]
09:55:11 INFO - 1500310511950 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:55:11 INFO - 1500310511960 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f1fe7b43-52db-44a7-b231-8f6af5c02506","ELEMENT":"f1fe7b43-52db-44a7-b231-8f6af5c02506"}}]
09:55:11 INFO - 1500310511961 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:55:11 INFO - 1500310511963 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a3f82058-caaf-411b-8e77-de6f8f1a6a8c","ELEMENT":"a3f82058-caaf-411b-8e77-de6f8f1a6a8c"}}]
09:55:11 INFO - 1500310511966 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"f1fe7b43-52db-44a7-b231-8f6af5c02506"}]
09:55:12 INFO - 1500310512200 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:55:12 INFO - 1500310512201 Marionette TRACE 394 <- [1,5,null,{}]
09:55:12 INFO - 1500310512202 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"a3f82058-caaf-411b-8e77-de6f8f1a6a8c"}]
09:55:12 INFO - 1500310512215 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]
09:55:12 INFO - 1500310512216 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:55:12 INFO - 1500310512219 Marionette TRACE 394 <- [1,7,null,{"value":false}]
09:55:12 INFO - 1500310512220 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}]
09:55:12 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500310512222 Marionette TRACE 394 <- [1,8,null,{"value":null}]
09:55:12 INFO - 1500310512223 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
09:55:12 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 356ms
09:55:12 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:55:12 INFO - 1500310512224 Marionette TRACE 394 <- [1,9,null,{}]
09:55:12 INFO - 1500310512226 Marionette DEBUG Closed connection 394
09:55:12 INFO - 1500310512227 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49801
09:55:12 INFO - 1500310512227 Marionette DEBUG Closed connection 395
09:55:12 INFO - 1500310512228 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49802
09:55:12 INFO - 1500310512229 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:12 INFO - 1500310512229 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:12 INFO - 1500310512231 Marionette DEBUG Register listener.js for window 15
09:55:12 INFO - 1500310512240 Marionette TRACE 396 <- [1,1,null,{"sessionId":"e57c2108-5197-42f6-a749-01295eeabbe8","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:12 INFO - 1500310512242 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
09:55:12 INFO - 1500310512242 Marionette TRACE 396 <- [1,2,null,{}]
09:55:12 INFO - 1500310512243 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:55:12 INFO - 1500310512243 Marionette TRACE 396 <- [1,3,null,{}]
09:55:12 INFO - 1500310512244 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
09:55:12 INFO - 1500310512244 Marionette TRACE 396 <- [1,4,null,{}]
09:55:12 INFO - 1500310512245 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}]
09:55:12 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500310512247 Marionette TRACE 396 <- [1,5,null,{"value":null}]
09:55:12 INFO - 1500310512248 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
09:55:12 INFO - 1500310512249 Marionette TRACE 396 <- [1,6,null,{}]
09:55:12 INFO - 1500310512251 Marionette DEBUG Closed connection 396
09:55:12 INFO - 1500310512252 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49803
09:55:12 INFO - 1500310512253 Marionette DEBUG Closed connection 397
09:55:12 INFO - 1500310512254 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49804
09:55:12 INFO - 1500310512255 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:55:12 INFO - 1500310512255 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:12 INFO - 1500310512257 Marionette DEBUG Register listener.js for window 15
09:55:12 INFO - 1500310512260 Marionette TRACE 398 <- [1,1,null,{"sessionId":"aa60be49-130a-48a1-adf2-aa6dfcb04168","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:12 INFO - 1500310512261 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
09:55:12 INFO - 1500310512263 Marionette TRACE 398 <- [1,2,null,{}]
09:55:12 INFO - 1500310512264 Marionette DEBUG Closed connection 398
09:55:12 INFO - 1500310512265 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49805
09:55:12 INFO - 1500310512265 Marionette DEBUG Closed connection 399
09:55:12 INFO - 1500310512266 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49806
09:55:12 INFO - 1500310512267 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:55:12 INFO - 1500310512267 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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}
09:55:12 INFO - 1500310512269 Marionette DEBUG Register listener.js for window 15
09:55:12 INFO - 1500310512273 Marionette TRACE 400 <- [1,1,null,{"sessionId":"2e5cd9cb-8873-498b-b849-16898d1669fb","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":1252,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-202.001\\AppData\\Local\\Temp\\tmpdd_k9l.mozrunner","moz:accessibilityChecks":false}}]
09:55:12 INFO - 1500310512275 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"}]
09:55:12 INFO - 1500310512276 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"
09:55:12 INFO - 1500310512278 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"
09:55:12 INFO - 1500310512279 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"
09:55:12 INFO - 1500310512295 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"
09:55:12 INFO - 1500310512297 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"
09:55:12 INFO - 1500310512299 Marionette TRACE 400 <- [1,2,null,{}]
09:55:12 INFO - 1500310512300 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:55:12 INFO - 1500310512307 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5d222781-d31c-4d55-bb65-1d3d2c31e329","ELEMENT":"5d222781-d31c-4d55-bb65-1d3d2c31e329"}}]
09:55:12 INFO - 1500310512308 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"5d222781-d31c-4d55-bb65-1d3d2c31e329"}]
09:55:12 INFO - 1500310512332 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
09:55:12 INFO - 1500310512333 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"5d222781-d31c-4d55-bb65-1d3d2c31e329"}]
09:55:12 INFO - 1500310512347 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element