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]
09:58:36 INFO - 1499360316571 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:58:36 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499360316573 Marionette TRACE 352 <- [1,5,null,{"value":null}]
09:58:36 INFO - 1499360316574 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
09:58:36 INFO - 1499360316575 Marionette TRACE 352 <- [1,6,null,{}]
09:58:36 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 117ms
09:58:36 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
09:58:36 INFO - 1499360316577 Marionette DEBUG Closed connection 352
09:58:36 INFO - 1499360316578 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49776
09:58:36 INFO - 1499360316579 Marionette DEBUG Closed connection 353
09:58:36 INFO - 1499360316580 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49777
09:58:36 INFO - 1499360316580 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:36 INFO - 1499360316581 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316583 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316585 Marionette TRACE 354 <- [1,1,null,{"sessionId":"1b4223f7-1e34-4b35-8353-94fa0c8f9585","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316587 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
09:58:36 INFO - 1499360316587 Marionette TRACE 354 <- [1,2,null,{}]
09:58:36 INFO - 1499360316588 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:36 INFO - 1499360316588 Marionette TRACE 354 <- [1,3,null,{}]
09:58:36 INFO - 1499360316589 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:36 INFO - 1499360316589 Marionette TRACE 354 <- [1,4,null,{}]
09:58:36 INFO - 1499360316591 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:58:36 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499360316593 Marionette TRACE 354 <- [1,5,null,{"value":null}]
09:58:36 INFO - 1499360316594 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
09:58:36 INFO - 1499360316595 Marionette TRACE 354 <- [1,6,null,{}]
09:58:36 INFO - 1499360316596 Marionette DEBUG Closed connection 354
09:58:36 INFO - 1499360316597 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49778
09:58:36 INFO - 1499360316597 Marionette DEBUG Closed connection 355
09:58:36 INFO - 1499360316598 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49779
09:58:36 INFO - 1499360316599 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:36 INFO - 1499360316599 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316601 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316604 Marionette TRACE 356 <- [1,1,null,{"sessionId":"26b205f6-6c56-41b3-b538-df0923c0a174","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316605 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
09:58:36 INFO - 1499360316606 Marionette TRACE 356 <- [1,2,null,{}]
09:58:36 INFO - 1499360316608 Marionette DEBUG Closed connection 356
09:58:36 INFO - 1499360316608 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49780
09:58:36 INFO - 1499360316609 Marionette DEBUG Closed connection 357
09:58:36 INFO - 1499360316610 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49781
09:58:36 INFO - 1499360316610 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:36 INFO - 1499360316611 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316613 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316616 Marionette TRACE 358 <- [1,1,null,{"sessionId":"9de69476-1a1d-4427-9623-0ce11c7d9d38","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316617 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49342/clicks.html"}]
09:58:36 INFO - 1499360316618 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/hidden.html"
09:58:36 INFO - 1499360316624 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/hidden.html"
09:58:36 INFO - 1499360316625 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/hidden.html"
09:58:36 INFO - 1499360316631 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49342/clicks.html"
09:58:36 INFO - 1499360316636 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49342/clicks.html"
09:58:36 INFO - 1499360316640 Marionette TRACE 358 <- [1,2,null,{}]
09:58:36 INFO - 1499360316643 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:58:36 INFO - 1499360316646 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5cbc4ac8-1e67-477b-a309-c24f33e5acd0","ELEMENT":"5cbc4ac8-1e67-477b-a309-c24f33e5acd0"}}]
09:58:36 INFO - 1499360316647 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"5cbc4ac8-1e67-477b-a309-c24f33e5acd0"}]
09:58:36 INFO - 1499360316686 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/clicks.html"
09:58:36 INFO - 1499360316692 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/clicks.html"
09:58:36 INFO - 1499360316692 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/clicks.html"
09:58:36 INFO - 1499360316698 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49342/test.html"
09:58:36 INFO - 1499360316702 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49342/test.html"
09:58:36 INFO - 1499360316702 Marionette TRACE 358 <- [1,4,null,{}]
09:58:36 INFO - 1499360316708 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:58:36 INFO - 1499360316711 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a2bd5a1-b865-490c-99a3-cad33c04377b","ELEMENT":"2a2bd5a1-b865-490c-99a3-cad33c04377b"}}]
09:58:36 INFO - 1499360316712 Marionette TRACE 358 -> [0,6,"getTitle",{}]
09:58:36 INFO - 1499360316713 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
09:58:36 INFO - 1499360316714 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:58:36 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499360316716 Marionette TRACE 358 <- [1,7,null,{"value":null}]
09:58:36 INFO - 1499360316717 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
09:58:36 INFO - 1499360316718 Marionette TRACE 358 <- [1,8,null,{}]
09:58:36 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 142ms
09:58:36 INFO - TEST-START | test_click.py TestClick.test_container_element
09:58:36 INFO - 1499360316719 Marionette DEBUG Closed connection 358
09:58:36 INFO - 1499360316723 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49784
09:58:36 INFO - 1499360316723 Marionette DEBUG Closed connection 359
09:58:36 INFO - 1499360316724 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49785
09:58:36 INFO - 1499360316725 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:36 INFO - 1499360316726 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316728 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316731 Marionette TRACE 360 <- [1,1,null,{"sessionId":"28526e87-2d7c-4415-b137-e62c7a6b8a4a","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316732 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
09:58:36 INFO - 1499360316732 Marionette TRACE 360 <- [1,2,null,{}]
09:58:36 INFO - 1499360316733 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:36 INFO - 1499360316733 Marionette TRACE 360 <- [1,3,null,{}]
09:58:36 INFO - 1499360316734 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:36 INFO - 1499360316734 Marionette TRACE 360 <- [1,4,null,{}]
09:58:36 INFO - 1499360316736 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:58:36 INFO - TEST-START: test_click.py TestClick.test_container_element1499360316738 Marionette TRACE 360 <- [1,5,null,{"value":null}]
09:58:36 INFO - 1499360316739 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
09:58:36 INFO - 1499360316740 Marionette TRACE 360 <- [1,6,null,{}]
09:58:36 INFO - 1499360316741 Marionette DEBUG Closed connection 360
09:58:36 INFO - 1499360316742 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49786
09:58:36 INFO - 1499360316742 Marionette DEBUG Closed connection 361
09:58:36 INFO - 1499360316743 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49787
09:58:36 INFO - 1499360316744 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:36 INFO - 1499360316744 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316747 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316749 Marionette TRACE 362 <- [1,1,null,{"sessionId":"d78e1dfa-84bb-4c50-98a3-9435f2af8a0c","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316758 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
09:58:36 INFO - 1499360316760 Marionette TRACE 362 <- [1,2,null,{}]
09:58:36 INFO - 1499360316761 Marionette DEBUG Closed connection 362
09:58:36 INFO - 1499360316761 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49788
09:58:36 INFO - 1499360316762 Marionette DEBUG Closed connection 363
09:58:36 INFO - 1499360316763 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49789
09:58:36 INFO - 1499360316764 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:36 INFO - 1499360316764 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:36 INFO - 1499360316766 Marionette DEBUG Register listener.js for window 4294967297
09:58:36 INFO - 1499360316769 Marionette TRACE 364 <- [1,1,null,{"sessionId":"324291a4-31af-4769-bd58-433bd6a027c0","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:36 INFO - 1499360316770 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:58:36 INFO - 1499360316772 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49342/test.html"
09:58:36 INFO - 1499360316774 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49342/test.html"
09:58:36 INFO - 1499360316775 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49342/test.html"
09:58:36 INFO - 1499360316781 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:58:36 INFO - 1499360316786 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:58:36 INFO - 1499360316792 Marionette TRACE 364 <- [1,2,null,{}]
09:58:36 INFO - 1499360316795 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:58:36 INFO - 1499360316797 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5fa09c5e-7cbf-42fb-8df4-c69e3014140e","ELEMENT":"5fa09c5e-7cbf-42fb-8df4-c69e3014140e"}}]
09:58:36 INFO - 1499360316798 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"5fa09c5e-7cbf-42fb-8df4-c69e3014140e"}]
09:58:37 INFO - 1499360317035 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:58:37 INFO - 1499360317036 Marionette TRACE 364 <- [1,4,null,{}]
09:58:37 INFO - 1499360317037 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"5fa09c5e-7cbf-42fb-8df4-c69e3014140e","name":"selected"}]
09:58:37 INFO - 1499360317041 Marionette TRACE 364 <- [1,5,null,{"value":true}]
09:58:37 INFO - 1499360317042 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:58:37 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 328ms
09:58:37 INFO - TEST-END: test_click.py TestClick.test_container_element1499360317044 Marionette TRACE 364 <- [1,6,null,{"value":null}]
09:58:37 INFO - 1499360317045 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
09:58:37 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:58:37 INFO - 1499360317046 Marionette TRACE 364 <- [1,7,null,{}]
09:58:37 INFO - 1499360317048 Marionette DEBUG Closed connection 364
09:58:37 INFO - 1499360317050 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49790
09:58:37 INFO - 1499360317051 Marionette DEBUG Closed connection 365
09:58:37 INFO - 1499360317051 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49791
09:58:37 INFO - 1499360317052 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317053 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317055 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317057 Marionette TRACE 366 <- [1,1,null,{"sessionId":"3066ab28-89b0-4d26-afed-87fa9882d4d6","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317059 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
09:58:37 INFO - 1499360317059 Marionette TRACE 366 <- [1,2,null,{}]
09:58:37 INFO - 1499360317060 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:37 INFO - 1499360317060 Marionette TRACE 366 <- [1,3,null,{}]
09:58:37 INFO - 1499360317061 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:37 INFO - 1499360317061 Marionette TRACE 366 <- [1,4,null,{}]
09:58:37 INFO - 1499360317063 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:58:37 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499360317065 Marionette TRACE 366 <- [1,5,null,{"value":null}]
09:58:37 INFO - 1499360317066 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
09:58:37 INFO - 1499360317067 Marionette TRACE 366 <- [1,6,null,{}]
09:58:37 INFO - 1499360317068 Marionette DEBUG Closed connection 366
09:58:37 INFO - 1499360317069 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49792
09:58:37 INFO - 1499360317069 Marionette DEBUG Closed connection 367
09:58:37 INFO - 1499360317071 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49793
09:58:37 INFO - 1499360317073 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317073 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317075 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317078 Marionette TRACE 368 <- [1,1,null,{"sessionId":"5814f540-bbb8-4e82-95de-b7579b0962ce","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317079 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
09:58:37 INFO - 1499360317080 Marionette TRACE 368 <- [1,2,null,{}]
09:58:37 INFO - 1499360317082 Marionette DEBUG Closed connection 368
09:58:37 INFO - 1499360317082 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49794
09:58:37 INFO - 1499360317083 Marionette DEBUG Closed connection 369
09:58:37 INFO - 1499360317083 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49795
09:58:37 INFO - 1499360317084 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:37 INFO - 1499360317085 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317087 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317090 Marionette TRACE 370 <- [1,1,null,{"sessionId":"2eb3d151-be46-435c-8fc4-6c20fd4c3a0c","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317091 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:58:37 INFO - 1499360317092 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:58:37 INFO - 1499360317094 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:58:37 INFO - 1499360317094 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:58:37 INFO - 1499360317099 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:58:37 INFO - 1499360317102 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:58:37 INFO - 1499360317108 Marionette TRACE 370 <- [1,2,null,{}]
09:58:37 INFO - 1499360317110 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:58:37 INFO - 1499360317112 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e1a053c5-c1b4-44e4-95d2-1bcb1f92d10e","ELEMENT":"e1a053c5-c1b4-44e4-95d2-1bcb1f92d10e"}}]
09:58:37 INFO - 1499360317113 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"e1a053c5-c1b4-44e4-95d2-1bcb1f92d10e"}]
09:58:37 INFO - 1499360317356 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:58:37 INFO - 1499360317357 Marionette TRACE 370 <- [1,4,null,{}]
09:58:37 INFO - 1499360317358 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"e1a053c5-c1b4-44e4-95d2-1bcb1f92d10e","name":"selected"}]
09:58:37 INFO - 1499360317361 Marionette TRACE 370 <- [1,5,null,{"value":true}]
09:58:37 INFO - 1499360317363 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:58:37 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499360317365 Marionette TRACE 370 <- [1,6,null,{"value":null}]
09:58:37 INFO - 1499360317366 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
09:58:37 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 320ms
09:58:37 INFO - 1499360317367 Marionette TRACE 370 <- [1,7,null,{}]
09:58:37 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:58:37 INFO - 1499360317369 Marionette DEBUG Closed connection 370
09:58:37 INFO - 1499360317370 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49796
09:58:37 INFO - 1499360317371 Marionette DEBUG Closed connection 371
09:58:37 INFO - 1499360317371 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49797
09:58:37 INFO - 1499360317372 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317372 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317375 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317377 Marionette TRACE 372 <- [1,1,null,{"sessionId":"b6642da1-5c07-4beb-bd68-84072ad5c63a","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317378 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
09:58:37 INFO - 1499360317378 Marionette TRACE 372 <- [1,2,null,{}]
09:58:37 INFO - 1499360317379 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:37 INFO - 1499360317380 Marionette TRACE 372 <- [1,3,null,{}]
09:58:37 INFO - 1499360317381 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:37 INFO - 1499360317381 Marionette TRACE 372 <- [1,4,null,{}]
09:58:37 INFO - 1499360317382 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:58:37 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499360317385 Marionette TRACE 372 <- [1,5,null,{"value":null}]
09:58:37 INFO - 1499360317386 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
09:58:37 INFO - 1499360317387 Marionette TRACE 372 <- [1,6,null,{}]
09:58:37 INFO - 1499360317388 Marionette DEBUG Closed connection 372
09:58:37 INFO - 1499360317389 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49798
09:58:37 INFO - 1499360317389 Marionette DEBUG Closed connection 373
09:58:37 INFO - 1499360317390 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49799
09:58:37 INFO - 1499360317391 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317392 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317394 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317396 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d45b05c5-357d-4bb1-a319-9aeb1a8566d5","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317397 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
09:58:37 INFO - 1499360317398 Marionette TRACE 374 <- [1,2,null,{}]
09:58:37 INFO - 1499360317400 Marionette DEBUG Closed connection 374
09:58:37 INFO - 1499360317400 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49800
09:58:37 INFO - 1499360317401 Marionette DEBUG Closed connection 375
09:58:37 INFO - 1499360317402 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49801
09:58:37 INFO - 1499360317403 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:37 INFO - 1499360317403 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317405 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317407 Marionette TRACE 376 <- [1,1,null,{"sessionId":"20631aef-b5ba-4965-8367-599f2cbac41c","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317408 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:58:37 INFO - 1499360317410 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:58:37 INFO - 1499360317412 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:58:37 INFO - 1499360317412 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:58:37 INFO - 1499360317417 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:58:37 INFO - 1499360317420 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:58:37 INFO - 1499360317426 Marionette TRACE 376 <- [1,2,null,{}]
09:58:37 INFO - 1499360317429 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:58:37 INFO - 1499360317431 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7b9410fc-26c2-468e-9622-86b9bb8be660","ELEMENT":"7b9410fc-26c2-468e-9622-86b9bb8be660"}}]
09:58:37 INFO - 1499360317432 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7b9410fc-26c2-468e-9622-86b9bb8be660"}]
09:58:37 INFO - 1499360317666 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:58:37 INFO - 1499360317667 Marionette TRACE 376 <- [1,4,null,{}]
09:58:37 INFO - 1499360317668 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:58:37 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499360317671 Marionette TRACE 376 <- [1,5,null,{"value":null}]
09:58:37 INFO - 1499360317672 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
09:58:37 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 305ms
09:58:37 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:58:37 INFO - 1499360317673 Marionette TRACE 376 <- [1,6,null,{}]
09:58:37 INFO - 1499360317674 Marionette DEBUG Closed connection 376
09:58:37 INFO - 1499360317675 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49802
09:58:37 INFO - 1499360317676 Marionette DEBUG Closed connection 377
09:58:37 INFO - 1499360317676 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49803
09:58:37 INFO - 1499360317677 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317678 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317680 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317683 Marionette TRACE 378 <- [1,1,null,{"sessionId":"a1abf8d7-02f0-4572-a308-5630f8d8e35b","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317684 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
09:58:37 INFO - 1499360317684 Marionette TRACE 378 <- [1,2,null,{}]
09:58:37 INFO - 1499360317685 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:37 INFO - 1499360317686 Marionette TRACE 378 <- [1,3,null,{}]
09:58:37 INFO - 1499360317686 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:37 INFO - 1499360317687 Marionette TRACE 378 <- [1,4,null,{}]
09:58:37 INFO - 1499360317688 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:58:37 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499360317691 Marionette TRACE 378 <- [1,5,null,{"value":null}]
09:58:37 INFO - 1499360317691 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
09:58:37 INFO - 1499360317693 Marionette TRACE 378 <- [1,6,null,{}]
09:58:37 INFO - 1499360317694 Marionette DEBUG Closed connection 378
09:58:37 INFO - 1499360317694 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49804
09:58:37 INFO - 1499360317695 Marionette DEBUG Closed connection 379
09:58:37 INFO - 1499360317696 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49805
09:58:37 INFO - 1499360317697 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317697 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317700 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317702 Marionette TRACE 380 <- [1,1,null,{"sessionId":"e77baf97-945c-4bac-b640-7a3dc9128094","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317704 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
09:58:37 INFO - 1499360317705 Marionette TRACE 380 <- [1,2,null,{}]
09:58:37 INFO - 1499360317706 Marionette DEBUG Closed connection 380
09:58:37 INFO - 1499360317707 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49806
09:58:37 INFO - 1499360317707 Marionette DEBUG Closed connection 381
09:58:37 INFO - 1499360317708 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49807
09:58:37 INFO - 1499360317709 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:37 INFO - 1499360317709 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317711 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317714 Marionette TRACE 382 <- [1,1,null,{"sessionId":"c94da211-652f-496a-b7c4-bd663761ec01","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317715 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:58:37 INFO - 1499360317717 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:58:37 INFO - 1499360317718 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:58:37 INFO - 1499360317719 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:58:37 INFO - 1499360317725 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:58:37 INFO - 1499360317728 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:58:37 INFO - 1499360317729 Marionette TRACE 382 <- [1,2,null,{}]
09:58:37 INFO - 1499360317732 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:58:37 INFO - 1499360317734 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"246bbf00-d146-4600-aa92-15a89af4d5b8","ELEMENT":"246bbf00-d146-4600-aa92-15a89af4d5b8"}}]
09:58:37 INFO - 1499360317735 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"246bbf00-d146-4600-aa92-15a89af4d5b8"}]
09:58:37 INFO - 1499360317976 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:58:37 INFO - 1499360317976 Marionette TRACE 382 <- [1,4,null,{}]
09:58:37 INFO - 1499360317978 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:58:37 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 309ms
09:58:37 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499360317981 Marionette TRACE 382 <- [1,5,null,{"value":null}]
09:58:37 INFO - 1499360317981 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
09:58:37 INFO - 1499360317983 Marionette TRACE 382 <- [1,6,null,{}]
09:58:37 INFO - TEST-START | test_click.py TestClick.test_input_file
09:58:37 INFO - 1499360317984 Marionette DEBUG Closed connection 382
09:58:37 INFO - 1499360317985 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49808
09:58:37 INFO - 1499360317986 Marionette DEBUG Closed connection 383
09:58:37 INFO - 1499360317987 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49809
09:58:37 INFO - 1499360317988 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:37 INFO - 1499360317988 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:37 INFO - 1499360317990 Marionette DEBUG Register listener.js for window 4294967297
09:58:37 INFO - 1499360317993 Marionette TRACE 384 <- [1,1,null,{"sessionId":"1ca214f0-e447-4671-a0a2-7e00b934a8b5","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:37 INFO - 1499360317994 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
09:58:37 INFO - 1499360317994 Marionette TRACE 384 <- [1,2,null,{}]
09:58:37 INFO - 1499360317995 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:37 INFO - 1499360317995 Marionette TRACE 384 <- [1,3,null,{}]
09:58:37 INFO - 1499360317996 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:37 INFO - 1499360317997 Marionette TRACE 384 <- [1,4,null,{}]
09:58:38 INFO - 1499360317999 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:58:38 INFO - TEST-START: test_click.py TestClick.test_input_file1499360318001 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:58:38 INFO - 1499360318002 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:58:38 INFO - 1499360318003 Marionette TRACE 384 <- [1,6,null,{}]
09:58:38 INFO - 1499360318004 Marionette DEBUG Closed connection 384
09:58:38 INFO - 1499360318005 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49810
09:58:38 INFO - 1499360318005 Marionette DEBUG Closed connection 385
09:58:38 INFO - 1499360318006 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49811
09:58:38 INFO - 1499360318007 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:38 INFO - 1499360318007 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318009 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318012 Marionette TRACE 386 <- [1,1,null,{"sessionId":"6ed3fced-f513-47c9-8f9b-18965cb4f971","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318013 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
09:58:38 INFO - 1499360318014 Marionette TRACE 386 <- [1,2,null,{}]
09:58:38 INFO - 1499360318015 Marionette DEBUG Closed connection 386
09:58:38 INFO - 1499360318016 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49812
09:58:38 INFO - 1499360318016 Marionette DEBUG Closed connection 387
09:58:38 INFO - 1499360318017 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49813
09:58:38 INFO - 1499360318018 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:38 INFO - 1499360318019 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318021 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318023 Marionette TRACE 388 <- [1,1,null,{"sessionId":"1132bf64-1548-4519-be04-1a946952511c","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318024 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:58:38 INFO - 1499360318026 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:58:38 INFO - 1499360318027 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:58:38 INFO - 1499360318028 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:58:38 INFO - 1499360318033 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:58:38 INFO - 1499360318036 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:58:38 INFO - 1499360318041 Marionette TRACE 388 <- [1,2,null,{}]
09:58:38 INFO - 1499360318043 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:58:38 INFO - 1499360318046 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9d1e8b5c-477e-4054-8a7c-1566f7ffff6f","ELEMENT":"9d1e8b5c-477e-4054-8a7c-1566f7ffff6f"}}]
09:58:38 INFO - 1499360318047 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"9d1e8b5c-477e-4054-8a7c-1566f7ffff6f"}]
09:58:38 INFO - 1499360318073 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]
09:58:38 INFO - 1499360318075 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:58:38 INFO - TEST-END: test_click.py TestClick.test_input_file1499360318077 Marionette TRACE 388 <- [1,5,null,{"value":null}]
09:58:38 INFO - 1499360318078 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
09:58:38 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 96ms
09:58:38 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:58:38 INFO - 1499360318079 Marionette TRACE 388 <- [1,6,null,{}]
09:58:38 INFO - 1499360318081 Marionette DEBUG Closed connection 388
09:58:38 INFO - 1499360318082 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49814
09:58:38 INFO - 1499360318082 Marionette DEBUG Closed connection 389
09:58:38 INFO - 1499360318083 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49815
09:58:38 INFO - 1499360318084 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:38 INFO - 1499360318084 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318087 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318089 Marionette TRACE 390 <- [1,1,null,{"sessionId":"93293027-5603-47f1-97a3-e2c217083ff3","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318090 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
09:58:38 INFO - 1499360318091 Marionette TRACE 390 <- [1,2,null,{}]
09:58:38 INFO - 1499360318091 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:38 INFO - 1499360318092 Marionette TRACE 390 <- [1,3,null,{}]
09:58:38 INFO - 1499360318092 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:38 INFO - 1499360318093 Marionette TRACE 390 <- [1,4,null,{}]
09:58:38 INFO - 1499360318094 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:58:38 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499360318097 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:58:38 INFO - 1499360318097 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:58:38 INFO - 1499360318098 Marionette TRACE 390 <- [1,6,null,{}]
09:58:38 INFO - 1499360318100 Marionette DEBUG Closed connection 390
09:58:38 INFO - 1499360318100 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49816
09:58:38 INFO - 1499360318101 Marionette DEBUG Closed connection 391
09:58:38 INFO - 1499360318101 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49817
09:58:38 INFO - 1499360318102 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:38 INFO - 1499360318103 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318105 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318108 Marionette TRACE 392 <- [1,1,null,{"sessionId":"e52f6f44-8ed6-4f88-a625-a12316d836dd","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318109 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
09:58:38 INFO - 1499360318110 Marionette TRACE 392 <- [1,2,null,{}]
09:58:38 INFO - 1499360318111 Marionette DEBUG Closed connection 392
09:58:38 INFO - 1499360318112 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49818
09:58:38 INFO - 1499360318112 Marionette DEBUG Closed connection 393
09:58:38 INFO - 1499360318113 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49819
09:58:38 INFO - 1499360318114 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:38 INFO - 1499360318114 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318116 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318119 Marionette TRACE 394 <- [1,1,null,{"sessionId":"9cd7a771-150c-4aae-87ad-e5083738de38","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318120 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:58:38 INFO - 1499360318122 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:58:38 INFO - 1499360318123 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:58:38 INFO - 1499360318123 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:58:38 INFO - 1499360318129 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:58:38 INFO - 1499360318131 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:58:38 INFO - 1499360318132 Marionette TRACE 394 <- [1,2,null,{}]
09:58:38 INFO - 1499360318135 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:58:38 INFO - 1499360318140 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"850cce20-ad56-443c-bd7d-23a70afa4488","ELEMENT":"850cce20-ad56-443c-bd7d-23a70afa4488"}}]
09:58:38 INFO - 1499360318141 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:58:38 INFO - 1499360318144 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"522bcca9-31ca-4dd4-b20c-f951b1dd377e","ELEMENT":"522bcca9-31ca-4dd4-b20c-f951b1dd377e"}}]
09:58:38 INFO - 1499360318144 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"850cce20-ad56-443c-bd7d-23a70afa4488"}]
09:58:38 INFO - 1499360318383 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:58:38 INFO - 1499360318384 Marionette TRACE 394 <- [1,5,null,{}]
09:58:38 INFO - 1499360318385 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"522bcca9-31ca-4dd4-b20c-f951b1dd377e"}]
09:58:38 INFO - 1499360318398 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]
09:58:38 INFO - 1499360318400 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:58:38 INFO - 1499360318402 Marionette TRACE 394 <- [1,7,null,{"value":false}]
09:58:38 INFO - 1499360318404 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:58:38 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499360318406 Marionette TRACE 394 <- [1,8,null,{"value":null}]
09:58:38 INFO - 1499360318407 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
09:58:38 INFO - 1499360318408 Marionette TRACE 394 <- [1,9,null,{}]
09:58:38 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 329ms
09:58:38 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:58:38 INFO - 1499360318409 Marionette DEBUG Closed connection 394
09:58:38 INFO - 1499360318411 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49820
09:58:38 INFO - 1499360318412 Marionette DEBUG Closed connection 395
09:58:38 INFO - 1499360318413 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49821
09:58:38 INFO - 1499360318413 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:38 INFO - 1499360318414 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318417 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318427 Marionette TRACE 396 <- [1,1,null,{"sessionId":"24ed19b7-c910-4d7d-9b61-dae836dc629e","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318429 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
09:58:38 INFO - 1499360318429 Marionette TRACE 396 <- [1,2,null,{}]
09:58:38 INFO - 1499360318430 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:58:38 INFO - 1499360318430 Marionette TRACE 396 <- [1,3,null,{}]
09:58:38 INFO - 1499360318431 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
09:58:38 INFO - 1499360318431 Marionette TRACE 396 <- [1,4,null,{}]
09:58:38 INFO - 1499360318433 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:58:38 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499360318435 Marionette TRACE 396 <- [1,5,null,{"value":null}]
09:58:38 INFO - 1499360318436 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
09:58:38 INFO - 1499360318437 Marionette TRACE 396 <- [1,6,null,{}]
09:58:38 INFO - 1499360318438 Marionette DEBUG Closed connection 396
09:58:38 INFO - 1499360318439 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49822
09:58:38 INFO - 1499360318440 Marionette DEBUG Closed connection 397
09:58:38 INFO - 1499360318440 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49823
09:58:38 INFO - 1499360318441 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:58:38 INFO - 1499360318441 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318444 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318446 Marionette TRACE 398 <- [1,1,null,{"sessionId":"ddc1c2cb-e227-4fa4-8a36-eb3e4246ad27","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318447 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
09:58:38 INFO - 1499360318448 Marionette TRACE 398 <- [1,2,null,{}]
09:58:38 INFO - 1499360318449 Marionette DEBUG Closed connection 398
09:58:38 INFO - 1499360318450 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49824
09:58:38 INFO - 1499360318450 Marionette DEBUG Closed connection 399
09:58:38 INFO - 1499360318451 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49825
09:58:38 INFO - 1499360318452 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:58:38 INFO - 1499360318452 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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}
09:58:38 INFO - 1499360318454 Marionette DEBUG Register listener.js for window 4294967297
09:58:38 INFO - 1499360318457 Marionette TRACE 400 <- [1,1,null,{"sessionId":"246ee9d3-88fb-4866-a9ff-33f8a9c2403a","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":2468,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-250.001\\AppData\\Local\\Temp\\tmpzboyli.mozrunner","moz:accessibilityChecks":false}}]
09:58:38 INFO - 1499360318458 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:58:38 INFO - 1499360318459 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:58:38 INFO - 1499360318461 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:58:38 INFO - 1499360318461 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:58:38 INFO - 1499360318467 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:58:38 INFO - 1499360318469 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:58:38 INFO - 1499360318476 Marionette TRACE 400 <- [1,2,null,{}]
09:58:38 INFO - 1499360318479 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:58:38 INFO - 1499360318481 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b2868e87-fbd5-4f21-994c-cadeefc17fa0","ELEMENT":"b2868e87-fbd5-4f21-994c-cadeefc17fa0"}}]
09:58:38 INFO - 1499360318481 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"b2868e87-fbd5-4f21-994c-cadeefc17fa0"}]
09:58:38 INFO - 1499360318503 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
09:58:38 INFO - 1499360318504 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"b2868e87-fbd5-4f21-994c-cadeefc17fa0"}]
09:58:38 INFO - 1499360318518 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element