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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:28:37 INFO - 1499736517775 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}]
18:28:37 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499736517777 Marionette TRACE 352 <- [1,5,null,{"value":null}]
18:28:37 INFO - 1499736517778 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
18:28:37 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 153ms
18:28:37 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
18:28:37 INFO - 1499736517780 Marionette TRACE 352 <- [1,6,null,{}]
18:28:37 INFO - 1499736517781 Marionette DEBUG Closed connection 352
18:28:37 INFO - 1499736517782 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49775
18:28:37 INFO - 1499736517783 Marionette DEBUG Closed connection 353
18:28:37 INFO - 1499736517784 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49776
18:28:37 INFO - 1499736517785 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:37 INFO - 1499736517785 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:37 INFO - 1499736517788 Marionette DEBUG Register listener.js for window 4294967297
18:28:37 INFO - 1499736517792 Marionette TRACE 354 <- [1,1,null,{"sessionId":"2a3e163b-ca6c-4f24-802e-7b69e983e897","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:37 INFO - 1499736517793 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
18:28:37 INFO - 1499736517794 Marionette TRACE 354 <- [1,2,null,{}]
18:28:37 INFO - 1499736517795 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:37 INFO - 1499736517795 Marionette TRACE 354 <- [1,3,null,{}]
18:28:37 INFO - 1499736517796 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:37 INFO - 1499736517797 Marionette TRACE 354 <- [1,4,null,{}]
18:28:37 INFO - 1499736517798 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}]
18:28:37 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499736517801 Marionette TRACE 354 <- [1,5,null,{"value":null}]
18:28:37 INFO - 1499736517802 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
18:28:37 INFO - 1499736517803 Marionette TRACE 354 <- [1,6,null,{}]
18:28:37 INFO - 1499736517805 Marionette DEBUG Closed connection 354
18:28:37 INFO - 1499736517806 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49777
18:28:37 INFO - 1499736517806 Marionette DEBUG Closed connection 355
18:28:37 INFO - 1499736517807 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49778
18:28:37 INFO - 1499736517808 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:37 INFO - 1499736517809 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:37 INFO - 1499736517813 Marionette DEBUG Register listener.js for window 4294967297
18:28:37 INFO - 1499736517817 Marionette TRACE 356 <- [1,1,null,{"sessionId":"d125066d-bc88-4e65-ae0c-f3d4ab410a99","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:37 INFO - 1499736517818 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
18:28:37 INFO - 1499736517819 Marionette TRACE 356 <- [1,2,null,{}]
18:28:37 INFO - 1499736517821 Marionette DEBUG Closed connection 356
18:28:37 INFO - 1499736517822 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49779
18:28:37 INFO - 1499736517824 Marionette DEBUG Closed connection 357
18:28:37 INFO - 1499736517825 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49780
18:28:37 INFO - 1499736517826 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:37 INFO - 1499736517827 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:37 INFO - 1499736517830 Marionette DEBUG Register listener.js for window 4294967297
18:28:37 INFO - 1499736517833 Marionette TRACE 358 <- [1,1,null,{"sessionId":"c1206bc6-03bb-4f93-9d24-6f7afa0c8424","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:37 INFO - 1499736517834 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49332/clicks.html"}]
18:28:37 INFO - 1499736517837 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/hidden.html"
18:28:37 INFO - 1499736517844 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/hidden.html"
18:28:37 INFO - 1499736517844 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/hidden.html"
18:28:37 INFO - 1499736517851 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/clicks.html"
18:28:37 INFO - 1499736517857 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/clicks.html"
18:28:37 INFO - 1499736517860 Marionette TRACE 358 <- [1,2,null,{}]
18:28:37 INFO - 1499736517865 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
18:28:37 INFO - 1499736517881 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5faaa888-34b2-4fea-839a-90f543be46e3","ELEMENT":"5faaa888-34b2-4fea-839a-90f543be46e3"}}]
18:28:37 INFO - 1499736517882 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"5faaa888-34b2-4fea-839a-90f543be46e3"}]
18:28:37 INFO - 1499736517924 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/clicks.html"
18:28:37 INFO - 1499736517944 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/clicks.html"
18:28:37 INFO - 1499736517944 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/clicks.html"
18:28:37 INFO - 1499736517953 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/test.html"
18:28:37 INFO - 1499736517961 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/test.html"
18:28:37 INFO - 1499736517962 Marionette TRACE 358 <- [1,4,null,{}]
18:28:37 INFO - 1499736517965 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
18:28:37 INFO - 1499736517968 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4feb29c7-54a2-4796-911d-cd40be700ebe","ELEMENT":"4feb29c7-54a2-4796-911d-cd40be700ebe"}}]
18:28:37 INFO - 1499736517970 Marionette TRACE 358 -> [0,6,"getTitle",{}]
18:28:37 INFO - 1499736517970 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
18:28:37 INFO - 1499736517977 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}]
18:28:37 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499736517982 Marionette TRACE 358 <- [1,7,null,{"value":null}]
18:28:37 INFO - 1499736517983 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
18:28:37 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 205ms
18:28:37 INFO - 1499736517985 Marionette TRACE 358 <- [1,8,null,{}]
18:28:37 INFO - TEST-START | test_click.py TestClick.test_container_element
18:28:37 INFO - 1499736517988 Marionette DEBUG Closed connection 358
18:28:37 INFO - 1499736517988 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49783
18:28:37 INFO - 1499736517989 Marionette DEBUG Closed connection 359
18:28:37 INFO - 1499736517990 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49784
18:28:37 INFO - 1499736517991 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:37 INFO - 1499736517992 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736517998 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518002 Marionette TRACE 360 <- [1,1,null,{"sessionId":"71248053-8183-4001-a808-f0d8a83b3513","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518003 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
18:28:38 INFO - 1499736518003 Marionette TRACE 360 <- [1,2,null,{}]
18:28:38 INFO - 1499736518004 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:38 INFO - 1499736518005 Marionette TRACE 360 <- [1,3,null,{}]
18:28:38 INFO - 1499736518006 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:38 INFO - 1499736518006 Marionette TRACE 360 <- [1,4,null,{}]
18:28:38 INFO - 1499736518008 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}]
18:28:38 INFO - TEST-START: test_click.py TestClick.test_container_element1499736518011 Marionette TRACE 360 <- [1,5,null,{"value":null}]
18:28:38 INFO - 1499736518012 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
18:28:38 INFO - 1499736518014 Marionette TRACE 360 <- [1,6,null,{}]
18:28:38 INFO - 1499736518015 Marionette DEBUG Closed connection 360
18:28:38 INFO - 1499736518016 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49785
18:28:38 INFO - 1499736518016 Marionette DEBUG Closed connection 361
18:28:38 INFO - 1499736518017 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49786
18:28:38 INFO - 1499736518018 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:38 INFO - 1499736518019 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518022 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518025 Marionette TRACE 362 <- [1,1,null,{"sessionId":"232432bb-6675-414a-a2ea-ac2c310d948b","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518027 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
18:28:38 INFO - 1499736518029 Marionette TRACE 362 <- [1,2,null,{}]
18:28:38 INFO - 1499736518030 Marionette DEBUG Closed connection 362
18:28:38 INFO - 1499736518031 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49787
18:28:38 INFO - 1499736518032 Marionette DEBUG Closed connection 363
18:28:38 INFO - 1499736518032 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49788
18:28:38 INFO - 1499736518033 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:38 INFO - 1499736518034 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518037 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518040 Marionette TRACE 364 <- [1,1,null,{"sessionId":"644eead1-db47-435a-bb2f-9d57b2adb02b","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518042 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"}]
18:28:38 INFO - 1499736518044 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/test.html"
18:28:38 INFO - 1499736518046 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/test.html"
18:28:38 INFO - 1499736518046 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/test.html"
18:28:38 INFO - 1499736518052 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"
18:28:38 INFO - 1499736518059 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"
18:28:38 INFO - 1499736518068 Marionette TRACE 364 <- [1,2,null,{}]
18:28:38 INFO - 1499736518076 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
18:28:38 INFO - 1499736518080 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c71c2b81-e5ad-42bb-86b0-e7e5d75046ad","ELEMENT":"c71c2b81-e5ad-42bb-86b0-e7e5d75046ad"}}]
18:28:38 INFO - 1499736518081 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"c71c2b81-e5ad-42bb-86b0-e7e5d75046ad"}]
18:28:38 INFO - 1499736518330 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:28:38 INFO - 1499736518331 Marionette TRACE 364 <- [1,4,null,{}]
18:28:38 INFO - 1499736518332 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"c71c2b81-e5ad-42bb-86b0-e7e5d75046ad","name":"selected"}]
18:28:38 INFO - 1499736518337 Marionette TRACE 364 <- [1,5,null,{"value":true}]
18:28:38 INFO - 1499736518338 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}]
18:28:38 INFO - TEST-END: test_click.py TestClick.test_container_element1499736518341 Marionette TRACE 364 <- [1,6,null,{"value":null}]
18:28:38 INFO - 1499736518342 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
18:28:38 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 358ms
18:28:38 INFO - 1499736518344 Marionette TRACE 364 <- [1,7,null,{}]
18:28:38 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
18:28:38 INFO - 1499736518345 Marionette DEBUG Closed connection 364
18:28:38 INFO - 1499736518346 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49789
18:28:38 INFO - 1499736518347 Marionette DEBUG Closed connection 365
18:28:38 INFO - 1499736518348 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49790
18:28:38 INFO - 1499736518349 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:38 INFO - 1499736518350 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518353 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518356 Marionette TRACE 366 <- [1,1,null,{"sessionId":"3a13b972-9cd3-46fe-8e19-14d1ca7d0143","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518357 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
18:28:38 INFO - 1499736518358 Marionette TRACE 366 <- [1,2,null,{}]
18:28:38 INFO - 1499736518358 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:38 INFO - 1499736518359 Marionette TRACE 366 <- [1,3,null,{}]
18:28:38 INFO - 1499736518360 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:38 INFO - 1499736518360 Marionette TRACE 366 <- [1,4,null,{}]
18:28:38 INFO - 1499736518362 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}]
18:28:38 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499736518365 Marionette TRACE 366 <- [1,5,null,{"value":null}]
18:28:38 INFO - 1499736518366 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
18:28:38 INFO - 1499736518367 Marionette TRACE 366 <- [1,6,null,{}]
18:28:38 INFO - 1499736518369 Marionette DEBUG Closed connection 366
18:28:38 INFO - 1499736518370 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49791
18:28:38 INFO - 1499736518370 Marionette DEBUG Closed connection 367
18:28:38 INFO - 1499736518371 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49792
18:28:38 INFO - 1499736518372 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:38 INFO - 1499736518373 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518376 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518379 Marionette TRACE 368 <- [1,1,null,{"sessionId":"4c32dd4c-6a58-4d3a-9ed0-29b8b356f227","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518380 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
18:28:38 INFO - 1499736518381 Marionette TRACE 368 <- [1,2,null,{}]
18:28:38 INFO - 1499736518383 Marionette DEBUG Closed connection 368
18:28:38 INFO - 1499736518384 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49793
18:28:38 INFO - 1499736518384 Marionette DEBUG Closed connection 369
18:28:38 INFO - 1499736518385 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49794
18:28:38 INFO - 1499736518386 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:38 INFO - 1499736518387 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518390 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518393 Marionette TRACE 370 <- [1,1,null,{"sessionId":"8c9faeb7-a08d-44cf-a391-ab19ac0deb95","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518395 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"}]
18:28:38 INFO - 1499736518397 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"
18:28:38 INFO - 1499736518398 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"
18:28:38 INFO - 1499736518399 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"
18:28:38 INFO - 1499736518405 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"
18:28:38 INFO - 1499736518409 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"
18:28:38 INFO - 1499736518415 Marionette TRACE 370 <- [1,2,null,{}]
18:28:38 INFO - 1499736518418 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
18:28:38 INFO - 1499736518426 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"804f4b38-1706-4f13-b0dd-f174cf12cafa","ELEMENT":"804f4b38-1706-4f13-b0dd-f174cf12cafa"}}]
18:28:38 INFO - 1499736518427 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"804f4b38-1706-4f13-b0dd-f174cf12cafa"}]
18:28:38 INFO - 1499736518672 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:28:38 INFO - 1499736518673 Marionette TRACE 370 <- [1,4,null,{}]
18:28:38 INFO - 1499736518674 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"804f4b38-1706-4f13-b0dd-f174cf12cafa","name":"selected"}]
18:28:38 INFO - 1499736518678 Marionette TRACE 370 <- [1,5,null,{"value":true}]
18:28:38 INFO - 1499736518680 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}]
18:28:38 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499736518682 Marionette TRACE 370 <- [1,6,null,{"value":null}]
18:28:38 INFO - 1499736518683 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
18:28:38 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 341ms
18:28:38 INFO - 1499736518685 Marionette TRACE 370 <- [1,7,null,{}]
18:28:38 INFO - TEST-START | test_click.py TestClick.test_css_transforms
18:28:38 INFO - 1499736518686 Marionette DEBUG Closed connection 370
18:28:38 INFO - 1499736518687 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49795
18:28:38 INFO - 1499736518688 Marionette DEBUG Closed connection 371
18:28:38 INFO - 1499736518689 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49796
18:28:38 INFO - 1499736518690 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:38 INFO - 1499736518691 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518694 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518697 Marionette TRACE 372 <- [1,1,null,{"sessionId":"c4e5bd18-4d60-4e65-9f18-131f879a0588","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518698 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
18:28:38 INFO - 1499736518699 Marionette TRACE 372 <- [1,2,null,{}]
18:28:38 INFO - 1499736518700 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:38 INFO - 1499736518700 Marionette TRACE 372 <- [1,3,null,{}]
18:28:38 INFO - 1499736518701 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:38 INFO - 1499736518702 Marionette TRACE 372 <- [1,4,null,{}]
18:28:38 INFO - 1499736518704 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}]
18:28:38 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499736518706 Marionette TRACE 372 <- [1,5,null,{"value":null}]
18:28:38 INFO - 1499736518708 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
18:28:38 INFO - 1499736518709 Marionette TRACE 372 <- [1,6,null,{}]
18:28:38 INFO - 1499736518711 Marionette DEBUG Closed connection 372
18:28:38 INFO - 1499736518711 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49797
18:28:38 INFO - 1499736518712 Marionette DEBUG Closed connection 373
18:28:38 INFO - 1499736518713 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49798
18:28:38 INFO - 1499736518714 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:38 INFO - 1499736518715 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518717 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518721 Marionette TRACE 374 <- [1,1,null,{"sessionId":"24463c91-1d6b-438d-bbdd-1c3a0284ca87","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518722 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
18:28:38 INFO - 1499736518724 Marionette TRACE 374 <- [1,2,null,{}]
18:28:38 INFO - 1499736518725 Marionette DEBUG Closed connection 374
18:28:38 INFO - 1499736518726 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49799
18:28:38 INFO - 1499736518727 Marionette DEBUG Closed connection 375
18:28:38 INFO - 1499736518727 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49800
18:28:38 INFO - 1499736518729 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:38 INFO - 1499736518729 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:38 INFO - 1499736518732 Marionette DEBUG Register listener.js for window 4294967297
18:28:38 INFO - 1499736518735 Marionette TRACE 376 <- [1,1,null,{"sessionId":"d6d3b118-d869-4158-b643-f41868f15f5c","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:38 INFO - 1499736518737 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"}]
18:28:38 INFO - 1499736518738 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"
18:28:38 INFO - 1499736518740 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"
18:28:38 INFO - 1499736518741 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"
18:28:38 INFO - 1499736518747 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"
18:28:38 INFO - 1499736518750 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"
18:28:38 INFO - 1499736518753 Marionette TRACE 376 <- [1,2,null,{}]
18:28:38 INFO - 1499736518761 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
18:28:38 INFO - 1499736518764 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5ba019f3-739a-423e-865b-445c9d37ccdf","ELEMENT":"5ba019f3-739a-423e-865b-445c9d37ccdf"}}]
18:28:38 INFO - 1499736518765 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"5ba019f3-739a-423e-865b-445c9d37ccdf"}]
18:28:39 INFO - 1499736519011 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:28:39 INFO - 1499736519012 Marionette TRACE 376 <- [1,4,null,{}]
18:28:39 INFO - 1499736519014 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}]
18:28:39 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499736519016 Marionette TRACE 376 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519018 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519019 Marionette TRACE 376 <- [1,6,null,{}]
18:28:39 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 336ms
18:28:39 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
18:28:39 INFO - 1499736519023 Marionette DEBUG Closed connection 376
18:28:39 INFO - 1499736519023 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49801
18:28:39 INFO - 1499736519024 Marionette DEBUG Closed connection 377
18:28:39 INFO - 1499736519025 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49802
18:28:39 INFO - 1499736519026 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519027 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519030 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519040 Marionette TRACE 378 <- [1,1,null,{"sessionId":"85dd538d-e041-4f53-9aee-32649db6c2e8","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519042 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
18:28:39 INFO - 1499736519042 Marionette TRACE 378 <- [1,2,null,{}]
18:28:39 INFO - 1499736519043 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:39 INFO - 1499736519044 Marionette TRACE 378 <- [1,3,null,{}]
18:28:39 INFO - 1499736519045 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:39 INFO - 1499736519045 Marionette TRACE 378 <- [1,4,null,{}]
18:28:39 INFO - 1499736519046 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}]
18:28:39 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499736519049 Marionette TRACE 378 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519050 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519052 Marionette TRACE 378 <- [1,6,null,{}]
18:28:39 INFO - 1499736519054 Marionette DEBUG Closed connection 378
18:28:39 INFO - 1499736519054 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49803
18:28:39 INFO - 1499736519055 Marionette DEBUG Closed connection 379
18:28:39 INFO - 1499736519056 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49804
18:28:39 INFO - 1499736519056 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519058 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519061 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519065 Marionette TRACE 380 <- [1,1,null,{"sessionId":"77647851-8d7b-42de-9362-dd7e9e0374c5","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519066 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
18:28:39 INFO - 1499736519068 Marionette TRACE 380 <- [1,2,null,{}]
18:28:39 INFO - 1499736519069 Marionette DEBUG Closed connection 380
18:28:39 INFO - 1499736519070 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49805
18:28:39 INFO - 1499736519070 Marionette DEBUG Closed connection 381
18:28:39 INFO - 1499736519071 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49806
18:28:39 INFO - 1499736519072 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:39 INFO - 1499736519073 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519076 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519080 Marionette TRACE 382 <- [1,1,null,{"sessionId":"4c980655-cb6e-4266-bdd4-01b2d4e30c95","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519081 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"}]
18:28:39 INFO - 1499736519083 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"
18:28:39 INFO - 1499736519085 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"
18:28:39 INFO - 1499736519086 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"
18:28:39 INFO - 1499736519093 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"
18:28:39 INFO - 1499736519098 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"
18:28:39 INFO - 1499736519103 Marionette TRACE 382 <- [1,2,null,{}]
18:28:39 INFO - 1499736519112 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
18:28:39 INFO - 1499736519124 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"85246ab9-29fd-4a5a-88b9-28ae9750d10c","ELEMENT":"85246ab9-29fd-4a5a-88b9-28ae9750d10c"}}]
18:28:39 INFO - 1499736519125 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"85246ab9-29fd-4a5a-88b9-28ae9750d10c"}]
18:28:39 INFO - 1499736519375 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:28:39 INFO - 1499736519377 Marionette TRACE 382 <- [1,4,null,{}]
18:28:39 INFO - 1499736519378 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}]
18:28:39 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499736519381 Marionette TRACE 382 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519382 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519384 Marionette TRACE 382 <- [1,6,null,{}]
18:28:39 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 363ms
18:28:39 INFO - TEST-START | test_click.py TestClick.test_input_file
18:28:39 INFO - 1499736519385 Marionette DEBUG Closed connection 382
18:28:39 INFO - 1499736519387 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49807
18:28:39 INFO - 1499736519388 Marionette DEBUG Closed connection 383
18:28:39 INFO - 1499736519389 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49808
18:28:39 INFO - 1499736519390 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519390 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519393 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519396 Marionette TRACE 384 <- [1,1,null,{"sessionId":"6e9bef87-522d-4a07-89e7-fde54a8affa7","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519398 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
18:28:39 INFO - 1499736519398 Marionette TRACE 384 <- [1,2,null,{}]
18:28:39 INFO - 1499736519399 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:39 INFO - 1499736519399 Marionette TRACE 384 <- [1,3,null,{}]
18:28:39 INFO - 1499736519400 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:39 INFO - 1499736519401 Marionette TRACE 384 <- [1,4,null,{}]
18:28:39 INFO - 1499736519403 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}]
18:28:39 INFO - TEST-START: test_click.py TestClick.test_input_file1499736519406 Marionette TRACE 384 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519406 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519408 Marionette TRACE 384 <- [1,6,null,{}]
18:28:39 INFO - 1499736519410 Marionette DEBUG Closed connection 384
18:28:39 INFO - 1499736519410 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49809
18:28:39 INFO - 1499736519411 Marionette DEBUG Closed connection 385
18:28:39 INFO - 1499736519411 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49810
18:28:39 INFO - 1499736519412 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519413 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519416 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519420 Marionette TRACE 386 <- [1,1,null,{"sessionId":"0b3e24e1-f372-4b93-9a91-64a56207fcd0","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519421 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
18:28:39 INFO - 1499736519423 Marionette TRACE 386 <- [1,2,null,{}]
18:28:39 INFO - 1499736519424 Marionette DEBUG Closed connection 386
18:28:39 INFO - 1499736519425 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49811
18:28:39 INFO - 1499736519426 Marionette DEBUG Closed connection 387
18:28:39 INFO - 1499736519426 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49812
18:28:39 INFO - 1499736519427 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:39 INFO - 1499736519428 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519431 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519434 Marionette TRACE 388 <- [1,1,null,{"sessionId":"e8823aaa-882f-4250-ac18-44e0025418ad","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519436 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
18:28:39 INFO - 1499736519438 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"
18:28:39 INFO - 1499736519439 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"
18:28:39 INFO - 1499736519440 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"
18:28:39 INFO - 1499736519446 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:28:39 INFO - 1499736519451 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:28:39 INFO - 1499736519452 Marionette TRACE 388 <- [1,2,null,{}]
18:28:39 INFO - 1499736519460 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
18:28:39 INFO - 1499736519463 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c8843461-a55f-4d07-b115-4c651c7a0a80","ELEMENT":"c8843461-a55f-4d07-b115-4c651c7a0a80"}}]
18:28:39 INFO - 1499736519464 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"c8843461-a55f-4d07-b115-4c651c7a0a80"}]
18:28:39 INFO - 1499736519499 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:28:39 INFO - 1499736519501 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}]
18:28:39 INFO - TEST-END: test_click.py TestClick.test_input_file1499736519504 Marionette TRACE 388 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519505 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
18:28:39 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 122ms
18:28:39 INFO - TEST-START | test_click.py TestClick.test_obscured_element
18:28:39 INFO - 1499736519507 Marionette TRACE 388 <- [1,6,null,{}]
18:28:39 INFO - 1499736519508 Marionette DEBUG Closed connection 388
18:28:39 INFO - 1499736519509 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49813
18:28:39 INFO - 1499736519510 Marionette DEBUG Closed connection 389
18:28:39 INFO - 1499736519510 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49814
18:28:39 INFO - 1499736519511 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519512 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519515 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519518 Marionette TRACE 390 <- [1,1,null,{"sessionId":"69d606d5-634f-48f0-8cc7-f9d2512622c6","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519519 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
18:28:39 INFO - 1499736519520 Marionette TRACE 390 <- [1,2,null,{}]
18:28:39 INFO - 1499736519521 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:39 INFO - 1499736519521 Marionette TRACE 390 <- [1,3,null,{}]
18:28:39 INFO - 1499736519522 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:39 INFO - 1499736519523 Marionette TRACE 390 <- [1,4,null,{}]
18:28:39 INFO - 1499736519524 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}]
18:28:39 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499736519527 Marionette TRACE 390 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519528 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519530 Marionette TRACE 390 <- [1,6,null,{}]
18:28:39 INFO - 1499736519531 Marionette DEBUG Closed connection 390
18:28:39 INFO - 1499736519532 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49815
18:28:39 INFO - 1499736519532 Marionette DEBUG Closed connection 391
18:28:39 INFO - 1499736519533 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49816
18:28:39 INFO - 1499736519534 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519535 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519537 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519541 Marionette TRACE 392 <- [1,1,null,{"sessionId":"9651deba-da45-4a34-9eb7-25d77c21a33c","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519542 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
18:28:39 INFO - 1499736519543 Marionette TRACE 392 <- [1,2,null,{}]
18:28:39 INFO - 1499736519545 Marionette DEBUG Closed connection 392
18:28:39 INFO - 1499736519545 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49817
18:28:39 INFO - 1499736519546 Marionette DEBUG Closed connection 393
18:28:39 INFO - 1499736519547 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49818
18:28:39 INFO - 1499736519548 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:39 INFO - 1499736519549 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519552 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519555 Marionette TRACE 394 <- [1,1,null,{"sessionId":"0e8dc762-559c-4255-988c-66c8d8d89a20","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519556 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"}]
18:28:39 INFO - 1499736519558 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:28:39 INFO - 1499736519560 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:28:39 INFO - 1499736519560 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:28:39 INFO - 1499736519568 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"
18:28:39 INFO - 1499736519571 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"
18:28:39 INFO - 1499736519577 Marionette TRACE 394 <- [1,2,null,{}]
18:28:39 INFO - 1499736519580 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
18:28:39 INFO - 1499736519583 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"41c6d46e-1af0-497d-b1dc-fbade2aa8df2","ELEMENT":"41c6d46e-1af0-497d-b1dc-fbade2aa8df2"}}]
18:28:39 INFO - 1499736519584 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
18:28:39 INFO - 1499736519586 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"05fc719a-818b-43dd-9d1b-ee31c3731f24","ELEMENT":"05fc719a-818b-43dd-9d1b-ee31c3731f24"}}]
18:28:39 INFO - 1499736519591 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"41c6d46e-1af0-497d-b1dc-fbade2aa8df2"}]
18:28:39 INFO - 1499736519830 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:28:39 INFO - 1499736519831 Marionette TRACE 394 <- [1,5,null,{}]
18:28:39 INFO - 1499736519833 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"05fc719a-818b-43dd-9d1b-ee31c3731f24"}]
18:28:39 INFO - 1499736519849 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:28:39 INFO - 1499736519851 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
18:28:39 INFO - 1499736519854 Marionette TRACE 394 <- [1,7,null,{"value":false}]
18:28:39 INFO - 1499736519856 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}]
18:28:39 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499736519858 Marionette TRACE 394 <- [1,8,null,{"value":null}]
18:28:39 INFO - 1499736519859 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
18:28:39 INFO - 1499736519861 Marionette TRACE 394 <- [1,9,null,{}]
18:28:39 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 354ms
18:28:39 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
18:28:39 INFO - 1499736519862 Marionette DEBUG Closed connection 394
18:28:39 INFO - 1499736519864 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49819
18:28:39 INFO - 1499736519864 Marionette DEBUG Closed connection 395
18:28:39 INFO - 1499736519865 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49820
18:28:39 INFO - 1499736519866 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519866 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519869 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519873 Marionette TRACE 396 <- [1,1,null,{"sessionId":"62fcba72-3458-4334-8fdc-1831f4f1d72e","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519874 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
18:28:39 INFO - 1499736519875 Marionette TRACE 396 <- [1,2,null,{}]
18:28:39 INFO - 1499736519876 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:28:39 INFO - 1499736519876 Marionette TRACE 396 <- [1,3,null,{}]
18:28:39 INFO - 1499736519877 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
18:28:39 INFO - 1499736519877 Marionette TRACE 396 <- [1,4,null,{}]
18:28:39 INFO - 1499736519879 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}]
18:28:39 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499736519882 Marionette TRACE 396 <- [1,5,null,{"value":null}]
18:28:39 INFO - 1499736519883 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
18:28:39 INFO - 1499736519884 Marionette TRACE 396 <- [1,6,null,{}]
18:28:39 INFO - 1499736519886 Marionette DEBUG Closed connection 396
18:28:39 INFO - 1499736519887 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49821
18:28:39 INFO - 1499736519888 Marionette DEBUG Closed connection 397
18:28:39 INFO - 1499736519888 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49822
18:28:39 INFO - 1499736519889 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:28:39 INFO - 1499736519890 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519893 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519896 Marionette TRACE 398 <- [1,1,null,{"sessionId":"bf5a43b4-9012-4488-a234-398813c3fc99","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519898 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
18:28:39 INFO - 1499736519899 Marionette TRACE 398 <- [1,2,null,{}]
18:28:39 INFO - 1499736519901 Marionette DEBUG Closed connection 398
18:28:39 INFO - 1499736519901 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49823
18:28:39 INFO - 1499736519902 Marionette DEBUG Closed connection 399
18:28:39 INFO - 1499736519903 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49824
18:28:39 INFO - 1499736519904 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:28:39 INFO - 1499736519905 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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}
18:28:39 INFO - 1499736519908 Marionette DEBUG Register listener.js for window 4294967297
18:28:39 INFO - 1499736519911 Marionette TRACE 400 <- [1,1,null,{"sessionId":"e03649eb-c812-4130-ae2b-de9ec1f82120","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":3384,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-018.001\\AppData\\Local\\Temp\\tmpr928io.mozrunner","moz:accessibilityChecks":false}}]
18:28:39 INFO - 1499736519912 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"}]
18:28:39 INFO - 1499736519914 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"
18:28:39 INFO - 1499736519916 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"
18:28:39 INFO - 1499736519917 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"
18:28:39 INFO - 1499736519925 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"
18:28:39 INFO - 1499736519927 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"
18:28:39 INFO - 1499736519932 Marionette TRACE 400 <- [1,2,null,{}]
18:28:39 INFO - 1499736519936 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
18:28:39 INFO - 1499736519942 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fe67efb1-c3ef-4d51-9ff6-e5f195a3a89d","ELEMENT":"fe67efb1-c3ef-4d51-9ff6-e5f195a3a89d"}}]
18:28:39 INFO - 1499736519944 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"fe67efb1-c3ef-4d51-9ff6-e5f195a3a89d"}]
18:28:39 INFO - 1499736519969 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
18:28:39 INFO - 1499736519970 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"fe67efb1-c3ef-4d51-9ff6-e5f195a3a89d"}]
18:28:39 INFO - 1499736519987 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element