could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
17:56:12 INFO - 1499302572310 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}]
17:56:12 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499302572314 Marionette TRACE 352 <- [1,5,null,{"value":null}]
17:56:12 INFO - 1499302572315 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
17:56:12 INFO - 1499302572316 Marionette TRACE 352 <- [1,6,null,{}]
17:56:12 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 130ms
17:56:12 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
17:56:12 INFO - 1499302572318 Marionette DEBUG Closed connection 352
17:56:12 INFO - 1499302572319 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49763
17:56:12 INFO - 1499302572320 Marionette DEBUG Closed connection 353
17:56:12 INFO - 1499302572320 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49764
17:56:12 INFO - 1499302572322 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572322 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572325 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572337 Marionette TRACE 354 <- [1,1,null,{"sessionId":"731af1a1-e4ac-485a-b17e-a0bf9c7e76a4","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572338 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
17:56:12 INFO - 1499302572338 Marionette TRACE 354 <- [1,2,null,{}]
17:56:12 INFO - 1499302572339 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:12 INFO - 1499302572340 Marionette TRACE 354 <- [1,3,null,{}]
17:56:12 INFO - 1499302572341 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:12 INFO - 1499302572341 Marionette TRACE 354 <- [1,4,null,{}]
17:56:12 INFO - 1499302572343 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}]
17:56:12 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499302572346 Marionette TRACE 354 <- [1,5,null,{"value":null}]
17:56:12 INFO - 1499302572347 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
17:56:12 INFO - 1499302572348 Marionette TRACE 354 <- [1,6,null,{}]
17:56:12 INFO - 1499302572350 Marionette DEBUG Closed connection 354
17:56:12 INFO - 1499302572351 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49765
17:56:12 INFO - 1499302572352 Marionette DEBUG Closed connection 355
17:56:12 INFO - 1499302572352 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49766
17:56:12 INFO - 1499302572354 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572354 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572357 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572361 Marionette TRACE 356 <- [1,1,null,{"sessionId":"19f83982-1898-4e19-8031-b83e4efa5769","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572362 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
17:56:12 INFO - 1499302572363 Marionette TRACE 356 <- [1,2,null,{}]
17:56:12 INFO - 1499302572365 Marionette DEBUG Closed connection 356
17:56:12 INFO - 1499302572366 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49767
17:56:12 INFO - 1499302572367 Marionette DEBUG Closed connection 357
17:56:12 INFO - 1499302572367 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49768
17:56:12 INFO - 1499302572368 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:12 INFO - 1499302572369 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572372 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572375 Marionette TRACE 358 <- [1,1,null,{"sessionId":"41c85c24-ae70-4fe6-8361-0588a3cd9f45","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572377 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49327/clicks.html"}]
17:56:12 INFO - 1499302572378 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/hidden.html"
17:56:12 INFO - 1499302572386 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/hidden.html"
17:56:12 INFO - 1499302572386 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/hidden.html"
17:56:12 INFO - 1499302572394 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/clicks.html"
17:56:12 INFO - 1499302572401 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/clicks.html"
17:56:12 INFO - 1499302572403 Marionette TRACE 358 <- [1,2,null,{}]
17:56:12 INFO - 1499302572406 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
17:56:12 INFO - 1499302572409 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a77802ff-8a1a-4e9d-b603-4858bcd1c961","ELEMENT":"a77802ff-8a1a-4e9d-b603-4858bcd1c961"}}]
17:56:12 INFO - 1499302572410 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"a77802ff-8a1a-4e9d-b603-4858bcd1c961"}]
17:56:12 INFO - 1499302572458 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/clicks.html"
17:56:12 INFO - 1499302572466 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/clicks.html"
17:56:12 INFO - 1499302572466 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/clicks.html"
17:56:12 INFO - 1499302572475 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/test.html"
17:56:12 INFO - 1499302572482 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/test.html"
17:56:12 INFO - 1499302572483 Marionette TRACE 358 <- [1,4,null,{}]
17:56:12 INFO - 1499302572487 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
17:56:12 INFO - 1499302572490 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a492dcf0-7450-4cd9-92e2-cfcfdebb84a4","ELEMENT":"a492dcf0-7450-4cd9-92e2-cfcfdebb84a4"}}]
17:56:12 INFO - 1499302572491 Marionette TRACE 358 -> [0,6,"getTitle",{}]
17:56:12 INFO - 1499302572491 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
17:56:12 INFO - 1499302572494 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}]
17:56:12 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 188ms
17:56:12 INFO - TEST-START | test_click.py TestClick.test_container_element
17:56:12 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499302572501 Marionette TRACE 358 <- [1,7,null,{"value":null}]
17:56:12 INFO - 1499302572503 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
17:56:12 INFO - 1499302572504 Marionette TRACE 358 <- [1,8,null,{}]
17:56:12 INFO - 1499302572506 Marionette DEBUG Closed connection 358
17:56:12 INFO - 1499302572507 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49771
17:56:12 INFO - 1499302572507 Marionette DEBUG Closed connection 359
17:56:12 INFO - 1499302572508 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49772
17:56:12 INFO - 1499302572509 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572510 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572513 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572517 Marionette TRACE 360 <- [1,1,null,{"sessionId":"ac2a4a33-4e9b-487f-8139-92bbea6e0ffe","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572518 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
17:56:12 INFO - 1499302572519 Marionette TRACE 360 <- [1,2,null,{}]
17:56:12 INFO - 1499302572520 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:12 INFO - 1499302572520 Marionette TRACE 360 <- [1,3,null,{}]
17:56:12 INFO - 1499302572521 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:12 INFO - 1499302572521 Marionette TRACE 360 <- [1,4,null,{}]
17:56:12 INFO - 1499302572523 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}]
17:56:12 INFO - TEST-START: test_click.py TestClick.test_container_element1499302572526 Marionette TRACE 360 <- [1,5,null,{"value":null}]
17:56:12 INFO - 1499302572527 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
17:56:12 INFO - 1499302572528 Marionette TRACE 360 <- [1,6,null,{}]
17:56:12 INFO - 1499302572530 Marionette DEBUG Closed connection 360
17:56:12 INFO - 1499302572531 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49773
17:56:12 INFO - 1499302572531 Marionette DEBUG Closed connection 361
17:56:12 INFO - 1499302572532 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49774
17:56:12 INFO - 1499302572533 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572534 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572537 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572540 Marionette TRACE 362 <- [1,1,null,{"sessionId":"8b1a1e90-d1f4-41b3-92bb-46a0de367cae","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572541 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
17:56:12 INFO - 1499302572542 Marionette TRACE 362 <- [1,2,null,{}]
17:56:12 INFO - 1499302572544 Marionette DEBUG Closed connection 362
17:56:12 INFO - 1499302572544 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49775
17:56:12 INFO - 1499302572545 Marionette DEBUG Closed connection 363
17:56:12 INFO - 1499302572546 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49776
17:56:12 INFO - 1499302572547 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:12 INFO - 1499302572547 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572550 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572553 Marionette TRACE 364 <- [1,1,null,{"sessionId":"ae4e42ce-6e15-4a52-b0ba-84c937a8af18","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572555 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"}]
17:56:12 INFO - 1499302572556 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/test.html"
17:56:12 INFO - 1499302572558 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/test.html"
17:56:12 INFO - 1499302572559 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/test.html"
17:56:12 INFO - 1499302572571 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"
17:56:12 INFO - 1499302572575 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"
17:56:12 INFO - 1499302572583 Marionette TRACE 364 <- [1,2,null,{}]
17:56:12 INFO - 1499302572587 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:56:12 INFO - 1499302572589 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9630725e-e393-49d5-821f-220333f5e0ff","ELEMENT":"9630725e-e393-49d5-821f-220333f5e0ff"}}]
17:56:12 INFO - 1499302572590 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"9630725e-e393-49d5-821f-220333f5e0ff"}]
17:56:12 INFO - 1499302572835 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:56:12 INFO - 1499302572836 Marionette TRACE 364 <- [1,4,null,{}]
17:56:12 INFO - 1499302572837 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"9630725e-e393-49d5-821f-220333f5e0ff","name":"selected"}]
17:56:12 INFO - 1499302572842 Marionette TRACE 364 <- [1,5,null,{"value":true}]
17:56:12 INFO - 1499302572844 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}]
17:56:12 INFO - TEST-END: test_click.py TestClick.test_container_element1499302572846 Marionette TRACE 364 <- [1,6,null,{"value":null}]
17:56:12 INFO - 1499302572847 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
17:56:12 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 345ms
17:56:12 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
17:56:12 INFO - 1499302572849 Marionette TRACE 364 <- [1,7,null,{}]
17:56:12 INFO - 1499302572851 Marionette DEBUG Closed connection 364
17:56:12 INFO - 1499302572851 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49777
17:56:12 INFO - 1499302572852 Marionette DEBUG Closed connection 365
17:56:12 INFO - 1499302572853 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49778
17:56:12 INFO - 1499302572854 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572855 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572857 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572861 Marionette TRACE 366 <- [1,1,null,{"sessionId":"57214399-91b6-467e-a02b-105e5e819c12","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572862 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
17:56:12 INFO - 1499302572862 Marionette TRACE 366 <- [1,2,null,{}]
17:56:12 INFO - 1499302572863 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:12 INFO - 1499302572864 Marionette TRACE 366 <- [1,3,null,{}]
17:56:12 INFO - 1499302572864 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:12 INFO - 1499302572865 Marionette TRACE 366 <- [1,4,null,{}]
17:56:12 INFO - 1499302572867 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}]
17:56:12 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499302572870 Marionette TRACE 366 <- [1,5,null,{"value":null}]
17:56:12 INFO - 1499302572871 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
17:56:12 INFO - 1499302572872 Marionette TRACE 366 <- [1,6,null,{}]
17:56:12 INFO - 1499302572874 Marionette DEBUG Closed connection 366
17:56:12 INFO - 1499302572875 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49779
17:56:12 INFO - 1499302572875 Marionette DEBUG Closed connection 367
17:56:12 INFO - 1499302572876 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49780
17:56:12 INFO - 1499302572877 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:12 INFO - 1499302572878 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572881 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572884 Marionette TRACE 368 <- [1,1,null,{"sessionId":"694b6358-7385-420d-b617-3ef6be6cb324","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572885 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
17:56:12 INFO - 1499302572887 Marionette TRACE 368 <- [1,2,null,{}]
17:56:12 INFO - 1499302572888 Marionette DEBUG Closed connection 368
17:56:12 INFO - 1499302572889 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49781
17:56:12 INFO - 1499302572890 Marionette DEBUG Closed connection 369
17:56:12 INFO - 1499302572890 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49782
17:56:12 INFO - 1499302572891 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:12 INFO - 1499302572892 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:12 INFO - 1499302572895 Marionette DEBUG Register listener.js for window 4294967297
17:56:12 INFO - 1499302572898 Marionette TRACE 370 <- [1,1,null,{"sessionId":"200e2c36-2eb7-4b5a-9d44-e915f58bb382","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:12 INFO - 1499302572899 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"}]
17:56:12 INFO - 1499302572901 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"
17:56:12 INFO - 1499302572903 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"
17:56:12 INFO - 1499302572903 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"
17:56:12 INFO - 1499302572909 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"
17:56:12 INFO - 1499302572913 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"
17:56:12 INFO - 1499302572919 Marionette TRACE 370 <- [1,2,null,{}]
17:56:12 INFO - 1499302572923 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:56:12 INFO - 1499302572926 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b0f4f3d8-402d-4bb6-9e5c-cf6014aefd46","ELEMENT":"b0f4f3d8-402d-4bb6-9e5c-cf6014aefd46"}}]
17:56:12 INFO - 1499302572927 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"b0f4f3d8-402d-4bb6-9e5c-cf6014aefd46"}]
17:56:13 INFO - 1499302573173 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:56:13 INFO - 1499302573174 Marionette TRACE 370 <- [1,4,null,{}]
17:56:13 INFO - 1499302573175 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"b0f4f3d8-402d-4bb6-9e5c-cf6014aefd46","name":"selected"}]
17:56:13 INFO - 1499302573217 Marionette TRACE 370 <- [1,5,null,{"value":true}]
17:56:13 INFO - 1499302573219 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}]
17:56:13 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499302573222 Marionette TRACE 370 <- [1,6,null,{"value":null}]
17:56:13 INFO - 1499302573223 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
17:56:13 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 374ms
17:56:13 INFO - 1499302573224 Marionette TRACE 370 <- [1,7,null,{}]
17:56:13 INFO - TEST-START | test_click.py TestClick.test_css_transforms
17:56:13 INFO - 1499302573226 Marionette DEBUG Closed connection 370
17:56:13 INFO - 1499302573227 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49783
17:56:13 INFO - 1499302573227 Marionette DEBUG Closed connection 371
17:56:13 INFO - 1499302573228 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49784
17:56:13 INFO - 1499302573229 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573229 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573232 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573236 Marionette TRACE 372 <- [1,1,null,{"sessionId":"e5a3daed-9a68-4818-bbe1-c802270ce101","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573237 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
17:56:13 INFO - 1499302573237 Marionette TRACE 372 <- [1,2,null,{}]
17:56:13 INFO - 1499302573238 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:13 INFO - 1499302573239 Marionette TRACE 372 <- [1,3,null,{}]
17:56:13 INFO - 1499302573240 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:13 INFO - 1499302573240 Marionette TRACE 372 <- [1,4,null,{}]
17:56:13 INFO - 1499302573242 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}]
17:56:13 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499302573245 Marionette TRACE 372 <- [1,5,null,{"value":null}]
17:56:13 INFO - 1499302573246 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
17:56:13 INFO - 1499302573247 Marionette TRACE 372 <- [1,6,null,{}]
17:56:13 INFO - 1499302573249 Marionette DEBUG Closed connection 372
17:56:13 INFO - 1499302573250 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49785
17:56:13 INFO - 1499302573251 Marionette DEBUG Closed connection 373
17:56:13 INFO - 1499302573251 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49786
17:56:13 INFO - 1499302573252 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573253 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573256 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573260 Marionette TRACE 374 <- [1,1,null,{"sessionId":"12590da3-c4f0-4352-a255-2643ebad916c","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573261 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
17:56:13 INFO - 1499302573263 Marionette TRACE 374 <- [1,2,null,{}]
17:56:13 INFO - 1499302573264 Marionette DEBUG Closed connection 374
17:56:13 INFO - 1499302573265 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49787
17:56:13 INFO - 1499302573266 Marionette DEBUG Closed connection 375
17:56:13 INFO - 1499302573266 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49788
17:56:13 INFO - 1499302573267 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:13 INFO - 1499302573268 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573271 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573274 Marionette TRACE 376 <- [1,1,null,{"sessionId":"12f66176-c886-4fdf-9215-cbe457eb5b45","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573275 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"}]
17:56:13 INFO - 1499302573277 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"
17:56:13 INFO - 1499302573280 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"
17:56:13 INFO - 1499302573280 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"
17:56:13 INFO - 1499302573287 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"
17:56:13 INFO - 1499302573290 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"
17:56:13 INFO - 1499302573293 Marionette TRACE 376 <- [1,2,null,{}]
17:56:13 INFO - 1499302573301 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
17:56:13 INFO - 1499302573304 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7073a2df-b443-4036-9dbd-d93af541625f","ELEMENT":"7073a2df-b443-4036-9dbd-d93af541625f"}}]
17:56:13 INFO - 1499302573305 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7073a2df-b443-4036-9dbd-d93af541625f"}]
17:56:13 INFO - 1499302573550 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:56:13 INFO - 1499302573551 Marionette TRACE 376 <- [1,4,null,{}]
17:56:13 INFO - 1499302573554 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}]
17:56:13 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499302573558 Marionette TRACE 376 <- [1,5,null,{"value":null}]
17:56:13 INFO - 1499302573560 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
17:56:13 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 339ms
17:56:13 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
17:56:13 INFO - 1499302573563 Marionette TRACE 376 <- [1,6,null,{}]
17:56:13 INFO - 1499302573569 Marionette DEBUG Closed connection 376
17:56:13 INFO - 1499302573570 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49789
17:56:13 INFO - 1499302573575 Marionette DEBUG Closed connection 377
17:56:13 INFO - 1499302573576 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49790
17:56:13 INFO - 1499302573578 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573582 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573585 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573591 Marionette TRACE 378 <- [1,1,null,{"sessionId":"48f1fee4-c609-427a-ab45-7ad814f20194","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573593 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
17:56:13 INFO - 1499302573594 Marionette TRACE 378 <- [1,2,null,{}]
17:56:13 INFO - 1499302573596 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:13 INFO - 1499302573597 Marionette TRACE 378 <- [1,3,null,{}]
17:56:13 INFO - 1499302573598 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:13 INFO - 1499302573599 Marionette TRACE 378 <- [1,4,null,{}]
17:56:13 INFO - 1499302573602 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}]
17:56:13 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499302573605 Marionette TRACE 378 <- [1,5,null,{"value":null}]
17:56:13 INFO - 1499302573607 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
17:56:13 INFO - 1499302573609 Marionette TRACE 378 <- [1,6,null,{}]
17:56:13 INFO - 1499302573612 Marionette DEBUG Closed connection 378
17:56:13 INFO - 1499302573613 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49791
17:56:13 INFO - 1499302573614 Marionette DEBUG Closed connection 379
17:56:13 INFO - 1499302573615 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49792
17:56:13 INFO - 1499302573616 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573618 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573620 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573625 Marionette TRACE 380 <- [1,1,null,{"sessionId":"3c35542d-20df-4c5d-a66d-fe22d4991029","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573627 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
17:56:13 INFO - 1499302573629 Marionette TRACE 380 <- [1,2,null,{}]
17:56:13 INFO - 1499302573631 Marionette DEBUG Closed connection 380
17:56:13 INFO - 1499302573632 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49793
17:56:13 INFO - 1499302573633 Marionette DEBUG Closed connection 381
17:56:13 INFO - 1499302573634 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49794
17:56:13 INFO - 1499302573637 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:13 INFO - 1499302573639 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573641 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573645 Marionette TRACE 382 <- [1,1,null,{"sessionId":"fd7bb5ca-a897-4bc3-9dda-230daabe2ddf","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573647 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"}]
17:56:13 INFO - 1499302573649 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"
17:56:13 INFO - 1499302573651 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"
17:56:13 INFO - 1499302573652 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"
17:56:13 INFO - 1499302573658 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"
17:56:13 INFO - 1499302573661 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"
17:56:13 INFO - 1499302573673 Marionette TRACE 382 <- [1,2,null,{}]
17:56:13 INFO - 1499302573682 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
17:56:13 INFO - 1499302573685 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5ffa0071-2e00-4b55-b4c7-c09a8278717a","ELEMENT":"5ffa0071-2e00-4b55-b4c7-c09a8278717a"}}]
17:56:13 INFO - 1499302573687 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"5ffa0071-2e00-4b55-b4c7-c09a8278717a"}]
17:56:13 INFO - 1499302573935 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:56:13 INFO - 1499302573936 Marionette TRACE 382 <- [1,4,null,{}]
17:56:13 INFO - 1499302573938 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}]
17:56:13 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499302573941 Marionette TRACE 382 <- [1,5,null,{"value":null}]
17:56:13 INFO - 1499302573943 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
17:56:13 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 381ms
17:56:13 INFO - TEST-START | test_click.py TestClick.test_input_file
17:56:13 INFO - 1499302573944 Marionette TRACE 382 <- [1,6,null,{}]
17:56:13 INFO - 1499302573946 Marionette DEBUG Closed connection 382
17:56:13 INFO - 1499302573947 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49795
17:56:13 INFO - 1499302573948 Marionette DEBUG Closed connection 383
17:56:13 INFO - 1499302573949 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49796
17:56:13 INFO - 1499302573950 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573951 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573954 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573958 Marionette TRACE 384 <- [1,1,null,{"sessionId":"7448cdd0-abe7-4438-8f46-d0e94f39a1e0","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573959 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
17:56:13 INFO - 1499302573960 Marionette TRACE 384 <- [1,2,null,{}]
17:56:13 INFO - 1499302573961 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:13 INFO - 1499302573962 Marionette TRACE 384 <- [1,3,null,{}]
17:56:13 INFO - 1499302573963 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:13 INFO - 1499302573963 Marionette TRACE 384 <- [1,4,null,{}]
17:56:13 INFO - 1499302573965 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}]
17:56:13 INFO - TEST-START: test_click.py TestClick.test_input_file1499302573969 Marionette TRACE 384 <- [1,5,null,{"value":null}]
17:56:13 INFO - 1499302573970 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
17:56:13 INFO - 1499302573971 Marionette TRACE 384 <- [1,6,null,{}]
17:56:13 INFO - 1499302573973 Marionette DEBUG Closed connection 384
17:56:13 INFO - 1499302573974 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49797
17:56:13 INFO - 1499302573975 Marionette DEBUG Closed connection 385
17:56:13 INFO - 1499302573975 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49798
17:56:13 INFO - 1499302573976 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:13 INFO - 1499302573977 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:13 INFO - 1499302573980 Marionette DEBUG Register listener.js for window 4294967297
17:56:13 INFO - 1499302573984 Marionette TRACE 386 <- [1,1,null,{"sessionId":"98cd79fb-74fc-4f7c-82ee-e7f6086f28c9","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:13 INFO - 1499302573987 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
17:56:13 INFO - 1499302573989 Marionette TRACE 386 <- [1,2,null,{}]
17:56:13 INFO - 1499302573991 Marionette DEBUG Closed connection 386
17:56:13 INFO - 1499302573994 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49799
17:56:13 INFO - 1499302573995 Marionette DEBUG Closed connection 387
17:56:13 INFO - 1499302573995 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49800
17:56:13 INFO - 1499302573997 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:14 INFO - 1499302573999 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574002 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574006 Marionette TRACE 388 <- [1,1,null,{"sessionId":"0fc5a4a7-2d09-4a7d-9f77-1bea34218d30","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574007 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
17:56:14 INFO - 1499302574010 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"
17:56:14 INFO - 1499302574011 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"
17:56:14 INFO - 1499302574012 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"
17:56:14 INFO - 1499302574019 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:56:14 INFO - 1499302574023 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:56:14 INFO - 1499302574034 Marionette TRACE 388 <- [1,2,null,{}]
17:56:14 INFO - 1499302574037 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
17:56:14 INFO - 1499302574041 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1d0e658a-9148-4fc7-9619-d1dbddf7b588","ELEMENT":"1d0e658a-9148-4fc7-9619-d1dbddf7b588"}}]
17:56:14 INFO - 1499302574042 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"1d0e658a-9148-4fc7-9619-d1dbddf7b588"}]
17:56:14 INFO - 1499302574078 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
17:56:14 INFO - 1499302574080 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}]
17:56:14 INFO - TEST-END: test_click.py TestClick.test_input_file1499302574084 Marionette TRACE 388 <- [1,5,null,{"value":null}]
17:56:14 INFO - 1499302574085 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
17:56:14 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 142ms
17:56:14 INFO - TEST-START | test_click.py TestClick.test_obscured_element
17:56:14 INFO - 1499302574086 Marionette TRACE 388 <- [1,6,null,{}]
17:56:14 INFO - 1499302574088 Marionette DEBUG Closed connection 388
17:56:14 INFO - 1499302574089 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49801
17:56:14 INFO - 1499302574090 Marionette DEBUG Closed connection 389
17:56:14 INFO - 1499302574090 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49802
17:56:14 INFO - 1499302574092 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:14 INFO - 1499302574092 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574095 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574098 Marionette TRACE 390 <- [1,1,null,{"sessionId":"548bc6fe-2c26-44b8-ac99-da69fd62973a","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574100 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
17:56:14 INFO - 1499302574100 Marionette TRACE 390 <- [1,2,null,{}]
17:56:14 INFO - 1499302574101 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:14 INFO - 1499302574102 Marionette TRACE 390 <- [1,3,null,{}]
17:56:14 INFO - 1499302574103 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:14 INFO - 1499302574103 Marionette TRACE 390 <- [1,4,null,{}]
17:56:14 INFO - 1499302574105 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}]
17:56:14 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499302574108 Marionette TRACE 390 <- [1,5,null,{"value":null}]
17:56:14 INFO - 1499302574110 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
17:56:14 INFO - 1499302574111 Marionette TRACE 390 <- [1,6,null,{}]
17:56:14 INFO - 1499302574113 Marionette DEBUG Closed connection 390
17:56:14 INFO - 1499302574114 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49803
17:56:14 INFO - 1499302574115 Marionette DEBUG Closed connection 391
17:56:14 INFO - 1499302574116 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49804
17:56:14 INFO - 1499302574117 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:14 INFO - 1499302574118 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574121 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574124 Marionette TRACE 392 <- [1,1,null,{"sessionId":"91a05d81-fd03-460a-a24a-1d6e4dd64e3a","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574125 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
17:56:14 INFO - 1499302574127 Marionette TRACE 392 <- [1,2,null,{}]
17:56:14 INFO - 1499302574128 Marionette DEBUG Closed connection 392
17:56:14 INFO - 1499302574129 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49805
17:56:14 INFO - 1499302574130 Marionette DEBUG Closed connection 393
17:56:14 INFO - 1499302574130 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49806
17:56:14 INFO - 1499302574132 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:14 INFO - 1499302574132 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574135 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574138 Marionette TRACE 394 <- [1,1,null,{"sessionId":"12772e18-43eb-4600-b678-b3ef12a17b53","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574140 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"}]
17:56:14 INFO - 1499302574141 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:56:14 INFO - 1499302574144 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:56:14 INFO - 1499302574144 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:56:14 INFO - 1499302574151 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"
17:56:14 INFO - 1499302574154 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"
17:56:14 INFO - 1499302574159 Marionette TRACE 394 <- [1,2,null,{}]
17:56:14 INFO - 1499302574168 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
17:56:14 INFO - 1499302574172 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f63fb0ec-43f3-4ab0-90a5-ac90f607e5cf","ELEMENT":"f63fb0ec-43f3-4ab0-90a5-ac90f607e5cf"}}]
17:56:14 INFO - 1499302574173 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
17:56:14 INFO - 1499302574175 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"10849eb5-a9ce-4fe0-93e4-25dbf9331957","ELEMENT":"10849eb5-a9ce-4fe0-93e4-25dbf9331957"}}]
17:56:14 INFO - 1499302574176 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"f63fb0ec-43f3-4ab0-90a5-ac90f607e5cf"}]
17:56:14 INFO - 1499302574416 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:56:14 INFO - 1499302574417 Marionette TRACE 394 <- [1,5,null,{}]
17:56:14 INFO - 1499302574418 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"10849eb5-a9ce-4fe0-93e4-25dbf9331957"}]
17:56:14 INFO - 1499302574435 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
17:56:14 INFO - 1499302574437 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
17:56:14 INFO - 1499302574440 Marionette TRACE 394 <- [1,7,null,{"value":false}]
17:56:14 INFO - 1499302574441 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}]
17:56:14 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499302574444 Marionette TRACE 394 <- [1,8,null,{"value":null}]
17:56:14 INFO - 1499302574445 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
17:56:14 INFO - 1499302574447 Marionette TRACE 394 <- [1,9,null,{}]
17:56:14 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 359ms
17:56:14 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
17:56:14 INFO - 1499302574448 Marionette DEBUG Closed connection 394
17:56:14 INFO - 1499302574449 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49807
17:56:14 INFO - 1499302574450 Marionette DEBUG Closed connection 395
17:56:14 INFO - 1499302574451 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49808
17:56:14 INFO - 1499302574452 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:14 INFO - 1499302574452 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574455 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574459 Marionette TRACE 396 <- [1,1,null,{"sessionId":"f45820fe-c29b-4f15-b12c-e0b60374f7c2","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574460 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
17:56:14 INFO - 1499302574461 Marionette TRACE 396 <- [1,2,null,{}]
17:56:14 INFO - 1499302574462 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:56:14 INFO - 1499302574463 Marionette TRACE 396 <- [1,3,null,{}]
17:56:14 INFO - 1499302574464 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
17:56:14 INFO - 1499302574464 Marionette TRACE 396 <- [1,4,null,{}]
17:56:14 INFO - 1499302574466 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}]
17:56:14 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499302574469 Marionette TRACE 396 <- [1,5,null,{"value":null}]
17:56:14 INFO - 1499302574470 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
17:56:14 INFO - 1499302574471 Marionette TRACE 396 <- [1,6,null,{}]
17:56:14 INFO - 1499302574473 Marionette DEBUG Closed connection 396
17:56:14 INFO - 1499302574474 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49809
17:56:14 INFO - 1499302574475 Marionette DEBUG Closed connection 397
17:56:14 INFO - 1499302574476 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49810
17:56:14 INFO - 1499302574477 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:56:14 INFO - 1499302574479 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574483 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574487 Marionette TRACE 398 <- [1,1,null,{"sessionId":"79060f92-26f4-4079-abe8-90a0a688cdfd","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574488 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
17:56:14 INFO - 1499302574490 Marionette TRACE 398 <- [1,2,null,{}]
17:56:14 INFO - 1499302574491 Marionette DEBUG Closed connection 398
17:56:14 INFO - 1499302574492 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49811
17:56:14 INFO - 1499302574493 Marionette DEBUG Closed connection 399
17:56:14 INFO - 1499302574494 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49812
17:56:14 INFO - 1499302574495 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:56:14 INFO - 1499302574496 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}
17:56:14 INFO - 1499302574499 Marionette DEBUG Register listener.js for window 4294967297
17:56:14 INFO - 1499302574503 Marionette TRACE 400 <- [1,1,null,{"sessionId":"dab65442-8a2c-4965-a56e-7024bb739ecb","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmphrzza7.mozrunner","moz:accessibilityChecks":false}}]
17:56:14 INFO - 1499302574504 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"}]
17:56:14 INFO - 1499302574506 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"
17:56:14 INFO - 1499302574508 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"
17:56:14 INFO - 1499302574508 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"
17:56:14 INFO - 1499302574515 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"
17:56:14 INFO - 1499302574518 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"
17:56:14 INFO - 1499302574525 Marionette TRACE 400 <- [1,2,null,{}]
17:56:14 INFO - 1499302574534 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
17:56:14 INFO - 1499302574537 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"59b7cf2e-86af-4cb5-aeb0-85fd8b858339","ELEMENT":"59b7cf2e-86af-4cb5-aeb0-85fd8b858339"}}]
17:56:14 INFO - 1499302574538 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"59b7cf2e-86af-4cb5-aeb0-85fd8b858339"}]
17:56:14 INFO - 1499302574563 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
17:56:14 INFO - 1499302574565 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"59b7cf2e-86af-4cb5-aeb0-85fd8b858339"}]
17:56:14 INFO - 1499302574591 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element