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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
08:43:29 INFO - 1500997409545 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}]
08:43:29 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500997409548 Marionette TRACE 352 <- [1,5,null,{"value":null}]
08:43:29 INFO - 1500997409549 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
08:43:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 111ms
08:43:29 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
08:43:29 INFO - 1500997409550 Marionette TRACE 352 <- [1,6,null,{}]
08:43:29 INFO - 1500997409551 Marionette DEBUG Closed connection 352
08:43:29 INFO - 1500997409552 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49762
08:43:29 INFO - 1500997409553 Marionette DEBUG Closed connection 353
08:43:29 INFO - 1500997409553 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49763
08:43:29 INFO - 1500997409554 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:29 INFO - 1500997409555 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409557 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409560 Marionette TRACE 354 <- [1,1,null,{"sessionId":"f51e4b0b-3231-437d-82f2-d6f804bd9573","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409561 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
08:43:29 INFO - 1500997409562 Marionette TRACE 354 <- [1,2,null,{}]
08:43:29 INFO - 1500997409562 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:29 INFO - 1500997409563 Marionette TRACE 354 <- [1,3,null,{}]
08:43:29 INFO - 1500997409564 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:29 INFO - 1500997409564 Marionette TRACE 354 <- [1,4,null,{}]
08:43:29 INFO - 1500997409566 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}]
08:43:29 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500997409568 Marionette TRACE 354 <- [1,5,null,{"value":null}]
08:43:29 INFO - 1500997409569 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
08:43:29 INFO - 1500997409570 Marionette TRACE 354 <- [1,6,null,{}]
08:43:29 INFO - 1500997409572 Marionette DEBUG Closed connection 354
08:43:29 INFO - 1500997409572 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49764
08:43:29 INFO - 1500997409573 Marionette DEBUG Closed connection 355
08:43:29 INFO - 1500997409573 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49765
08:43:29 INFO - 1500997409574 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:29 INFO - 1500997409575 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409577 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409580 Marionette TRACE 356 <- [1,1,null,{"sessionId":"322f2092-05f1-4fae-a10a-cc5e3173413d","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409581 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
08:43:29 INFO - 1500997409582 Marionette TRACE 356 <- [1,2,null,{}]
08:43:29 INFO - 1500997409583 Marionette DEBUG Closed connection 356
08:43:29 INFO - 1500997409584 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49766
08:43:29 INFO - 1500997409584 Marionette DEBUG Closed connection 357
08:43:29 INFO - 1500997409585 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49767
08:43:29 INFO - 1500997409586 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:29 INFO - 1500997409586 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409588 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409598 Marionette TRACE 358 <- [1,1,null,{"sessionId":"5a95e11f-e055-4725-be36-1bbdfd765172","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409599 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49327/clicks.html"}]
08:43:29 INFO - 1500997409601 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/hidden.html"
08:43:29 INFO - 1500997409607 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/hidden.html"
08:43:29 INFO - 1500997409607 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/hidden.html"
08:43:29 INFO - 1500997409613 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/clicks.html"
08:43:29 INFO - 1500997409617 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/clicks.html"
08:43:29 INFO - 1500997409619 Marionette TRACE 358 <- [1,2,null,{}]
08:43:29 INFO - 1500997409622 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
08:43:29 INFO - 1500997409625 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8562c3ff-0f01-4523-a770-409e4995530d","ELEMENT":"8562c3ff-0f01-4523-a770-409e4995530d"}}]
08:43:29 INFO - 1500997409626 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"8562c3ff-0f01-4523-a770-409e4995530d"}]
08:43:29 INFO - 1500997409674 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/clicks.html"
08:43:29 INFO - 1500997409683 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/clicks.html"
08:43:29 INFO - 1500997409683 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/clicks.html"
08:43:29 INFO - 1500997409689 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/test.html"
08:43:29 INFO - 1500997409691 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/test.html"
08:43:29 INFO - 1500997409703 Marionette TRACE 358 <- [1,4,null,{}]
08:43:29 INFO - 1500997409712 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
08:43:29 INFO - 1500997409716 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"de7d5bf8-7c27-49de-931a-63c2b2ff12fe","ELEMENT":"de7d5bf8-7c27-49de-931a-63c2b2ff12fe"}}]
08:43:29 INFO - 1500997409717 Marionette TRACE 358 -> [0,6,"getTitle",{}]
08:43:29 INFO - 1500997409717 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
08:43:29 INFO - 1500997409719 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}]
08:43:29 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500997409721 Marionette TRACE 358 <- [1,7,null,{"value":null}]
08:43:29 INFO - 1500997409722 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
08:43:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 172ms
08:43:29 INFO - TEST-START | test_click.py TestClick.test_container_element
08:43:29 INFO - 1500997409723 Marionette TRACE 358 <- [1,8,null,{}]
08:43:29 INFO - 1500997409724 Marionette DEBUG Closed connection 358
08:43:29 INFO - 1500997409725 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49770
08:43:29 INFO - 1500997409726 Marionette DEBUG Closed connection 359
08:43:29 INFO - 1500997409726 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49771
08:43:29 INFO - 1500997409727 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:29 INFO - 1500997409727 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409730 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409733 Marionette TRACE 360 <- [1,1,null,{"sessionId":"74e4b997-7840-4a89-9ce2-6a9126f41182","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409734 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
08:43:29 INFO - 1500997409735 Marionette TRACE 360 <- [1,2,null,{}]
08:43:29 INFO - 1500997409735 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:29 INFO - 1500997409736 Marionette TRACE 360 <- [1,3,null,{}]
08:43:29 INFO - 1500997409737 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:29 INFO - 1500997409737 Marionette TRACE 360 <- [1,4,null,{}]
08:43:29 INFO - 1500997409738 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}]
08:43:29 INFO - TEST-START: test_click.py TestClick.test_container_element1500997409741 Marionette TRACE 360 <- [1,5,null,{"value":null}]
08:43:29 INFO - 1500997409742 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
08:43:29 INFO - 1500997409743 Marionette TRACE 360 <- [1,6,null,{}]
08:43:29 INFO - 1500997409744 Marionette DEBUG Closed connection 360
08:43:29 INFO - 1500997409745 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49772
08:43:29 INFO - 1500997409745 Marionette DEBUG Closed connection 361
08:43:29 INFO - 1500997409746 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49773
08:43:29 INFO - 1500997409747 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:29 INFO - 1500997409747 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409749 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409752 Marionette TRACE 362 <- [1,1,null,{"sessionId":"bd49aa10-670a-449b-aab1-e5596339f6f1","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409754 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
08:43:29 INFO - 1500997409755 Marionette TRACE 362 <- [1,2,null,{}]
08:43:29 INFO - 1500997409757 Marionette DEBUG Closed connection 362
08:43:29 INFO - 1500997409757 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49774
08:43:29 INFO - 1500997409758 Marionette DEBUG Closed connection 363
08:43:29 INFO - 1500997409758 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49775
08:43:29 INFO - 1500997409759 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:29 INFO - 1500997409760 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:29 INFO - 1500997409762 Marionette DEBUG Register listener.js for window 4294967297
08:43:29 INFO - 1500997409765 Marionette TRACE 364 <- [1,1,null,{"sessionId":"a3b1fd85-c1b1-4520-b4a1-3d6f64719093","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:29 INFO - 1500997409766 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"}]
08:43:29 INFO - 1500997409768 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/test.html"
08:43:29 INFO - 1500997409770 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/test.html"
08:43:29 INFO - 1500997409771 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/test.html"
08:43:29 INFO - 1500997409782 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"
08:43:29 INFO - 1500997409785 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"
08:43:29 INFO - 1500997409789 Marionette TRACE 364 <- [1,2,null,{}]
08:43:29 INFO - 1500997409792 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
08:43:29 INFO - 1500997409797 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6650cf79-5112-47c5-bf29-acb29d5566e4","ELEMENT":"6650cf79-5112-47c5-bf29-acb29d5566e4"}}]
08:43:29 INFO - 1500997409798 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"6650cf79-5112-47c5-bf29-acb29d5566e4"}]
08:43:30 INFO - 1500997410036 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:30 INFO - 1500997410037 Marionette TRACE 364 <- [1,4,null,{}]
08:43:30 INFO - 1500997410038 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"6650cf79-5112-47c5-bf29-acb29d5566e4","name":"selected"}]
08:43:30 INFO - 1500997410042 Marionette TRACE 364 <- [1,5,null,{"value":true}]
08:43:30 INFO - 1500997410044 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}]
08:43:30 INFO - TEST-END: test_click.py TestClick.test_container_element1500997410046 Marionette TRACE 364 <- [1,6,null,{"value":null}]
08:43:30 INFO - 1500997410047 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
08:43:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 325ms
08:43:30 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
08:43:30 INFO - 1500997410048 Marionette TRACE 364 <- [1,7,null,{}]
08:43:30 INFO - 1500997410050 Marionette DEBUG Closed connection 364
08:43:30 INFO - 1500997410051 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49776
08:43:30 INFO - 1500997410051 Marionette DEBUG Closed connection 365
08:43:30 INFO - 1500997410052 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49777
08:43:30 INFO - 1500997410053 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410054 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410056 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410059 Marionette TRACE 366 <- [1,1,null,{"sessionId":"1380eb88-aa6c-463d-8f74-30f12414655e","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410060 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
08:43:30 INFO - 1500997410060 Marionette TRACE 366 <- [1,2,null,{}]
08:43:30 INFO - 1500997410061 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:30 INFO - 1500997410062 Marionette TRACE 366 <- [1,3,null,{}]
08:43:30 INFO - 1500997410063 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:30 INFO - 1500997410063 Marionette TRACE 366 <- [1,4,null,{}]
08:43:30 INFO - 1500997410064 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}]
08:43:30 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500997410067 Marionette TRACE 366 <- [1,5,null,{"value":null}]
08:43:30 INFO - 1500997410068 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
08:43:30 INFO - 1500997410069 Marionette TRACE 366 <- [1,6,null,{}]
08:43:30 INFO - 1500997410070 Marionette DEBUG Closed connection 366
08:43:30 INFO - 1500997410071 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49778
08:43:30 INFO - 1500997410072 Marionette DEBUG Closed connection 367
08:43:30 INFO - 1500997410072 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49779
08:43:30 INFO - 1500997410073 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410074 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410076 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410079 Marionette TRACE 368 <- [1,1,null,{"sessionId":"a91abb8c-42b5-40ed-88ec-ee9ebcc86367","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410080 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
08:43:30 INFO - 1500997410081 Marionette TRACE 368 <- [1,2,null,{}]
08:43:30 INFO - 1500997410082 Marionette DEBUG Closed connection 368
08:43:30 INFO - 1500997410084 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49780
08:43:30 INFO - 1500997410085 Marionette DEBUG Closed connection 369
08:43:30 INFO - 1500997410086 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49781
08:43:30 INFO - 1500997410087 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:30 INFO - 1500997410087 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410089 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410092 Marionette TRACE 370 <- [1,1,null,{"sessionId":"bf50800d-4008-474a-b6cb-b792d484789c","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410098 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"}]
08:43:30 INFO - 1500997410100 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"
08:43:30 INFO - 1500997410102 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"
08:43:30 INFO - 1500997410102 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"
08:43:30 INFO - 1500997410107 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"
08:43:30 INFO - 1500997410110 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"
08:43:30 INFO - 1500997410116 Marionette TRACE 370 <- [1,2,null,{}]
08:43:30 INFO - 1500997410119 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
08:43:30 INFO - 1500997410121 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3e91163a-9bbd-4224-a418-e36b3615f413","ELEMENT":"3e91163a-9bbd-4224-a418-e36b3615f413"}}]
08:43:30 INFO - 1500997410121 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"3e91163a-9bbd-4224-a418-e36b3615f413"}]
08:43:30 INFO - 1500997410358 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:30 INFO - 1500997410359 Marionette TRACE 370 <- [1,4,null,{}]
08:43:30 INFO - 1500997410360 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"3e91163a-9bbd-4224-a418-e36b3615f413","name":"selected"}]
08:43:30 INFO - 1500997410364 Marionette TRACE 370 <- [1,5,null,{"value":true}]
08:43:30 INFO - 1500997410366 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}]
08:43:30 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500997410368 Marionette TRACE 370 <- [1,6,null,{"value":null}]
08:43:30 INFO - 1500997410369 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
08:43:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 321ms
08:43:30 INFO - 1500997410370 Marionette TRACE 370 <- [1,7,null,{}]
08:43:30 INFO - TEST-START | test_click.py TestClick.test_css_transforms
08:43:30 INFO - 1500997410371 Marionette DEBUG Closed connection 370
08:43:30 INFO - 1500997410373 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49782
08:43:30 INFO - 1500997410373 Marionette DEBUG Closed connection 371
08:43:30 INFO - 1500997410374 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49783
08:43:30 INFO - 1500997410375 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410375 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410377 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410380 Marionette TRACE 372 <- [1,1,null,{"sessionId":"751a72d1-a2c9-4ac1-a7a7-ce27863d3a1e","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410381 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
08:43:30 INFO - 1500997410381 Marionette TRACE 372 <- [1,2,null,{}]
08:43:30 INFO - 1500997410382 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:30 INFO - 1500997410383 Marionette TRACE 372 <- [1,3,null,{}]
08:43:30 INFO - 1500997410383 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:30 INFO - 1500997410384 Marionette TRACE 372 <- [1,4,null,{}]
08:43:30 INFO - 1500997410385 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}]
08:43:30 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500997410387 Marionette TRACE 372 <- [1,5,null,{"value":null}]
08:43:30 INFO - 1500997410388 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
08:43:30 INFO - 1500997410390 Marionette TRACE 372 <- [1,6,null,{}]
08:43:30 INFO - 1500997410391 Marionette DEBUG Closed connection 372
08:43:30 INFO - 1500997410392 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49784
08:43:30 INFO - 1500997410392 Marionette DEBUG Closed connection 373
08:43:30 INFO - 1500997410393 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49785
08:43:30 INFO - 1500997410394 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410395 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410397 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410400 Marionette TRACE 374 <- [1,1,null,{"sessionId":"cca9d634-fb30-4cea-bc2a-ee69e2f5ec06","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410401 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
08:43:30 INFO - 1500997410402 Marionette TRACE 374 <- [1,2,null,{}]
08:43:30 INFO - 1500997410403 Marionette DEBUG Closed connection 374
08:43:30 INFO - 1500997410404 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49786
08:43:30 INFO - 1500997410404 Marionette DEBUG Closed connection 375
08:43:30 INFO - 1500997410405 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49787
08:43:30 INFO - 1500997410406 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:30 INFO - 1500997410407 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410409 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410411 Marionette TRACE 376 <- [1,1,null,{"sessionId":"77f55d5f-c287-4d45-9e38-993d4295ba2a","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410412 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"}]
08:43:30 INFO - 1500997410414 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"
08:43:30 INFO - 1500997410416 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"
08:43:30 INFO - 1500997410416 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"
08:43:30 INFO - 1500997410421 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"
08:43:30 INFO - 1500997410423 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"
08:43:30 INFO - 1500997410427 Marionette TRACE 376 <- [1,2,null,{}]
08:43:30 INFO - 1500997410435 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
08:43:30 INFO - 1500997410437 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c985194b-1713-44f1-bc5e-50a56748990a","ELEMENT":"c985194b-1713-44f1-bc5e-50a56748990a"}}]
08:43:30 INFO - 1500997410438 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"c985194b-1713-44f1-bc5e-50a56748990a"}]
08:43:30 INFO - 1500997410677 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:30 INFO - 1500997410678 Marionette TRACE 376 <- [1,4,null,{}]
08:43:30 INFO - 1500997410680 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}]
08:43:30 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500997410683 Marionette TRACE 376 <- [1,5,null,{"value":null}]
08:43:30 INFO - 1500997410684 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
08:43:30 INFO - 1500997410685 Marionette TRACE 376 <- [1,6,null,{}]
08:43:30 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 315ms
08:43:30 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
08:43:30 INFO - 1500997410686 Marionette DEBUG Closed connection 376
08:43:30 INFO - 1500997410688 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49788
08:43:30 INFO - 1500997410689 Marionette DEBUG Closed connection 377
08:43:30 INFO - 1500997410689 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49789
08:43:30 INFO - 1500997410690 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410691 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410693 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410696 Marionette TRACE 378 <- [1,1,null,{"sessionId":"210d81b6-1b3d-4b9b-93ae-5d45d2b35e1a","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410697 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
08:43:30 INFO - 1500997410697 Marionette TRACE 378 <- [1,2,null,{}]
08:43:30 INFO - 1500997410698 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:30 INFO - 1500997410699 Marionette TRACE 378 <- [1,3,null,{}]
08:43:30 INFO - 1500997410699 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:30 INFO - 1500997410700 Marionette TRACE 378 <- [1,4,null,{}]
08:43:30 INFO - 1500997410702 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}]
08:43:30 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500997410704 Marionette TRACE 378 <- [1,5,null,{"value":null}]
08:43:30 INFO - 1500997410705 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
08:43:30 INFO - 1500997410706 Marionette TRACE 378 <- [1,6,null,{}]
08:43:30 INFO - 1500997410708 Marionette DEBUG Closed connection 378
08:43:30 INFO - 1500997410708 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49790
08:43:30 INFO - 1500997410709 Marionette DEBUG Closed connection 379
08:43:30 INFO - 1500997410709 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49791
08:43:30 INFO - 1500997410710 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:30 INFO - 1500997410711 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410713 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410716 Marionette TRACE 380 <- [1,1,null,{"sessionId":"42b4bfb1-2d03-4af0-85f4-fd7825f0c9f3","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410717 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
08:43:30 INFO - 1500997410718 Marionette TRACE 380 <- [1,2,null,{}]
08:43:30 INFO - 1500997410719 Marionette DEBUG Closed connection 380
08:43:30 INFO - 1500997410720 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49792
08:43:30 INFO - 1500997410720 Marionette DEBUG Closed connection 381
08:43:30 INFO - 1500997410721 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49793
08:43:30 INFO - 1500997410722 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:30 INFO - 1500997410723 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:30 INFO - 1500997410724 Marionette DEBUG Register listener.js for window 4294967297
08:43:30 INFO - 1500997410727 Marionette TRACE 382 <- [1,1,null,{"sessionId":"328d2bd7-8562-4cc4-a84a-ee7a1e413493","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:30 INFO - 1500997410728 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"}]
08:43:30 INFO - 1500997410730 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"
08:43:30 INFO - 1500997410731 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"
08:43:30 INFO - 1500997410732 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"
08:43:30 INFO - 1500997410737 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"
08:43:30 INFO - 1500997410739 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"
08:43:30 INFO - 1500997410742 Marionette TRACE 382 <- [1,2,null,{}]
08:43:30 INFO - 1500997410749 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
08:43:30 INFO - 1500997410751 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1129284e-6722-49be-b399-b22965836431","ELEMENT":"1129284e-6722-49be-b399-b22965836431"}}]
08:43:30 INFO - 1500997410752 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"1129284e-6722-49be-b399-b22965836431"}]
08:43:30 INFO - 1500997410988 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:30 INFO - 1500997410989 Marionette TRACE 382 <- [1,4,null,{}]
08:43:30 INFO - 1500997410991 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}]
08:43:30 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500997410993 Marionette TRACE 382 <- [1,5,null,{"value":null}]
08:43:30 INFO - 1500997410994 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
08:43:30 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 309ms
08:43:31 INFO - 1500997410995 Marionette TRACE 382 <- [1,6,null,{}]
08:43:31 INFO - TEST-START | test_click.py TestClick.test_input_file
08:43:31 INFO - 1500997410997 Marionette DEBUG Closed connection 382
08:43:31 INFO - 1500997410998 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49794
08:43:31 INFO - 1500997410998 Marionette DEBUG Closed connection 383
08:43:31 INFO - 1500997410999 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49795
08:43:31 INFO - 1500997411000 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411000 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411003 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411005 Marionette TRACE 384 <- [1,1,null,{"sessionId":"24201e81-c9a6-4812-82fd-6e3fafcfd751","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411007 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
08:43:31 INFO - 1500997411007 Marionette TRACE 384 <- [1,2,null,{}]
08:43:31 INFO - 1500997411008 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:31 INFO - 1500997411008 Marionette TRACE 384 <- [1,3,null,{}]
08:43:31 INFO - 1500997411009 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:31 INFO - 1500997411010 Marionette TRACE 384 <- [1,4,null,{}]
08:43:31 INFO - 1500997411012 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}]
08:43:31 INFO - TEST-START: test_click.py TestClick.test_input_file1500997411015 Marionette TRACE 384 <- [1,5,null,{"value":null}]
08:43:31 INFO - 1500997411015 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
08:43:31 INFO - 1500997411017 Marionette TRACE 384 <- [1,6,null,{}]
08:43:31 INFO - 1500997411018 Marionette DEBUG Closed connection 384
08:43:31 INFO - 1500997411018 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49796
08:43:31 INFO - 1500997411019 Marionette DEBUG Closed connection 385
08:43:31 INFO - 1500997411020 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49797
08:43:31 INFO - 1500997411021 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411021 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411024 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411033 Marionette TRACE 386 <- [1,1,null,{"sessionId":"256cf47d-2895-420e-b686-7ea386a9323a","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411034 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
08:43:31 INFO - 1500997411036 Marionette TRACE 386 <- [1,2,null,{}]
08:43:31 INFO - 1500997411037 Marionette DEBUG Closed connection 386
08:43:31 INFO - 1500997411037 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49798
08:43:31 INFO - 1500997411038 Marionette DEBUG Closed connection 387
08:43:31 INFO - 1500997411039 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49799
08:43:31 INFO - 1500997411040 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:31 INFO - 1500997411040 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411042 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411045 Marionette TRACE 388 <- [1,1,null,{"sessionId":"d10954b9-6f56-4f9f-b338-81a6aaaaa263","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411046 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
08:43:31 INFO - 1500997411048 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"
08:43:31 INFO - 1500997411049 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"
08:43:31 INFO - 1500997411049 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"
08:43:31 INFO - 1500997411055 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:31 INFO - 1500997411058 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:31 INFO - 1500997411059 Marionette TRACE 388 <- [1,2,null,{}]
08:43:31 INFO - 1500997411066 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
08:43:31 INFO - 1500997411069 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"77f0c035-5ea0-4861-9689-664bb2207e19","ELEMENT":"77f0c035-5ea0-4861-9689-664bb2207e19"}}]
08:43:31 INFO - 1500997411070 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"77f0c035-5ea0-4861-9689-664bb2207e19"}]
08:43:31 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 110ms
08:43:31 INFO - TEST-START | test_click.py TestClick.test_obscured_element
08:43:31 INFO - 1500997411100 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
08:43:31 INFO - 1500997411102 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}]
08:43:31 INFO - TEST-END: test_click.py TestClick.test_input_file1500997411104 Marionette TRACE 388 <- [1,5,null,{"value":null}]
08:43:31 INFO - 1500997411105 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
08:43:31 INFO - 1500997411106 Marionette TRACE 388 <- [1,6,null,{}]
08:43:31 INFO - 1500997411107 Marionette DEBUG Closed connection 388
08:43:31 INFO - 1500997411108 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49800
08:43:31 INFO - 1500997411109 Marionette DEBUG Closed connection 389
08:43:31 INFO - 1500997411110 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49801
08:43:31 INFO - 1500997411111 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411111 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411114 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411116 Marionette TRACE 390 <- [1,1,null,{"sessionId":"d2102b6a-b2e3-42c6-af66-5e0d5323d590","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411118 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
08:43:31 INFO - 1500997411118 Marionette TRACE 390 <- [1,2,null,{}]
08:43:31 INFO - 1500997411119 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:31 INFO - 1500997411120 Marionette TRACE 390 <- [1,3,null,{}]
08:43:31 INFO - 1500997411120 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:31 INFO - 1500997411121 Marionette TRACE 390 <- [1,4,null,{}]
08:43:31 INFO - 1500997411122 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}]
08:43:31 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500997411125 Marionette TRACE 390 <- [1,5,null,{"value":null}]
08:43:31 INFO - 1500997411126 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
08:43:31 INFO - 1500997411127 Marionette TRACE 390 <- [1,6,null,{}]
08:43:31 INFO - 1500997411128 Marionette DEBUG Closed connection 390
08:43:31 INFO - 1500997411129 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49802
08:43:31 INFO - 1500997411129 Marionette DEBUG Closed connection 391
08:43:31 INFO - 1500997411130 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49803
08:43:31 INFO - 1500997411130 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411131 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411133 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411136 Marionette TRACE 392 <- [1,1,null,{"sessionId":"9f07dd54-69c0-4bfc-a0e6-c9a07c9231cc","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411137 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
08:43:31 INFO - 1500997411138 Marionette TRACE 392 <- [1,2,null,{}]
08:43:31 INFO - 1500997411139 Marionette DEBUG Closed connection 392
08:43:31 INFO - 1500997411140 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49804
08:43:31 INFO - 1500997411141 Marionette DEBUG Closed connection 393
08:43:31 INFO - 1500997411141 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49805
08:43:31 INFO - 1500997411142 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:31 INFO - 1500997411143 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411145 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411147 Marionette TRACE 394 <- [1,1,null,{"sessionId":"9ce444ec-e826-40c4-a399-094b51fcbd36","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411149 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"}]
08:43:31 INFO - 1500997411150 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:31 INFO - 1500997411152 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:31 INFO - 1500997411152 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:31 INFO - 1500997411158 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"
08:43:31 INFO - 1500997411160 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"
08:43:31 INFO - 1500997411167 Marionette TRACE 394 <- [1,2,null,{}]
08:43:31 INFO - 1500997411170 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
08:43:31 INFO - 1500997411172 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"75d43db3-f89b-475e-9b55-d69107db655c","ELEMENT":"75d43db3-f89b-475e-9b55-d69107db655c"}}]
08:43:31 INFO - 1500997411173 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
08:43:31 INFO - 1500997411175 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5200e0d5-15a4-4694-8edc-c2220b534343","ELEMENT":"5200e0d5-15a4-4694-8edc-c2220b534343"}}]
08:43:31 INFO - 1500997411176 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"75d43db3-f89b-475e-9b55-d69107db655c"}]
08:43:31 INFO - 1500997411413 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:31 INFO - 1500997411413 Marionette TRACE 394 <- [1,5,null,{}]
08:43:31 INFO - 1500997411415 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"5200e0d5-15a4-4694-8edc-c2220b534343"}]
08:43:31 INFO - 1500997411428 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
08:43:31 INFO - 1500997411430 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
08:43:31 INFO - 1500997411433 Marionette TRACE 394 <- [1,7,null,{"value":false}]
08:43:31 INFO - 1500997411434 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}]
08:43:31 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500997411437 Marionette TRACE 394 <- [1,8,null,{"value":null}]
08:43:31 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 332ms
08:43:31 INFO - 1500997411437 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
08:43:31 INFO - 1500997411439 Marionette TRACE 394 <- [1,9,null,{}]
08:43:31 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
08:43:31 INFO - 1500997411440 Marionette DEBUG Closed connection 394
08:43:31 INFO - 1500997411441 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49806
08:43:31 INFO - 1500997411442 Marionette DEBUG Closed connection 395
08:43:31 INFO - 1500997411443 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49807
08:43:31 INFO - 1500997411444 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411445 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411447 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411450 Marionette TRACE 396 <- [1,1,null,{"sessionId":"1b962ccd-98ae-42b3-9b7d-d17f50c2af99","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411451 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
08:43:31 INFO - 1500997411451 Marionette TRACE 396 <- [1,2,null,{}]
08:43:31 INFO - 1500997411452 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:31 INFO - 1500997411452 Marionette TRACE 396 <- [1,3,null,{}]
08:43:31 INFO - 1500997411453 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:31 INFO - 1500997411454 Marionette TRACE 396 <- [1,4,null,{}]
08:43:31 INFO - 1500997411456 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}]
08:43:31 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500997411458 Marionette TRACE 396 <- [1,5,null,{"value":null}]
08:43:31 INFO - 1500997411459 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
08:43:31 INFO - 1500997411460 Marionette TRACE 396 <- [1,6,null,{}]
08:43:31 INFO - 1500997411461 Marionette DEBUG Closed connection 396
08:43:31 INFO - 1500997411462 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49808
08:43:31 INFO - 1500997411463 Marionette DEBUG Closed connection 397
08:43:31 INFO - 1500997411463 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49809
08:43:31 INFO - 1500997411464 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:31 INFO - 1500997411465 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411467 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411470 Marionette TRACE 398 <- [1,1,null,{"sessionId":"3fd6b521-ae4e-4669-bc5a-9f2be77cce5a","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411471 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
08:43:31 INFO - 1500997411472 Marionette TRACE 398 <- [1,2,null,{}]
08:43:31 INFO - 1500997411473 Marionette DEBUG Closed connection 398
08:43:31 INFO - 1500997411474 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49810
08:43:31 INFO - 1500997411474 Marionette DEBUG Closed connection 399
08:43:31 INFO - 1500997411475 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49811
08:43:31 INFO - 1500997411476 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:31 INFO - 1500997411477 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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}
08:43:31 INFO - 1500997411479 Marionette DEBUG Register listener.js for window 4294967297
08:43:31 INFO - 1500997411482 Marionette TRACE 400 <- [1,1,null,{"sessionId":"ff9dd647-1679-432d-bd0b-cd8e111693cb","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":3028,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmpcfxutm.mozrunner","moz:accessibilityChecks":false}}]
08:43:31 INFO - 1500997411483 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"}]
08:43:31 INFO - 1500997411485 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"
08:43:31 INFO - 1500997411487 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"
08:43:31 INFO - 1500997411487 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"
08:43:31 INFO - 1500997411492 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"
08:43:31 INFO - 1500997411494 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"
08:43:31 INFO - 1500997411502 Marionette TRACE 400 <- [1,2,null,{}]
08:43:31 INFO - 1500997411505 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
08:43:31 INFO - 1500997411507 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ae295be3-4a30-4a12-a6da-9f53926031be","ELEMENT":"ae295be3-4a30-4a12-a6da-9f53926031be"}}]
08:43:31 INFO - 1500997411508 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"ae295be3-4a30-4a12-a6da-9f53926031be"}]
08:43:31 INFO - 1500997411535 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
08:43:31 INFO - 1500997411536 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"ae295be3-4a30-4a12-a6da-9f53926031be"}]
08:43:31 INFO - 1500997411550 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element