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:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
16:42:55 INFO - 1499902975780 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}]
16:42:55 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499902975782 Marionette TRACE 352 <- [1,5,null,{"value":null}]
16:42:55 INFO - 1499902975783 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
16:42:55 INFO - 1499902975784 Marionette TRACE 352 <- [1,6,null,{}]
16:42:55 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 111ms
16:42:55 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
16:42:55 INFO - 1499902975786 Marionette DEBUG Closed connection 352
16:42:55 INFO - 1499902975787 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49773
16:42:55 INFO - 1499902975787 Marionette DEBUG Closed connection 353
16:42:55 INFO - 1499902975788 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49774
16:42:55 INFO - 1499902975789 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:55 INFO - 1499902975790 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975792 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975795 Marionette TRACE 354 <- [1,1,null,{"sessionId":"464722dd-b7d8-4199-9836-57b681e01bac","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975796 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
16:42:55 INFO - 1499902975796 Marionette TRACE 354 <- [1,2,null,{}]
16:42:55 INFO - 1499902975797 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:55 INFO - 1499902975797 Marionette TRACE 354 <- [1,3,null,{}]
16:42:55 INFO - 1499902975798 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:55 INFO - 1499902975799 Marionette TRACE 354 <- [1,4,null,{}]
16:42:55 INFO - 1499902975800 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}]
16:42:55 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499902975803 Marionette TRACE 354 <- [1,5,null,{"value":null}]
16:42:55 INFO - 1499902975803 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
16:42:55 INFO - 1499902975804 Marionette TRACE 354 <- [1,6,null,{}]
16:42:55 INFO - 1499902975806 Marionette DEBUG Closed connection 354
16:42:55 INFO - 1499902975806 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49775
16:42:55 INFO - 1499902975807 Marionette DEBUG Closed connection 355
16:42:55 INFO - 1499902975807 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49776
16:42:55 INFO - 1499902975808 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:55 INFO - 1499902975809 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975811 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975814 Marionette TRACE 356 <- [1,1,null,{"sessionId":"8a3651d4-88c3-40f7-ac4e-35d5b1e44d3e","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975815 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
16:42:55 INFO - 1499902975816 Marionette TRACE 356 <- [1,2,null,{}]
16:42:55 INFO - 1499902975817 Marionette DEBUG Closed connection 356
16:42:55 INFO - 1499902975817 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49777
16:42:55 INFO - 1499902975818 Marionette DEBUG Closed connection 357
16:42:55 INFO - 1499902975819 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49778
16:42:55 INFO - 1499902975820 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:55 INFO - 1499902975820 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975822 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975832 Marionette TRACE 358 <- [1,1,null,{"sessionId":"4ef1ef55-cfda-4dcb-b222-e8a8b5aec06a","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975833 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49331/clicks.html"}]
16:42:55 INFO - 1499902975835 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/hidden.html"
16:42:55 INFO - 1499902975841 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/hidden.html"
16:42:55 INFO - 1499902975841 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/hidden.html"
16:42:55 INFO - 1499902975853 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/clicks.html"
16:42:55 INFO - 1499902975856 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/clicks.html"
16:42:55 INFO - 1499902975857 Marionette TRACE 358 <- [1,2,null,{}]
16:42:55 INFO - 1499902975860 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
16:42:55 INFO - 1499902975867 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1fcfabb3-e646-44af-883a-17e22b44a45d","ELEMENT":"1fcfabb3-e646-44af-883a-17e22b44a45d"}}]
16:42:55 INFO - 1499902975868 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"1fcfabb3-e646-44af-883a-17e22b44a45d"}]
16:42:55 INFO - 1499902975911 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/clicks.html"
16:42:55 INFO - 1499902975917 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/clicks.html"
16:42:55 INFO - 1499902975918 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/clicks.html"
16:42:55 INFO - 1499902975923 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/test.html"
16:42:55 INFO - 1499902975926 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/test.html"
16:42:55 INFO - 1499902975937 Marionette TRACE 358 <- [1,4,null,{}]
16:42:55 INFO - 1499902975942 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
16:42:55 INFO - 1499902975947 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a7ebc23-561c-440d-8de9-508dd926fa33","ELEMENT":"2a7ebc23-561c-440d-8de9-508dd926fa33"}}]
16:42:55 INFO - 1499902975948 Marionette TRACE 358 -> [0,6,"getTitle",{}]
16:42:55 INFO - 1499902975949 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
16:42:55 INFO - 1499902975950 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}]
16:42:55 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499902975953 Marionette TRACE 358 <- [1,7,null,{"value":null}]
16:42:55 INFO - 1499902975954 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
16:42:55 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 171ms
16:42:55 INFO - TEST-START | test_click.py TestClick.test_container_element
16:42:55 INFO - 1499902975955 Marionette TRACE 358 <- [1,8,null,{}]
16:42:55 INFO - 1499902975956 Marionette DEBUG Closed connection 358
16:42:55 INFO - 1499902975957 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49781
16:42:55 INFO - 1499902975958 Marionette DEBUG Closed connection 359
16:42:55 INFO - 1499902975958 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49782
16:42:55 INFO - 1499902975959 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:55 INFO - 1499902975959 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975962 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975965 Marionette TRACE 360 <- [1,1,null,{"sessionId":"05d71771-9e18-45bf-8d2d-6ef4a03591ba","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975966 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
16:42:55 INFO - 1499902975966 Marionette TRACE 360 <- [1,2,null,{}]
16:42:55 INFO - 1499902975967 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:55 INFO - 1499902975968 Marionette TRACE 360 <- [1,3,null,{}]
16:42:55 INFO - 1499902975968 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:55 INFO - 1499902975969 Marionette TRACE 360 <- [1,4,null,{}]
16:42:55 INFO - 1499902975971 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}]
16:42:55 INFO - TEST-START: test_click.py TestClick.test_container_element1499902975973 Marionette TRACE 360 <- [1,5,null,{"value":null}]
16:42:55 INFO - 1499902975974 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
16:42:55 INFO - 1499902975975 Marionette TRACE 360 <- [1,6,null,{}]
16:42:55 INFO - 1499902975977 Marionette DEBUG Closed connection 360
16:42:55 INFO - 1499902975977 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49783
16:42:55 INFO - 1499902975978 Marionette DEBUG Closed connection 361
16:42:55 INFO - 1499902975979 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49784
16:42:55 INFO - 1499902975980 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:55 INFO - 1499902975980 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975982 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975985 Marionette TRACE 362 <- [1,1,null,{"sessionId":"4ac41170-3da5-4801-956f-1e5e04a9b0f0","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975986 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
16:42:55 INFO - 1499902975987 Marionette TRACE 362 <- [1,2,null,{}]
16:42:55 INFO - 1499902975988 Marionette DEBUG Closed connection 362
16:42:55 INFO - 1499902975989 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49785
16:42:55 INFO - 1499902975990 Marionette DEBUG Closed connection 363
16:42:55 INFO - 1499902975990 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49786
16:42:55 INFO - 1499902975991 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:55 INFO - 1499902975992 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:55 INFO - 1499902975994 Marionette DEBUG Register listener.js for window 4294967297
16:42:55 INFO - 1499902975997 Marionette TRACE 364 <- [1,1,null,{"sessionId":"6beddeae-f7de-435c-84ab-3aa7e38aa47e","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:55 INFO - 1499902975998 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"}]
16:42:56 INFO - 1499902975999 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/test.html"
16:42:56 INFO - 1499902976002 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/test.html"
16:42:56 INFO - 1499902976002 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/test.html"
16:42:56 INFO - 1499902976009 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"
16:42:56 INFO - 1499902976014 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"
16:42:56 INFO - 1499902976020 Marionette TRACE 364 <- [1,2,null,{}]
16:42:56 INFO - 1499902976023 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
16:42:56 INFO - 1499902976025 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b5686376-9880-4ccd-9d55-c0f8ded5cb89","ELEMENT":"b5686376-9880-4ccd-9d55-c0f8ded5cb89"}}]
16:42:56 INFO - 1499902976026 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"b5686376-9880-4ccd-9d55-c0f8ded5cb89"}]
16:42:56 INFO - 1499902976262 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:42:56 INFO - 1499902976263 Marionette TRACE 364 <- [1,4,null,{}]
16:42:56 INFO - 1499902976264 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"b5686376-9880-4ccd-9d55-c0f8ded5cb89","name":"selected"}]
16:42:56 INFO - 1499902976268 Marionette TRACE 364 <- [1,5,null,{"value":true}]
16:42:56 INFO - 1499902976269 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}]
16:42:56 INFO - TEST-END: test_click.py TestClick.test_container_element1499902976272 Marionette TRACE 364 <- [1,6,null,{"value":null}]
16:42:56 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 318ms
16:42:56 INFO - 1499902976273 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
16:42:56 INFO - 1499902976274 Marionette TRACE 364 <- [1,7,null,{}]
16:42:56 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
16:42:56 INFO - 1499902976275 Marionette DEBUG Closed connection 364
16:42:56 INFO - 1499902976277 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49787
16:42:56 INFO - 1499902976279 Marionette DEBUG Closed connection 365
16:42:56 INFO - 1499902976280 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49788
16:42:56 INFO - 1499902976281 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976281 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976283 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976286 Marionette TRACE 366 <- [1,1,null,{"sessionId":"6e19e728-8783-4879-916e-43cb03536a07","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976288 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
16:42:56 INFO - 1499902976288 Marionette TRACE 366 <- [1,2,null,{}]
16:42:56 INFO - 1499902976289 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:56 INFO - 1499902976290 Marionette TRACE 366 <- [1,3,null,{}]
16:42:56 INFO - 1499902976291 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:56 INFO - 1499902976291 Marionette TRACE 366 <- [1,4,null,{}]
16:42:56 INFO - 1499902976292 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}]
16:42:56 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499902976295 Marionette TRACE 366 <- [1,5,null,{"value":null}]
16:42:56 INFO - 1499902976296 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
16:42:56 INFO - 1499902976297 Marionette TRACE 366 <- [1,6,null,{}]
16:42:56 INFO - 1499902976298 Marionette DEBUG Closed connection 366
16:42:56 INFO - 1499902976299 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49789
16:42:56 INFO - 1499902976299 Marionette DEBUG Closed connection 367
16:42:56 INFO - 1499902976300 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49790
16:42:56 INFO - 1499902976301 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976301 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976303 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976306 Marionette TRACE 368 <- [1,1,null,{"sessionId":"9721556a-ac96-4fd1-ba78-28449ac7cbdb","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976307 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
16:42:56 INFO - 1499902976308 Marionette TRACE 368 <- [1,2,null,{}]
16:42:56 INFO - 1499902976310 Marionette DEBUG Closed connection 368
16:42:56 INFO - 1499902976310 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49791
16:42:56 INFO - 1499902976311 Marionette DEBUG Closed connection 369
16:42:56 INFO - 1499902976312 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49792
16:42:56 INFO - 1499902976313 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:56 INFO - 1499902976314 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976316 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976318 Marionette TRACE 370 <- [1,1,null,{"sessionId":"7603acf9-302d-4c4b-b7d8-23d596c938ac","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976319 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"}]
16:42:56 INFO - 1499902976321 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"
16:42:56 INFO - 1499902976322 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"
16:42:56 INFO - 1499902976323 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"
16:42:56 INFO - 1499902976329 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"
16:42:56 INFO - 1499902976331 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"
16:42:56 INFO - 1499902976335 Marionette TRACE 370 <- [1,2,null,{}]
16:42:56 INFO - 1499902976338 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
16:42:56 INFO - 1499902976340 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8759b5bd-84cf-4f6b-904c-72f52b1ab698","ELEMENT":"8759b5bd-84cf-4f6b-904c-72f52b1ab698"}}]
16:42:56 INFO - 1499902976341 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"8759b5bd-84cf-4f6b-904c-72f52b1ab698"}]
16:42:56 INFO - 1499902976594 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:42:56 INFO - 1499902976595 Marionette TRACE 370 <- [1,4,null,{}]
16:42:56 INFO - 1499902976597 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"8759b5bd-84cf-4f6b-904c-72f52b1ab698","name":"selected"}]
16:42:56 INFO - 1499902976600 Marionette TRACE 370 <- [1,5,null,{"value":true}]
16:42:56 INFO - 1499902976602 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}]
16:42:56 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499902976604 Marionette TRACE 370 <- [1,6,null,{"value":null}]
16:42:56 INFO - 1499902976605 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
16:42:56 INFO - 1499902976606 Marionette TRACE 370 <- [1,7,null,{}]
16:42:56 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 332ms
16:42:56 INFO - TEST-START | test_click.py TestClick.test_css_transforms
16:42:56 INFO - 1499902976607 Marionette DEBUG Closed connection 370
16:42:56 INFO - 1499902976608 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49793
16:42:56 INFO - 1499902976609 Marionette DEBUG Closed connection 371
16:42:56 INFO - 1499902976610 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49794
16:42:56 INFO - 1499902976610 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976611 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976613 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976617 Marionette TRACE 372 <- [1,1,null,{"sessionId":"f6fce34f-20ab-4d77-aa44-e7150e97afc6","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976618 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
16:42:56 INFO - 1499902976619 Marionette TRACE 372 <- [1,2,null,{}]
16:42:56 INFO - 1499902976619 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:56 INFO - 1499902976620 Marionette TRACE 372 <- [1,3,null,{}]
16:42:56 INFO - 1499902976621 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:56 INFO - 1499902976621 Marionette TRACE 372 <- [1,4,null,{}]
16:42:56 INFO - 1499902976623 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}]
16:42:56 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499902976625 Marionette TRACE 372 <- [1,5,null,{"value":null}]
16:42:56 INFO - 1499902976626 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
16:42:56 INFO - 1499902976627 Marionette TRACE 372 <- [1,6,null,{}]
16:42:56 INFO - 1499902976629 Marionette DEBUG Closed connection 372
16:42:56 INFO - 1499902976629 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49795
16:42:56 INFO - 1499902976630 Marionette DEBUG Closed connection 373
16:42:56 INFO - 1499902976630 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49796
16:42:56 INFO - 1499902976631 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976632 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976634 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976636 Marionette TRACE 374 <- [1,1,null,{"sessionId":"b4080404-6531-4523-863a-e0a673045309","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976637 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
16:42:56 INFO - 1499902976638 Marionette TRACE 374 <- [1,2,null,{}]
16:42:56 INFO - 1499902976640 Marionette DEBUG Closed connection 374
16:42:56 INFO - 1499902976640 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49797
16:42:56 INFO - 1499902976641 Marionette DEBUG Closed connection 375
16:42:56 INFO - 1499902976642 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49798
16:42:56 INFO - 1499902976643 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:56 INFO - 1499902976643 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976645 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976648 Marionette TRACE 376 <- [1,1,null,{"sessionId":"9d1a2673-4456-4371-b240-4fdf70c51c2b","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976649 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"}]
16:42:56 INFO - 1499902976651 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"
16:42:56 INFO - 1499902976652 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"
16:42:56 INFO - 1499902976653 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"
16:42:56 INFO - 1499902976658 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"
16:42:56 INFO - 1499902976660 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"
16:42:56 INFO - 1499902976668 Marionette TRACE 376 <- [1,2,null,{}]
16:42:56 INFO - 1499902976671 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
16:42:56 INFO - 1499902976674 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1fd4e12c-b152-4ba8-ab31-2f2d4c2282c3","ELEMENT":"1fd4e12c-b152-4ba8-ab31-2f2d4c2282c3"}}]
16:42:56 INFO - 1499902976674 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"1fd4e12c-b152-4ba8-ab31-2f2d4c2282c3"}]
16:42:56 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 307ms
16:42:56 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
16:42:56 INFO - 1499902976906 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:42:56 INFO - 1499902976907 Marionette TRACE 376 <- [1,4,null,{}]
16:42:56 INFO - 1499902976908 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}]
16:42:56 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499902976911 Marionette TRACE 376 <- [1,5,null,{"value":null}]
16:42:56 INFO - 1499902976912 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
16:42:56 INFO - 1499902976913 Marionette TRACE 376 <- [1,6,null,{}]
16:42:56 INFO - 1499902976914 Marionette DEBUG Closed connection 376
16:42:56 INFO - 1499902976915 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49799
16:42:56 INFO - 1499902976916 Marionette DEBUG Closed connection 377
16:42:56 INFO - 1499902976917 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49800
16:42:56 INFO - 1499902976918 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976918 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976920 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976923 Marionette TRACE 378 <- [1,1,null,{"sessionId":"bb483a26-9e71-4b2c-a2fb-c96606929f21","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976924 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
16:42:56 INFO - 1499902976924 Marionette TRACE 378 <- [1,2,null,{}]
16:42:56 INFO - 1499902976925 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:56 INFO - 1499902976925 Marionette TRACE 378 <- [1,3,null,{}]
16:42:56 INFO - 1499902976926 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:56 INFO - 1499902976927 Marionette TRACE 378 <- [1,4,null,{}]
16:42:56 INFO - 1499902976928 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}]
16:42:56 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499902976930 Marionette TRACE 378 <- [1,5,null,{"value":null}]
16:42:56 INFO - 1499902976931 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
16:42:56 INFO - 1499902976932 Marionette TRACE 378 <- [1,6,null,{}]
16:42:56 INFO - 1499902976933 Marionette DEBUG Closed connection 378
16:42:56 INFO - 1499902976934 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49801
16:42:56 INFO - 1499902976935 Marionette DEBUG Closed connection 379
16:42:56 INFO - 1499902976935 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49802
16:42:56 INFO - 1499902976936 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:56 INFO - 1499902976937 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976939 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976941 Marionette TRACE 380 <- [1,1,null,{"sessionId":"7769e9be-75e8-4de4-ba69-4599b450b7e0","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976942 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
16:42:56 INFO - 1499902976943 Marionette TRACE 380 <- [1,2,null,{}]
16:42:56 INFO - 1499902976945 Marionette DEBUG Closed connection 380
16:42:56 INFO - 1499902976945 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49803
16:42:56 INFO - 1499902976946 Marionette DEBUG Closed connection 381
16:42:56 INFO - 1499902976946 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49804
16:42:56 INFO - 1499902976947 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:56 INFO - 1499902976948 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:56 INFO - 1499902976950 Marionette DEBUG Register listener.js for window 4294967297
16:42:56 INFO - 1499902976952 Marionette TRACE 382 <- [1,1,null,{"sessionId":"fbb7b882-a8b3-49e3-a001-22b4cdfcda56","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:56 INFO - 1499902976953 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"}]
16:42:56 INFO - 1499902976955 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"
16:42:56 INFO - 1499902976957 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"
16:42:56 INFO - 1499902976957 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"
16:42:56 INFO - 1499902976965 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"
16:42:56 INFO - 1499902976967 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"
16:42:56 INFO - 1499902976971 Marionette TRACE 382 <- [1,2,null,{}]
16:42:56 INFO - 1499902976974 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
16:42:56 INFO - 1499902976982 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a3bd03d-0955-4e1d-b551-a5290c9bab80","ELEMENT":"2a3bd03d-0955-4e1d-b551-a5290c9bab80"}}]
16:42:56 INFO - 1499902976983 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"2a3bd03d-0955-4e1d-b551-a5290c9bab80"}]
16:42:57 INFO - 1499902977225 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:42:57 INFO - 1499902977226 Marionette TRACE 382 <- [1,4,null,{}]
16:42:57 INFO - 1499902977228 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}]
16:42:57 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499902977230 Marionette TRACE 382 <- [1,5,null,{"value":null}]
16:42:57 INFO - 1499902977231 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
16:42:57 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 319ms
16:42:57 INFO - TEST-START | test_click.py TestClick.test_input_file
16:42:57 INFO - 1499902977232 Marionette TRACE 382 <- [1,6,null,{}]
16:42:57 INFO - 1499902977234 Marionette DEBUG Closed connection 382
16:42:57 INFO - 1499902977235 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49805
16:42:57 INFO - 1499902977235 Marionette DEBUG Closed connection 383
16:42:57 INFO - 1499902977236 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49806
16:42:57 INFO - 1499902977237 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977237 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977239 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977242 Marionette TRACE 384 <- [1,1,null,{"sessionId":"b3d44a4f-0839-4bdf-bc92-b13d91d531cc","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977243 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
16:42:57 INFO - 1499902977244 Marionette TRACE 384 <- [1,2,null,{}]
16:42:57 INFO - 1499902977245 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:57 INFO - 1499902977245 Marionette TRACE 384 <- [1,3,null,{}]
16:42:57 INFO - 1499902977246 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:57 INFO - 1499902977246 Marionette TRACE 384 <- [1,4,null,{}]
16:42:57 INFO - 1499902977248 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}]
16:42:57 INFO - TEST-START: test_click.py TestClick.test_input_file1499902977250 Marionette TRACE 384 <- [1,5,null,{"value":null}]
16:42:57 INFO - 1499902977251 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
16:42:57 INFO - 1499902977253 Marionette TRACE 384 <- [1,6,null,{}]
16:42:57 INFO - 1499902977254 Marionette DEBUG Closed connection 384
16:42:57 INFO - 1499902977254 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49807
16:42:57 INFO - 1499902977255 Marionette DEBUG Closed connection 385
16:42:57 INFO - 1499902977256 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49808
16:42:57 INFO - 1499902977257 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977257 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977260 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977269 Marionette TRACE 386 <- [1,1,null,{"sessionId":"173848ef-805a-4978-b6dd-a27139a4374c","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977271 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
16:42:57 INFO - 1499902977272 Marionette TRACE 386 <- [1,2,null,{}]
16:42:57 INFO - 1499902977273 Marionette DEBUG Closed connection 386
16:42:57 INFO - 1499902977273 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49809
16:42:57 INFO - 1499902977274 Marionette DEBUG Closed connection 387
16:42:57 INFO - 1499902977275 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49810
16:42:57 INFO - 1499902977276 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:57 INFO - 1499902977276 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977278 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977281 Marionette TRACE 388 <- [1,1,null,{"sessionId":"074cf4de-3396-4448-b02b-4695ff568a3e","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977282 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
16:42:57 INFO - 1499902977283 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"
16:42:57 INFO - 1499902977285 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"
16:42:57 INFO - 1499902977285 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"
16:42:57 INFO - 1499902977290 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:42:57 INFO - 1499902977293 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:42:57 INFO - 1499902977298 Marionette TRACE 388 <- [1,2,null,{}]
16:42:57 INFO - 1499902977301 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
16:42:57 INFO - 1499902977313 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fb423e03-8bad-4643-888c-d50da157e167","ELEMENT":"fb423e03-8bad-4643-888c-d50da157e167"}}]
16:42:57 INFO - 1499902977314 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"fb423e03-8bad-4643-888c-d50da157e167"}]
16:42:57 INFO - 1499902977339 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:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
16:42:57 INFO - 1499902977341 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}]
16:42:57 INFO - TEST-END: test_click.py TestClick.test_input_file1499902977343 Marionette TRACE 388 <- [1,5,null,{"value":null}]
16:42:57 INFO - 1499902977344 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
16:42:57 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 113ms
16:42:57 INFO - TEST-START | test_click.py TestClick.test_obscured_element
16:42:57 INFO - 1499902977345 Marionette TRACE 388 <- [1,6,null,{}]
16:42:57 INFO - 1499902977346 Marionette DEBUG Closed connection 388
16:42:57 INFO - 1499902977347 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49811
16:42:57 INFO - 1499902977348 Marionette DEBUG Closed connection 389
16:42:57 INFO - 1499902977349 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49812
16:42:57 INFO - 1499902977349 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977350 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977352 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977355 Marionette TRACE 390 <- [1,1,null,{"sessionId":"b58e80b8-c98f-4694-b5a0-9323faf61760","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977356 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
16:42:57 INFO - 1499902977356 Marionette TRACE 390 <- [1,2,null,{}]
16:42:57 INFO - 1499902977357 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:57 INFO - 1499902977357 Marionette TRACE 390 <- [1,3,null,{}]
16:42:57 INFO - 1499902977358 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:57 INFO - 1499902977358 Marionette TRACE 390 <- [1,4,null,{}]
16:42:57 INFO - 1499902977360 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}]
16:42:57 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499902977362 Marionette TRACE 390 <- [1,5,null,{"value":null}]
16:42:57 INFO - 1499902977363 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
16:42:57 INFO - 1499902977364 Marionette TRACE 390 <- [1,6,null,{}]
16:42:57 INFO - 1499902977365 Marionette DEBUG Closed connection 390
16:42:57 INFO - 1499902977366 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49813
16:42:57 INFO - 1499902977366 Marionette DEBUG Closed connection 391
16:42:57 INFO - 1499902977367 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49814
16:42:57 INFO - 1499902977367 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977368 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977370 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977373 Marionette TRACE 392 <- [1,1,null,{"sessionId":"0facd62e-b5b1-4296-ae55-34ce5560854c","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977374 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
16:42:57 INFO - 1499902977375 Marionette TRACE 392 <- [1,2,null,{}]
16:42:57 INFO - 1499902977376 Marionette DEBUG Closed connection 392
16:42:57 INFO - 1499902977377 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49815
16:42:57 INFO - 1499902977377 Marionette DEBUG Closed connection 393
16:42:57 INFO - 1499902977378 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49816
16:42:57 INFO - 1499902977379 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:57 INFO - 1499902977379 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977381 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977384 Marionette TRACE 394 <- [1,1,null,{"sessionId":"1a4ac4b6-c969-444d-83c4-3eb979c4c0f4","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977385 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"}]
16:42:57 INFO - 1499902977387 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:42:57 INFO - 1499902977388 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:42:57 INFO - 1499902977389 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:42:57 INFO - 1499902977396 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"
16:42:57 INFO - 1499902977397 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"
16:42:57 INFO - 1499902977402 Marionette TRACE 394 <- [1,2,null,{}]
16:42:57 INFO - 1499902977405 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
16:42:57 INFO - 1499902977407 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"245c01ef-f8a3-4592-9cfe-64f497dfe599","ELEMENT":"245c01ef-f8a3-4592-9cfe-64f497dfe599"}}]
16:42:57 INFO - 1499902977408 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
16:42:57 INFO - 1499902977414 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"17319044-0aaa-4c54-9dd3-19c836916349","ELEMENT":"17319044-0aaa-4c54-9dd3-19c836916349"}}]
16:42:57 INFO - 1499902977415 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"245c01ef-f8a3-4592-9cfe-64f497dfe599"}]
16:42:57 INFO - 1499902977655 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:42:57 INFO - 1499902977656 Marionette TRACE 394 <- [1,5,null,{}]
16:42:57 INFO - 1499902977657 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"17319044-0aaa-4c54-9dd3-19c836916349"}]
16:42:57 INFO - 1499902977670 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:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
16:42:57 INFO - 1499902977672 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
16:42:57 INFO - 1499902977674 Marionette TRACE 394 <- [1,7,null,{"value":false}]
16:42:57 INFO - 1499902977676 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}]
16:42:57 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499902977678 Marionette TRACE 394 <- [1,8,null,{"value":null}]
16:42:57 INFO - 1499902977679 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
16:42:57 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 335ms
16:42:57 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
16:42:57 INFO - 1499902977680 Marionette TRACE 394 <- [1,9,null,{}]
16:42:57 INFO - 1499902977682 Marionette DEBUG Closed connection 394
16:42:57 INFO - 1499902977683 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49817
16:42:57 INFO - 1499902977683 Marionette DEBUG Closed connection 395
16:42:57 INFO - 1499902977684 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49818
16:42:57 INFO - 1499902977685 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977685 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977688 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977690 Marionette TRACE 396 <- [1,1,null,{"sessionId":"c0f3d2e9-5c7d-4b76-aa09-517511eb2821","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977691 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
16:42:57 INFO - 1499902977692 Marionette TRACE 396 <- [1,2,null,{}]
16:42:57 INFO - 1499902977693 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:42:57 INFO - 1499902977693 Marionette TRACE 396 <- [1,3,null,{}]
16:42:57 INFO - 1499902977694 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
16:42:57 INFO - 1499902977694 Marionette TRACE 396 <- [1,4,null,{}]
16:42:57 INFO - 1499902977695 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}]
16:42:57 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499902977698 Marionette TRACE 396 <- [1,5,null,{"value":null}]
16:42:57 INFO - 1499902977699 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
16:42:57 INFO - 1499902977700 Marionette TRACE 396 <- [1,6,null,{}]
16:42:57 INFO - 1499902977701 Marionette DEBUG Closed connection 396
16:42:57 INFO - 1499902977701 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49819
16:42:57 INFO - 1499902977702 Marionette DEBUG Closed connection 397
16:42:57 INFO - 1499902977703 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49820
16:42:57 INFO - 1499902977703 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:42:57 INFO - 1499902977704 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977706 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977709 Marionette TRACE 398 <- [1,1,null,{"sessionId":"f3718aad-b155-4831-93a9-1957108591dc","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977710 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
16:42:57 INFO - 1499902977711 Marionette TRACE 398 <- [1,2,null,{}]
16:42:57 INFO - 1499902977712 Marionette DEBUG Closed connection 398
16:42:57 INFO - 1499902977713 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49821
16:42:57 INFO - 1499902977713 Marionette DEBUG Closed connection 399
16:42:57 INFO - 1499902977714 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49822
16:42:57 INFO - 1499902977715 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:42:57 INFO - 1499902977715 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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}
16:42:57 INFO - 1499902977717 Marionette DEBUG Register listener.js for window 4294967297
16:42:57 INFO - 1499902977720 Marionette TRACE 400 <- [1,1,null,{"sessionId":"e9e12a91-2a07-42ff-83bb-53000a75f402","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":3300,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-024.001\\AppData\\Local\\Temp\\tmpajulpw.mozrunner","moz:accessibilityChecks":false}}]
16:42:57 INFO - 1499902977722 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"}]
16:42:57 INFO - 1499902977723 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"
16:42:57 INFO - 1499902977725 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"
16:42:57 INFO - 1499902977725 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"
16:42:57 INFO - 1499902977736 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"
16:42:57 INFO - 1499902977738 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"
16:42:57 INFO - 1499902977741 Marionette TRACE 400 <- [1,2,null,{}]
16:42:57 INFO - 1499902977747 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
16:42:57 INFO - 1499902977750 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bf659c52-0d8a-488c-b74b-01eb5c367d0e","ELEMENT":"bf659c52-0d8a-488c-b74b-01eb5c367d0e"}}]
16:42:57 INFO - 1499902977751 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"bf659c52-0d8a-488c-b74b-01eb5c367d0e"}]
16:42:57 INFO - 1499902977771 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
16:42:57 INFO - 1499902977772 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"bf659c52-0d8a-488c-b74b-01eb5c367d0e"}]
16:42:57 INFO - 1499902977786 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element