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:1330:5\n"},null]
13:33:26 INFO - 1498941206742 Marionette TRACE 358 -> [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}]
13:33:26 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498941206746 Marionette TRACE 358 <- [1,5,null,{"value":null}]
13:33:26 INFO - 1498941206748 Marionette TRACE 358 -> [0,6,"deleteSession",{}]
13:33:26 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 143ms
13:33:26 INFO - 1498941206749 Marionette TRACE 358 <- [1,6,null,{}]
13:33:26 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
13:33:26 INFO - 1498941206752 Marionette DEBUG Closed connection 358
13:33:26 INFO - 1498941206753 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49715
13:33:26 INFO - 1498941206754 Marionette DEBUG Closed connection 359
13:33:26 INFO - 1498941206755 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49716
13:33:26 INFO - 1498941206756 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:26 INFO - 1498941206757 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:26 INFO - 1498941206760 Marionette DEBUG Register listener.js for window 7
13:33:26 INFO - 1498941206764 Marionette TRACE 360 <- [1,1,null,{"sessionId":"1fe34a7e-fadb-4887-9415-68dc9192632c","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:26 INFO - 1498941206765 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
13:33:26 INFO - 1498941206765 Marionette TRACE 360 <- [1,2,null,{}]
13:33:26 INFO - 1498941206766 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:26 INFO - 1498941206767 Marionette TRACE 360 <- [1,3,null,{}]
13:33:26 INFO - 1498941206767 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:26 INFO - 1498941206768 Marionette TRACE 360 <- [1,4,null,{}]
13:33:26 INFO - 1498941206769 Marionette TRACE 360 -> [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}]
13:33:26 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498941206772 Marionette TRACE 360 <- [1,5,null,{"value":null}]
13:33:26 INFO - 1498941206773 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
13:33:26 INFO - 1498941206774 Marionette TRACE 360 <- [1,6,null,{}]
13:33:26 INFO - 1498941206776 Marionette DEBUG Closed connection 360
13:33:26 INFO - 1498941206777 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49717
13:33:26 INFO - 1498941206778 Marionette DEBUG Closed connection 361
13:33:26 INFO - 1498941206778 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49718
13:33:26 INFO - 1498941206779 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:26 INFO - 1498941206780 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:26 INFO - 1498941206782 Marionette DEBUG Register listener.js for window 7
13:33:26 INFO - 1498941206793 Marionette TRACE 362 <- [1,1,null,{"sessionId":"dc5f6ae6-593f-41fe-ae74-19ab74de5bbd","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:26 INFO - 1498941206794 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
13:33:26 INFO - 1498941206795 Marionette TRACE 362 <- [1,2,null,{}]
13:33:26 INFO - 1498941206797 Marionette DEBUG Closed connection 362
13:33:26 INFO - 1498941206798 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49719
13:33:26 INFO - 1498941206798 Marionette DEBUG Closed connection 363
13:33:26 INFO - 1498941206799 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49720
13:33:26 INFO - 1498941206800 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:26 INFO - 1498941206801 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:26 INFO - 1498941206803 Marionette DEBUG Register listener.js for window 7
13:33:26 INFO - 1498941206806 Marionette TRACE 364 <- [1,1,null,{"sessionId":"f6438b21-a6c9-405a-9203-e894631fe1a2","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:26 INFO - 1498941206807 Marionette TRACE 364 -> [0,2,"get",{"url":"http://127.0.0.1:49321/clicks.html"}]
13:33:26 INFO - 1498941206809 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49321/hidden.html"
13:33:26 INFO - 1498941206814 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49321/hidden.html"
13:33:26 INFO - 1498941206814 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49321/hidden.html"
13:33:26 INFO - 1498941206841 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49321/clicks.html"
13:33:26 INFO - 1498941206843 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49321/clicks.html"
13:33:26 INFO - 1498941206846 Marionette TRACE 364 <- [1,2,null,{}]
13:33:26 INFO - 1498941206847 Marionette TRACE 364 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
13:33:26 INFO - 1498941206856 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3d2cb9e1-eba1-4f3d-bdf3-087878021b41","ELEMENT":"3d2cb9e1-eba1-4f3d-bdf3-087878021b41"}}]
13:33:26 INFO - 1498941206857 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"3d2cb9e1-eba1-4f3d-bdf3-087878021b41"}]
13:33:26 INFO - 1498941206901 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49321/clicks.html"
13:33:26 INFO - 1498941206912 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49321/clicks.html"
13:33:26 INFO - 1498941206912 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49321/clicks.html"
13:33:26 INFO - 1498941206957 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49321/test.html"
13:33:26 INFO - 1498941206961 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49321/test.html"
13:33:26 INFO - 1498941206965 Marionette TRACE 364 <- [1,4,null,{}]
13:33:26 INFO - 1498941206972 Marionette TRACE 364 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
13:33:26 INFO - 1498941206975 Marionette TRACE 364 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2632e325-6326-409e-8070-4f3e6b49d2db","ELEMENT":"2632e325-6326-409e-8070-4f3e6b49d2db"}}]
13:33:26 INFO - 1498941206976 Marionette TRACE 364 -> [0,6,"getTitle",{}]
13:33:26 INFO - 1498941206977 Marionette TRACE 364 <- [1,6,null,{"value":"Marionette Test"}]
13:33:26 INFO - 1498941206979 Marionette TRACE 364 -> [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}]
13:33:26 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498941206981 Marionette TRACE 364 <- [1,7,null,{"value":null}]
13:33:26 INFO - 1498941206982 Marionette TRACE 364 -> [0,8,"deleteSession",{}]
13:33:26 INFO - 1498941206984 Marionette TRACE 364 <- [1,8,null,{}]
13:33:26 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 235ms
13:33:26 INFO - TEST-START | test_click.py TestClick.test_container_element
13:33:26 INFO - 1498941206986 Marionette DEBUG Closed connection 364
13:33:26 INFO - 1498941206987 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49723
13:33:26 INFO - 1498941206988 Marionette DEBUG Closed connection 365
13:33:26 INFO - 1498941206988 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49724
13:33:26 INFO - 1498941206989 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:26 INFO - 1498941206990 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:26 INFO - 1498941206993 Marionette DEBUG Register listener.js for window 7
13:33:26 INFO - 1498941206996 Marionette TRACE 366 <- [1,1,null,{"sessionId":"e9eaa664-74a4-49fa-817d-e1db74646fd6","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:26 INFO - 1498941206997 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
13:33:27 INFO - 1498941206998 Marionette TRACE 366 <- [1,2,null,{}]
13:33:27 INFO - 1498941206999 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:27 INFO - 1498941206999 Marionette TRACE 366 <- [1,3,null,{}]
13:33:27 INFO - 1498941207000 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:27 INFO - 1498941207001 Marionette TRACE 366 <- [1,4,null,{}]
13:33:27 INFO - 1498941207003 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')","sandbox":"simpletest","line":316}]
13:33:27 INFO - TEST-START: test_click.py TestClick.test_container_element1498941207005 Marionette TRACE 366 <- [1,5,null,{"value":null}]
13:33:27 INFO - 1498941207007 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
13:33:27 INFO - 1498941207009 Marionette TRACE 366 <- [1,6,null,{}]
13:33:27 INFO - 1498941207015 Marionette DEBUG Closed connection 366
13:33:27 INFO - 1498941207015 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49725
13:33:27 INFO - 1498941207016 Marionette DEBUG Closed connection 367
13:33:27 INFO - 1498941207017 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49726
13:33:27 INFO - 1498941207018 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:27 INFO - 1498941207018 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207021 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207025 Marionette TRACE 368 <- [1,1,null,{"sessionId":"633f2370-6b32-44c5-ba51-4eaebb46b998","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207026 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
13:33:27 INFO - 1498941207027 Marionette TRACE 368 <- [1,2,null,{}]
13:33:27 INFO - 1498941207029 Marionette DEBUG Closed connection 368
13:33:27 INFO - 1498941207030 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49727
13:33:27 INFO - 1498941207030 Marionette DEBUG Closed connection 369
13:33:27 INFO - 1498941207031 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49728
13:33:27 INFO - 1498941207032 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:27 INFO - 1498941207033 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207035 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207039 Marionette TRACE 370 <- [1,1,null,{"sessionId":"1c048963-2a0c-4abc-a3de-db9a0f04f241","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207040 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%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"}]
13:33:27 INFO - 1498941207041 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49321/test.html"
13:33:27 INFO - 1498941207043 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49321/test.html"
13:33:27 INFO - 1498941207044 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49321/test.html"
13:33:27 INFO - 1498941207070 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"
13:33:27 INFO - 1498941207072 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"
13:33:27 INFO - 1498941207076 Marionette TRACE 370 <- [1,2,null,{}]
13:33:27 INFO - 1498941207082 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
13:33:27 INFO - 1498941207090 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a72fb66f-840b-4d15-abe5-d5016881bec8","ELEMENT":"a72fb66f-840b-4d15-abe5-d5016881bec8"}}]
13:33:27 INFO - 1498941207098 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"a72fb66f-840b-4d15-abe5-d5016881bec8"}]
13:33:27 INFO - 1498941207352 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:33:27 INFO - 1498941207353 Marionette TRACE 370 <- [1,4,null,{}]
13:33:27 INFO - 1498941207354 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"a72fb66f-840b-4d15-abe5-d5016881bec8","name":"selected"}]
13:33:27 INFO - 1498941207358 Marionette TRACE 370 <- [1,5,null,{"value":true}]
13:33:27 INFO - 1498941207360 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')","sandbox":"simpletest","line":328}]
13:33:27 INFO - TEST-END: test_click.py TestClick.test_container_element1498941207363 Marionette TRACE 370 <- [1,6,null,{"value":null}]
13:33:27 INFO - 1498941207364 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
13:33:27 INFO - 1498941207365 Marionette TRACE 370 <- [1,7,null,{}]
13:33:27 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 381ms
13:33:27 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
13:33:27 INFO - 1498941207367 Marionette DEBUG Closed connection 370
13:33:27 INFO - 1498941207368 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49729
13:33:27 INFO - 1498941207369 Marionette DEBUG Closed connection 371
13:33:27 INFO - 1498941207370 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49730
13:33:27 INFO - 1498941207371 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:27 INFO - 1498941207371 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207374 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207377 Marionette TRACE 372 <- [1,1,null,{"sessionId":"b7c9608a-baed-4856-981b-a6281f0787ca","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207379 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
13:33:27 INFO - 1498941207379 Marionette TRACE 372 <- [1,2,null,{}]
13:33:27 INFO - 1498941207380 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:27 INFO - 1498941207380 Marionette TRACE 372 <- [1,3,null,{}]
13:33:27 INFO - 1498941207381 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:27 INFO - 1498941207382 Marionette TRACE 372 <- [1,4,null,{}]
13:33:27 INFO - 1498941207384 Marionette TRACE 372 -> [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}]
13:33:27 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498941207386 Marionette TRACE 372 <- [1,5,null,{"value":null}]
13:33:27 INFO - 1498941207387 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
13:33:27 INFO - 1498941207388 Marionette TRACE 372 <- [1,6,null,{}]
13:33:27 INFO - 1498941207390 Marionette DEBUG Closed connection 372
13:33:27 INFO - 1498941207391 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49731
13:33:27 INFO - 1498941207392 Marionette DEBUG Closed connection 373
13:33:27 INFO - 1498941207392 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49732
13:33:27 INFO - 1498941207394 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:27 INFO - 1498941207394 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207397 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207400 Marionette TRACE 374 <- [1,1,null,{"sessionId":"1b65ae15-266e-4ad1-9010-e87521daf8db","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207401 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
13:33:27 INFO - 1498941207402 Marionette TRACE 374 <- [1,2,null,{}]
13:33:27 INFO - 1498941207405 Marionette DEBUG Closed connection 374
13:33:27 INFO - 1498941207405 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49733
13:33:27 INFO - 1498941207406 Marionette DEBUG Closed connection 375
13:33:27 INFO - 1498941207407 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49734
13:33:27 INFO - 1498941207408 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:27 INFO - 1498941207408 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207411 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207414 Marionette TRACE 376 <- [1,1,null,{"sessionId":"501b64d2-c746-4cfe-be83-344d08954ff8","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207416 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%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"}]
13:33:27 INFO - 1498941207417 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"
13:33:27 INFO - 1498941207421 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"
13:33:27 INFO - 1498941207421 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"
13:33:27 INFO - 1498941207442 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"
13:33:27 INFO - 1498941207444 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"
13:33:27 INFO - 1498941207453 Marionette TRACE 376 <- [1,2,null,{}]
13:33:27 INFO - 1498941207463 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
13:33:27 INFO - 1498941207465 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7733c6d6-c924-4e9f-b3e2-901b766977df","ELEMENT":"7733c6d6-c924-4e9f-b3e2-901b766977df"}}]
13:33:27 INFO - 1498941207466 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7733c6d6-c924-4e9f-b3e2-901b766977df"}]
13:33:27 INFO - 1498941207711 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:33:27 INFO - 1498941207712 Marionette TRACE 376 <- [1,4,null,{}]
13:33:27 INFO - 1498941207713 Marionette TRACE 376 -> [0,5,"getElementProperty",{"id":"7733c6d6-c924-4e9f-b3e2-901b766977df","name":"selected"}]
13:33:27 INFO - 1498941207717 Marionette TRACE 376 <- [1,5,null,{"value":true}]
13:33:27 INFO - 1498941207719 Marionette TRACE 376 -> [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}]
13:33:27 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498941207721 Marionette TRACE 376 <- [1,6,null,{"value":null}]
13:33:27 INFO - 1498941207722 Marionette TRACE 376 -> [0,7,"deleteSession",{}]
13:33:27 INFO - 1498941207723 Marionette TRACE 376 <- [1,7,null,{}]
13:33:27 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 357ms
13:33:27 INFO - TEST-START | test_click.py TestClick.test_css_transforms
13:33:27 INFO - 1498941207726 Marionette DEBUG Closed connection 376
13:33:27 INFO - 1498941207726 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49735
13:33:27 INFO - 1498941207727 Marionette DEBUG Closed connection 377
13:33:27 INFO - 1498941207728 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49736
13:33:27 INFO - 1498941207729 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:27 INFO - 1498941207730 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207732 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207735 Marionette TRACE 378 <- [1,1,null,{"sessionId":"4ef73ba6-2758-477f-9c05-ade528653965","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207737 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
13:33:27 INFO - 1498941207737 Marionette TRACE 378 <- [1,2,null,{}]
13:33:27 INFO - 1498941207738 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:27 INFO - 1498941207738 Marionette TRACE 378 <- [1,3,null,{}]
13:33:27 INFO - 1498941207739 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:27 INFO - 1498941207739 Marionette TRACE 378 <- [1,4,null,{}]
13:33:27 INFO - 1498941207741 Marionette TRACE 378 -> [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}]
13:33:27 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498941207744 Marionette TRACE 378 <- [1,5,null,{"value":null}]
13:33:27 INFO - 1498941207745 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
13:33:27 INFO - 1498941207746 Marionette TRACE 378 <- [1,6,null,{}]
13:33:27 INFO - 1498941207748 Marionette DEBUG Closed connection 378
13:33:27 INFO - 1498941207749 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49737
13:33:27 INFO - 1498941207749 Marionette DEBUG Closed connection 379
13:33:27 INFO - 1498941207750 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49738
13:33:27 INFO - 1498941207751 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:27 INFO - 1498941207751 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207754 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207757 Marionette TRACE 380 <- [1,1,null,{"sessionId":"52d4a2d2-cffb-4494-b679-4aaa780c30d4","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207758 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
13:33:27 INFO - 1498941207760 Marionette TRACE 380 <- [1,2,null,{}]
13:33:27 INFO - 1498941207762 Marionette DEBUG Closed connection 380
13:33:27 INFO - 1498941207762 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49739
13:33:27 INFO - 1498941207763 Marionette DEBUG Closed connection 381
13:33:27 INFO - 1498941207764 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49740
13:33:27 INFO - 1498941207765 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:27 INFO - 1498941207766 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:27 INFO - 1498941207768 Marionette DEBUG Register listener.js for window 7
13:33:27 INFO - 1498941207771 Marionette TRACE 382 <- [1,1,null,{"sessionId":"63e355e2-ab8e-43b4-a627-e63774faf4e7","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:27 INFO - 1498941207772 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%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"}]
13:33:27 INFO - 1498941207774 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"
13:33:27 INFO - 1498941207776 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"
13:33:27 INFO - 1498941207776 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"
13:33:27 INFO - 1498941207796 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"
13:33:27 INFO - 1498941207800 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"
13:33:27 INFO - 1498941207808 Marionette TRACE 382 <- [1,2,null,{}]
13:33:27 INFO - 1498941207809 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
13:33:27 INFO - 1498941207812 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5a3355e3-65c1-4bb7-b3db-f6b4b89aea58","ELEMENT":"5a3355e3-65c1-4bb7-b3db-f6b4b89aea58"}}]
13:33:27 INFO - 1498941207813 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"5a3355e3-65c1-4bb7-b3db-f6b4b89aea58"}]
13:33:28 INFO - 1498941208060 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:33:28 INFO - 1498941208061 Marionette TRACE 382 <- [1,4,null,{}]
13:33:28 INFO - 1498941208062 Marionette TRACE 382 -> [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}]
13:33:28 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498941208065 Marionette TRACE 382 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208066 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208067 Marionette TRACE 382 <- [1,6,null,{}]
13:33:28 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 343ms
13:33:28 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
13:33:28 INFO - 1498941208069 Marionette DEBUG Closed connection 382
13:33:28 INFO - 1498941208070 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49741
13:33:28 INFO - 1498941208071 Marionette DEBUG Closed connection 383
13:33:28 INFO - 1498941208071 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49742
13:33:28 INFO - 1498941208072 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208073 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208076 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208079 Marionette TRACE 384 <- [1,1,null,{"sessionId":"3e7d8d5f-0435-475f-a6ef-72660e865931","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208080 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
13:33:28 INFO - 1498941208081 Marionette TRACE 384 <- [1,2,null,{}]
13:33:28 INFO - 1498941208082 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:28 INFO - 1498941208082 Marionette TRACE 384 <- [1,3,null,{}]
13:33:28 INFO - 1498941208083 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:28 INFO - 1498941208084 Marionette TRACE 384 <- [1,4,null,{}]
13:33:28 INFO - 1498941208085 Marionette TRACE 384 -> [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}]
13:33:28 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498941208088 Marionette TRACE 384 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208089 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208090 Marionette TRACE 384 <- [1,6,null,{}]
13:33:28 INFO - 1498941208092 Marionette DEBUG Closed connection 384
13:33:28 INFO - 1498941208093 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49743
13:33:28 INFO - 1498941208094 Marionette DEBUG Closed connection 385
13:33:28 INFO - 1498941208094 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49744
13:33:28 INFO - 1498941208095 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208096 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208099 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208102 Marionette TRACE 386 <- [1,1,null,{"sessionId":"dc95313d-b390-4c5e-8ace-c8973e604564","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208103 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
13:33:28 INFO - 1498941208104 Marionette TRACE 386 <- [1,2,null,{}]
13:33:28 INFO - 1498941208106 Marionette DEBUG Closed connection 386
13:33:28 INFO - 1498941208107 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49745
13:33:28 INFO - 1498941208108 Marionette DEBUG Closed connection 387
13:33:28 INFO - 1498941208108 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49746
13:33:28 INFO - 1498941208109 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:28 INFO - 1498941208110 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208113 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208116 Marionette TRACE 388 <- [1,1,null,{"sessionId":"c3203172-bf2f-4c67-b40e-e4f06c9f05b5","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208117 Marionette TRACE 388 -> [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"}]
13:33:28 INFO - 1498941208118 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"
13:33:28 INFO - 1498941208121 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"
13:33:28 INFO - 1498941208121 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"
13:33:28 INFO - 1498941208143 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"
13:33:28 INFO - 1498941208145 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"
13:33:28 INFO - 1498941208148 Marionette TRACE 388 <- [1,2,null,{}]
13:33:28 INFO - 1498941208156 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
13:33:28 INFO - 1498941208158 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"835c6fe8-c5aa-44e4-831c-8c4f2de1d858","ELEMENT":"835c6fe8-c5aa-44e4-831c-8c4f2de1d858"}}]
13:33:28 INFO - 1498941208159 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"835c6fe8-c5aa-44e4-831c-8c4f2de1d858"}]
13:33:28 INFO - 1498941208401 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:33:28 INFO - 1498941208402 Marionette TRACE 388 <- [1,4,null,{}]
13:33:28 INFO - 1498941208403 Marionette TRACE 388 -> [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}]
13:33:28 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498941208406 Marionette TRACE 388 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208407 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208408 Marionette TRACE 388 <- [1,6,null,{}]
13:33:28 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 341ms
13:33:28 INFO - TEST-START | test_click.py TestClick.test_input_file
13:33:28 INFO - 1498941208410 Marionette DEBUG Closed connection 388
13:33:28 INFO - 1498941208411 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49747
13:33:28 INFO - 1498941208412 Marionette DEBUG Closed connection 389
13:33:28 INFO - 1498941208413 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49748
13:33:28 INFO - 1498941208414 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208414 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208423 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208426 Marionette TRACE 390 <- [1,1,null,{"sessionId":"1a7b87b8-1998-4b44-a39f-e2754f408855","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208428 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
13:33:28 INFO - 1498941208428 Marionette TRACE 390 <- [1,2,null,{}]
13:33:28 INFO - 1498941208429 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:28 INFO - 1498941208430 Marionette TRACE 390 <- [1,3,null,{}]
13:33:28 INFO - 1498941208431 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:28 INFO - 1498941208431 Marionette TRACE 390 <- [1,4,null,{}]
13:33:28 INFO - 1498941208433 Marionette TRACE 390 -> [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}]
13:33:28 INFO - TEST-START: test_click.py TestClick.test_input_file1498941208436 Marionette TRACE 390 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208437 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208438 Marionette TRACE 390 <- [1,6,null,{}]
13:33:28 INFO - 1498941208440 Marionette DEBUG Closed connection 390
13:33:28 INFO - 1498941208441 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49749
13:33:28 INFO - 1498941208441 Marionette DEBUG Closed connection 391
13:33:28 INFO - 1498941208442 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49750
13:33:28 INFO - 1498941208443 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208444 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208446 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208450 Marionette TRACE 392 <- [1,1,null,{"sessionId":"8bcf1762-c4ee-4f6d-b947-1fd4d7f2eb0c","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208451 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
13:33:28 INFO - 1498941208452 Marionette TRACE 392 <- [1,2,null,{}]
13:33:28 INFO - 1498941208455 Marionette DEBUG Closed connection 392
13:33:28 INFO - 1498941208455 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49751
13:33:28 INFO - 1498941208456 Marionette DEBUG Closed connection 393
13:33:28 INFO - 1498941208456 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49752
13:33:28 INFO - 1498941208457 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:28 INFO - 1498941208458 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208461 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208464 Marionette TRACE 394 <- [1,1,null,{"sessionId":"e1145705-8dbc-47c3-9535-5812ba0d8a9e","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208465 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
13:33:28 INFO - 1498941208466 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"
13:33:28 INFO - 1498941208468 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"
13:33:28 INFO - 1498941208469 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"
13:33:28 INFO - 1498941208481 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:33:28 INFO - 1498941208492 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:33:28 INFO - 1498941208495 Marionette TRACE 394 <- [1,2,null,{}]
13:33:28 INFO - 1498941208497 Marionette TRACE 394 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
13:33:28 INFO - 1498941208504 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"efe27dea-13fa-4a44-95b3-3e697b1602f3","ELEMENT":"efe27dea-13fa-4a44-95b3-3e697b1602f3"}}]
13:33:28 INFO - 1498941208506 Marionette TRACE 394 -> [0,4,"clickElement",{"id":"efe27dea-13fa-4a44-95b3-3e697b1602f3"}]
13:33:28 INFO - 1498941208540 Marionette TRACE 394 <- [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:1330:5\n"},null]
13:33:28 INFO - 1498941208542 Marionette TRACE 394 -> [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}]
13:33:28 INFO - TEST-END: test_click.py TestClick.test_input_file1498941208544 Marionette TRACE 394 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208545 Marionette TRACE 394 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208547 Marionette TRACE 394 <- [1,6,null,{}]
13:33:28 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 138ms
13:33:28 INFO - TEST-START | test_click.py TestClick.test_obscured_element
13:33:28 INFO - 1498941208549 Marionette DEBUG Closed connection 394
13:33:28 INFO - 1498941208550 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49753
13:33:28 INFO - 1498941208551 Marionette DEBUG Closed connection 395
13:33:28 INFO - 1498941208551 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49754
13:33:28 INFO - 1498941208552 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208553 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208556 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208559 Marionette TRACE 396 <- [1,1,null,{"sessionId":"9cea5e72-67e2-4bac-b0a3-fe82028ce02d","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208560 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
13:33:28 INFO - 1498941208561 Marionette TRACE 396 <- [1,2,null,{}]
13:33:28 INFO - 1498941208562 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:28 INFO - 1498941208562 Marionette TRACE 396 <- [1,3,null,{}]
13:33:28 INFO - 1498941208563 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:28 INFO - 1498941208563 Marionette TRACE 396 <- [1,4,null,{}]
13:33:28 INFO - 1498941208565 Marionette TRACE 396 -> [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}]
13:33:28 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498941208568 Marionette TRACE 396 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208569 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208570 Marionette TRACE 396 <- [1,6,null,{}]
13:33:28 INFO - 1498941208572 Marionette DEBUG Closed connection 396
13:33:28 INFO - 1498941208573 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49755
13:33:28 INFO - 1498941208574 Marionette DEBUG Closed connection 397
13:33:28 INFO - 1498941208574 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49756
13:33:28 INFO - 1498941208575 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208576 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208578 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208582 Marionette TRACE 398 <- [1,1,null,{"sessionId":"953aa47b-9daa-45b7-83eb-f1033df15341","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208583 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
13:33:28 INFO - 1498941208584 Marionette TRACE 398 <- [1,2,null,{}]
13:33:28 INFO - 1498941208586 Marionette DEBUG Closed connection 398
13:33:28 INFO - 1498941208587 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49757
13:33:28 INFO - 1498941208588 Marionette DEBUG Closed connection 399
13:33:28 INFO - 1498941208588 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49758
13:33:28 INFO - 1498941208590 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:28 INFO - 1498941208590 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208593 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208596 Marionette TRACE 400 <- [1,1,null,{"sessionId":"d172c957-863b-4a85-9750-48d258cc7a94","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208597 Marionette TRACE 400 -> [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"}]
13:33:28 INFO - 1498941208599 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:33:28 INFO - 1498941208601 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:33:28 INFO - 1498941208601 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:33:28 INFO - 1498941208613 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"
13:33:28 INFO - 1498941208617 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"
13:33:28 INFO - 1498941208626 Marionette TRACE 400 <- [1,2,null,{}]
13:33:28 INFO - 1498941208628 Marionette TRACE 400 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
13:33:28 INFO - 1498941208630 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3b3ba638-43d5-415f-bbdc-8760fe89c069","ELEMENT":"3b3ba638-43d5-415f-bbdc-8760fe89c069"}}]
13:33:28 INFO - 1498941208631 Marionette TRACE 400 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
13:33:28 INFO - 1498941208634 Marionette TRACE 400 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a09f39a7-420a-435e-bc66-68891f221176","ELEMENT":"a09f39a7-420a-435e-bc66-68891f221176"}}]
13:33:28 INFO - 1498941208635 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"3b3ba638-43d5-415f-bbdc-8760fe89c069"}]
13:33:28 INFO - 1498941208913 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:33:28 INFO - 1498941208914 Marionette TRACE 400 <- [1,5,null,{}]
13:33:28 INFO - 1498941208916 Marionette TRACE 400 -> [0,6,"clickElement",{"id":"a09f39a7-420a-435e-bc66-68891f221176"}]
13:33:28 INFO - 1498941208938 Marionette TRACE 400 <- [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:1330:5\n"},null]
13:33:28 INFO - 1498941208940 Marionette TRACE 400 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
13:33:28 INFO - 1498941208944 Marionette TRACE 400 <- [1,7,null,{"value":false}]
13:33:28 INFO - 1498941208947 Marionette TRACE 400 -> [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}]
13:33:28 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498941208951 Marionette TRACE 400 <- [1,8,null,{"value":null}]
13:33:28 INFO - 1498941208953 Marionette TRACE 400 -> [0,9,"deleteSession",{}]
13:33:28 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 408ms
13:33:28 INFO - 1498941208955 Marionette TRACE 400 <- [1,9,null,{}]
13:33:28 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
13:33:28 INFO - 1498941208959 Marionette DEBUG Closed connection 400
13:33:28 INFO - 1498941208960 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49759
13:33:28 INFO - 1498941208962 Marionette DEBUG Closed connection 401
13:33:28 INFO - 1498941208963 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49760
13:33:28 INFO - 1498941208964 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:28 INFO - 1498941208967 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:28 INFO - 1498941208970 Marionette DEBUG Register listener.js for window 7
13:33:28 INFO - 1498941208977 Marionette TRACE 402 <- [1,1,null,{"sessionId":"008398a1-8f75-4ec2-aed0-df5093ff9243","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:28 INFO - 1498941208979 Marionette TRACE 402 -> [0,2,"setTimeouts",{"script":30000}]
13:33:28 INFO - 1498941208980 Marionette TRACE 402 <- [1,2,null,{}]
13:33:28 INFO - 1498941208981 Marionette TRACE 402 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:33:28 INFO - 1498941208982 Marionette TRACE 402 <- [1,3,null,{}]
13:33:28 INFO - 1498941208983 Marionette TRACE 402 -> [0,4,"setTimeouts",{"implicit":0}]
13:33:28 INFO - 1498941208983 Marionette TRACE 402 <- [1,4,null,{}]
13:33:28 INFO - 1498941208986 Marionette TRACE 402 -> [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}]
13:33:28 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498941208991 Marionette TRACE 402 <- [1,5,null,{"value":null}]
13:33:28 INFO - 1498941208992 Marionette TRACE 402 -> [0,6,"deleteSession",{}]
13:33:28 INFO - 1498941208994 Marionette TRACE 402 <- [1,6,null,{}]
13:33:29 INFO - 1498941208997 Marionette DEBUG Closed connection 402
13:33:29 INFO - 1498941208999 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49761
13:33:29 INFO - 1498941209000 Marionette DEBUG Closed connection 403
13:33:29 INFO - 1498941209001 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49762
13:33:29 INFO - 1498941209040 Marionette TRACE 404 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:33:29 INFO - 1498941209042 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:29 INFO - 1498941209045 Marionette DEBUG Register listener.js for window 7
13:33:29 INFO - 1498941209050 Marionette TRACE 404 <- [1,1,null,{"sessionId":"631f9a91-af0e-40be-9b53-b1a9d0787862","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:29 INFO - 1498941209056 Marionette TRACE 404 -> [0,2,"deleteSession",{}]
13:33:29 INFO - 1498941209058 Marionette TRACE 404 <- [1,2,null,{}]
13:33:29 INFO - 1498941209060 Marionette DEBUG Closed connection 404
13:33:29 INFO - 1498941209061 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49763
13:33:29 INFO - 1498941209062 Marionette DEBUG Closed connection 405
13:33:29 INFO - 1498941209063 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49764
13:33:29 INFO - 1498941209064 Marionette TRACE 406 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:33:29 INFO - 1498941209065 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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}
13:33:29 INFO - 1498941209068 Marionette DEBUG Register listener.js for window 7
13:33:29 INFO - 1498941209073 Marionette TRACE 406 <- [1,1,null,{"sessionId":"6897901b-d946-4f5f-ba5c-d966dbe108ba","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":684,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-292.001\\AppData\\Local\\Temp\\tmp7nxyht.mozrunner","moz:accessibilityChecks":false}}]
13:33:29 INFO - 1498941209074 Marionette TRACE 406 -> [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"}]
13:33:29 INFO - 1498941209076 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"
13:33:29 INFO - 1498941209080 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"
13:33:29 INFO - 1498941209081 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"
13:33:29 INFO - 1498941209106 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"
13:33:29 INFO - 1498941209109 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"
13:33:29 INFO - 1498941209115 Marionette TRACE 406 <- [1,2,null,{}]
13:33:29 INFO - 1498941209131 Marionette TRACE 406 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
13:33:29 INFO - 1498941209135 Marionette TRACE 406 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4690d81f-d09f-4022-8325-3b2b1f8ce714","ELEMENT":"4690d81f-d09f-4022-8325-3b2b1f8ce714"}}]
13:33:29 INFO - 1498941209137 Marionette TRACE 406 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"4690d81f-d09f-4022-8325-3b2b1f8ce714"}]
13:33:29 INFO - 1498941209167 Marionette TRACE 406 <- [1,4,null,{"value":"none"}]
13:33:29 INFO - 1498941209168 Marionette TRACE 406 -> [0,5,"clickElement",{"id":"4690d81f-d09f-4022-8325-3b2b1f8ce714"}]
13:33:29 INFO - 1498941209190 Marionette TRACE 406 <- [1,5,{"error":"element click intercepted","message":"Element