could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
21:27:20 INFO - 1499142440778 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}]
21:27:20 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499142440780 Marionette TRACE 352 <- [1,5,null,{"value":null}]
21:27:20 INFO - 1499142440781 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
21:27:20 INFO - 1499142440782 Marionette TRACE 352 <- [1,6,null,{}]
21:27:20 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 136ms
21:27:20 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
21:27:20 INFO - 1499142440793 Marionette DEBUG Closed connection 352
21:27:20 INFO - 1499142440794 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49758
21:27:20 INFO - 1499142440795 Marionette DEBUG Closed connection 353
21:27:20 INFO - 1499142440796 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49759
21:27:20 INFO - 1499142440796 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:20 INFO - 1499142440797 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:20 INFO - 1499142440799 Marionette DEBUG Register listener.js for window 12
21:27:20 INFO - 1499142440802 Marionette TRACE 354 <- [1,1,null,{"sessionId":"c8f33919-e956-485f-89a1-0100bc84b261","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:20 INFO - 1499142440803 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
21:27:20 INFO - 1499142440803 Marionette TRACE 354 <- [1,2,null,{}]
21:27:20 INFO - 1499142440804 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:20 INFO - 1499142440805 Marionette TRACE 354 <- [1,3,null,{}]
21:27:20 INFO - 1499142440805 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:20 INFO - 1499142440806 Marionette TRACE 354 <- [1,4,null,{}]
21:27:20 INFO - 1499142440807 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}]
21:27:20 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499142440809 Marionette TRACE 354 <- [1,5,null,{"value":null}]
21:27:20 INFO - 1499142440810 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
21:27:20 INFO - 1499142440811 Marionette TRACE 354 <- [1,6,null,{}]
21:27:20 INFO - 1499142440813 Marionette DEBUG Closed connection 354
21:27:20 INFO - 1499142440814 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49760
21:27:20 INFO - 1499142440814 Marionette DEBUG Closed connection 355
21:27:20 INFO - 1499142440815 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49761
21:27:20 INFO - 1499142440816 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:20 INFO - 1499142440816 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:20 INFO - 1499142440819 Marionette DEBUG Register listener.js for window 12
21:27:20 INFO - 1499142440821 Marionette TRACE 356 <- [1,1,null,{"sessionId":"1df75fcc-5a56-4ffb-85a4-e79e19542a95","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:20 INFO - 1499142440822 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
21:27:20 INFO - 1499142440823 Marionette TRACE 356 <- [1,2,null,{}]
21:27:20 INFO - 1499142440825 Marionette DEBUG Closed connection 356
21:27:20 INFO - 1499142440825 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49762
21:27:20 INFO - 1499142440826 Marionette DEBUG Closed connection 357
21:27:20 INFO - 1499142440827 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49763
21:27:20 INFO - 1499142440830 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:20 INFO - 1499142440831 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:20 INFO - 1499142440833 Marionette DEBUG Register listener.js for window 12
21:27:20 INFO - 1499142440835 Marionette TRACE 358 <- [1,1,null,{"sessionId":"fe99ac3d-15d1-43c8-bc98-d62c90a3bb55","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:20 INFO - 1499142440839 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
21:27:20 INFO - 1499142440840 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
21:27:20 INFO - 1499142440844 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
21:27:20 INFO - 1499142440845 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
21:27:20 INFO - 1499142440860 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
21:27:20 INFO - 1499142440865 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
21:27:20 INFO - 1499142440875 Marionette TRACE 358 <- [1,2,null,{}]
21:27:20 INFO - 1499142440876 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
21:27:20 INFO - 1499142440878 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"721e32be-8ccf-46f5-8bd5-123e9bb348b9","ELEMENT":"721e32be-8ccf-46f5-8bd5-123e9bb348b9"}}]
21:27:20 INFO - 1499142440880 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"721e32be-8ccf-46f5-8bd5-123e9bb348b9"}]
21:27:20 INFO - 1499142440922 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
21:27:20 INFO - 1499142440926 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
21:27:20 INFO - 1499142440927 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
21:27:20 INFO - 1499142440942 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
21:27:20 INFO - 1499142440945 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
21:27:20 INFO - 1499142440952 Marionette TRACE 358 <- [1,4,null,{}]
21:27:20 INFO - 1499142440954 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
21:27:20 INFO - 1499142440955 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"68c547b4-2b81-4bc3-a489-028699ab38be","ELEMENT":"68c547b4-2b81-4bc3-a489-028699ab38be"}}]
21:27:20 INFO - 1499142440956 Marionette TRACE 358 -> [0,6,"getTitle",{}]
21:27:20 INFO - 1499142440958 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
21:27:20 INFO - 1499142440959 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}]
21:27:20 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499142440961 Marionette TRACE 358 <- [1,7,null,{"value":null}]
21:27:20 INFO - 1499142440962 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
21:27:20 INFO - 1499142440963 Marionette TRACE 358 <- [1,8,null,{}]
21:27:20 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 180ms
21:27:20 INFO - TEST-START | test_click.py TestClick.test_container_element
21:27:20 INFO - 1499142440965 Marionette DEBUG Closed connection 358
21:27:20 INFO - 1499142440966 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49766
21:27:20 INFO - 1499142440967 Marionette DEBUG Closed connection 359
21:27:20 INFO - 1499142440968 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49767
21:27:20 INFO - 1499142440969 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:20 INFO - 1499142440969 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:20 INFO - 1499142440972 Marionette DEBUG Register listener.js for window 12
21:27:20 INFO - 1499142440975 Marionette TRACE 360 <- [1,1,null,{"sessionId":"bfec98b7-e71b-41fd-9b7c-9bead5fd89f9","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:20 INFO - 1499142440976 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
21:27:20 INFO - 1499142440976 Marionette TRACE 360 <- [1,2,null,{}]
21:27:20 INFO - 1499142440977 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:20 INFO - 1499142440977 Marionette TRACE 360 <- [1,3,null,{}]
21:27:20 INFO - 1499142440978 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:20 INFO - 1499142440978 Marionette TRACE 360 <- [1,4,null,{}]
21:27:20 INFO - 1499142440981 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}]
21:27:20 INFO - TEST-START: test_click.py TestClick.test_container_element1499142440983 Marionette TRACE 360 <- [1,5,null,{"value":null}]
21:27:20 INFO - 1499142440984 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
21:27:20 INFO - 1499142440985 Marionette TRACE 360 <- [1,6,null,{}]
21:27:20 INFO - 1499142440987 Marionette DEBUG Closed connection 360
21:27:20 INFO - 1499142440988 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49768
21:27:20 INFO - 1499142440989 Marionette DEBUG Closed connection 361
21:27:20 INFO - 1499142440989 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49769
21:27:20 INFO - 1499142440990 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:20 INFO - 1499142440991 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:20 INFO - 1499142440993 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142440997 Marionette TRACE 362 <- [1,1,null,{"sessionId":"e34e044b-88e0-4927-afd0-80dd68f782cf","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142440998 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
21:27:21 INFO - 1499142440999 Marionette TRACE 362 <- [1,2,null,{}]
21:27:21 INFO - 1499142441001 Marionette DEBUG Closed connection 362
21:27:21 INFO - 1499142441002 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49770
21:27:21 INFO - 1499142441002 Marionette DEBUG Closed connection 363
21:27:21 INFO - 1499142441003 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49771
21:27:21 INFO - 1499142441004 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:21 INFO - 1499142441005 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441007 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441011 Marionette TRACE 364 <- [1,1,null,{"sessionId":"0d84f158-1789-4dfc-8145-d5420a1d7d33","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441013 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"}]
21:27:21 INFO - 1499142441015 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
21:27:21 INFO - 1499142441016 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
21:27:21 INFO - 1499142441016 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
21:27:21 INFO - 1499142441037 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"
21:27:21 INFO - 1499142441038 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"
21:27:21 INFO - 1499142441041 Marionette TRACE 364 <- [1,2,null,{}]
21:27:21 INFO - 1499142441042 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:27:21 INFO - 1499142441044 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"352b1dd2-03ce-4449-97d2-d46e842f7639","ELEMENT":"352b1dd2-03ce-4449-97d2-d46e842f7639"}}]
21:27:21 INFO - 1499142441050 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"352b1dd2-03ce-4449-97d2-d46e842f7639"}]
21:27:21 INFO - 1499142441287 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:27:21 INFO - 1499142441288 Marionette TRACE 364 <- [1,4,null,{}]
21:27:21 INFO - 1499142441289 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"352b1dd2-03ce-4449-97d2-d46e842f7639","name":"selected"}]
21:27:21 INFO - 1499142441293 Marionette TRACE 364 <- [1,5,null,{"value":true}]
21:27:21 INFO - 1499142441294 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}]
21:27:21 INFO - TEST-END: test_click.py TestClick.test_container_element1499142441296 Marionette TRACE 364 <- [1,6,null,{"value":null}]
21:27:21 INFO - 1499142441297 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
21:27:21 INFO - 1499142441298 Marionette TRACE 364 <- [1,7,null,{}]
21:27:21 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 335ms
21:27:21 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
21:27:21 INFO - 1499142441300 Marionette DEBUG Closed connection 364
21:27:21 INFO - 1499142441301 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49772
21:27:21 INFO - 1499142441302 Marionette DEBUG Closed connection 365
21:27:21 INFO - 1499142441303 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49773
21:27:21 INFO - 1499142441304 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441304 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441306 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441309 Marionette TRACE 366 <- [1,1,null,{"sessionId":"de8bb7c5-38eb-46f2-8e76-b6c1cf0022b5","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441310 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
21:27:21 INFO - 1499142441310 Marionette TRACE 366 <- [1,2,null,{}]
21:27:21 INFO - 1499142441311 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:21 INFO - 1499142441311 Marionette TRACE 366 <- [1,3,null,{}]
21:27:21 INFO - 1499142441312 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:21 INFO - 1499142441313 Marionette TRACE 366 <- [1,4,null,{}]
21:27:21 INFO - 1499142441315 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}]
21:27:21 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499142441317 Marionette TRACE 366 <- [1,5,null,{"value":null}]
21:27:21 INFO - 1499142441318 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
21:27:21 INFO - 1499142441319 Marionette TRACE 366 <- [1,6,null,{}]
21:27:21 INFO - 1499142441320 Marionette DEBUG Closed connection 366
21:27:21 INFO - 1499142441321 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49774
21:27:21 INFO - 1499142441322 Marionette DEBUG Closed connection 367
21:27:21 INFO - 1499142441322 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49775
21:27:21 INFO - 1499142441323 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441324 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441326 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441328 Marionette TRACE 368 <- [1,1,null,{"sessionId":"c5d8d1ba-1b63-463e-9062-75c990d06617","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441329 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
21:27:21 INFO - 1499142441330 Marionette TRACE 368 <- [1,2,null,{}]
21:27:21 INFO - 1499142441332 Marionette DEBUG Closed connection 368
21:27:21 INFO - 1499142441332 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49776
21:27:21 INFO - 1499142441333 Marionette DEBUG Closed connection 369
21:27:21 INFO - 1499142441334 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49777
21:27:21 INFO - 1499142441335 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:21 INFO - 1499142441335 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441337 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441339 Marionette TRACE 370 <- [1,1,null,{"sessionId":"e80b58b7-8795-4594-bfb8-2950148c6f1e","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441340 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"}]
21:27:21 INFO - 1499142441341 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"
21:27:21 INFO - 1499142441343 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"
21:27:21 INFO - 1499142441343 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"
21:27:21 INFO - 1499142441358 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"
21:27:21 INFO - 1499142441361 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"
21:27:21 INFO - 1499142441369 Marionette TRACE 370 <- [1,2,null,{}]
21:27:21 INFO - 1499142441371 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
21:27:21 INFO - 1499142441373 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b4cc7909-85ea-467b-8661-4563d3a75ca8","ELEMENT":"b4cc7909-85ea-467b-8661-4563d3a75ca8"}}]
21:27:21 INFO - 1499142441373 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"b4cc7909-85ea-467b-8661-4563d3a75ca8"}]
21:27:21 INFO - 1499142441622 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:27:21 INFO - 1499142441623 Marionette TRACE 370 <- [1,4,null,{}]
21:27:21 INFO - 1499142441624 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"b4cc7909-85ea-467b-8661-4563d3a75ca8","name":"selected"}]
21:27:21 INFO - 1499142441629 Marionette TRACE 370 <- [1,5,null,{"value":true}]
21:27:21 INFO - 1499142441631 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}]
21:27:21 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499142441633 Marionette TRACE 370 <- [1,6,null,{"value":null}]
21:27:21 INFO - 1499142441634 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
21:27:21 INFO - 1499142441635 Marionette TRACE 370 <- [1,7,null,{}]
21:27:21 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 336ms
21:27:21 INFO - TEST-START | test_click.py TestClick.test_css_transforms
21:27:21 INFO - 1499142441636 Marionette DEBUG Closed connection 370
21:27:21 INFO - 1499142441637 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49778
21:27:21 INFO - 1499142441638 Marionette DEBUG Closed connection 371
21:27:21 INFO - 1499142441639 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49779
21:27:21 INFO - 1499142441640 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441640 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441642 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441645 Marionette TRACE 372 <- [1,1,null,{"sessionId":"f6b393cc-c812-43e4-b6ba-4105639c34e1","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441646 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
21:27:21 INFO - 1499142441646 Marionette TRACE 372 <- [1,2,null,{}]
21:27:21 INFO - 1499142441647 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:21 INFO - 1499142441647 Marionette TRACE 372 <- [1,3,null,{}]
21:27:21 INFO - 1499142441648 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:21 INFO - 1499142441648 Marionette TRACE 372 <- [1,4,null,{}]
21:27:21 INFO - 1499142441650 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}]
21:27:21 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499142441652 Marionette TRACE 372 <- [1,5,null,{"value":null}]
21:27:21 INFO - 1499142441652 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
21:27:21 INFO - 1499142441653 Marionette TRACE 372 <- [1,6,null,{}]
21:27:21 INFO - 1499142441655 Marionette DEBUG Closed connection 372
21:27:21 INFO - 1499142441656 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49780
21:27:21 INFO - 1499142441657 Marionette DEBUG Closed connection 373
21:27:21 INFO - 1499142441657 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49781
21:27:21 INFO - 1499142441658 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441659 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441661 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441663 Marionette TRACE 374 <- [1,1,null,{"sessionId":"f2ae91ea-7115-4b38-b0f3-122e81532040","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441664 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
21:27:21 INFO - 1499142441665 Marionette TRACE 374 <- [1,2,null,{}]
21:27:21 INFO - 1499142441667 Marionette DEBUG Closed connection 374
21:27:21 INFO - 1499142441667 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49782
21:27:21 INFO - 1499142441668 Marionette DEBUG Closed connection 375
21:27:21 INFO - 1499142441669 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49783
21:27:21 INFO - 1499142441669 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:21 INFO - 1499142441670 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441672 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441674 Marionette TRACE 376 <- [1,1,null,{"sessionId":"97d7199c-4cac-4fb4-961d-3656fcfd4ecc","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441675 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"}]
21:27:21 INFO - 1499142441676 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"
21:27:21 INFO - 1499142441678 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"
21:27:21 INFO - 1499142441679 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"
21:27:21 INFO - 1499142441688 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"
21:27:21 INFO - 1499142441691 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"
21:27:21 INFO - 1499142441693 Marionette TRACE 376 <- [1,2,null,{}]
21:27:21 INFO - 1499142441701 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
21:27:21 INFO - 1499142441703 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3494cda7-8db4-4678-ac26-a5642e228e48","ELEMENT":"3494cda7-8db4-4678-ac26-a5642e228e48"}}]
21:27:21 INFO - 1499142441705 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"3494cda7-8db4-4678-ac26-a5642e228e48"}]
21:27:21 INFO - 1499142441940 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:27:21 INFO - 1499142441941 Marionette TRACE 376 <- [1,4,null,{}]
21:27:21 INFO - 1499142441943 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}]
21:27:21 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499142441945 Marionette TRACE 376 <- [1,5,null,{"value":null}]
21:27:21 INFO - 1499142441946 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
21:27:21 INFO - 1499142441947 Marionette TRACE 376 <- [1,6,null,{}]
21:27:21 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 312ms
21:27:21 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
21:27:21 INFO - 1499142441949 Marionette DEBUG Closed connection 376
21:27:21 INFO - 1499142441950 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49784
21:27:21 INFO - 1499142441951 Marionette DEBUG Closed connection 377
21:27:21 INFO - 1499142441951 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49785
21:27:21 INFO - 1499142441952 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441953 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441955 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441957 Marionette TRACE 378 <- [1,1,null,{"sessionId":"51d12305-4657-400e-9599-f257d92d748d","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441958 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
21:27:21 INFO - 1499142441959 Marionette TRACE 378 <- [1,2,null,{}]
21:27:21 INFO - 1499142441960 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:21 INFO - 1499142441960 Marionette TRACE 378 <- [1,3,null,{}]
21:27:21 INFO - 1499142441961 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:21 INFO - 1499142441961 Marionette TRACE 378 <- [1,4,null,{}]
21:27:21 INFO - 1499142441963 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}]
21:27:21 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499142441965 Marionette TRACE 378 <- [1,5,null,{"value":null}]
21:27:21 INFO - 1499142441966 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
21:27:21 INFO - 1499142441967 Marionette TRACE 378 <- [1,6,null,{}]
21:27:21 INFO - 1499142441968 Marionette DEBUG Closed connection 378
21:27:21 INFO - 1499142441969 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49786
21:27:21 INFO - 1499142441969 Marionette DEBUG Closed connection 379
21:27:21 INFO - 1499142441970 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49787
21:27:21 INFO - 1499142441971 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:21 INFO - 1499142441971 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441974 Marionette DEBUG Register listener.js for window 12
21:27:21 INFO - 1499142441985 Marionette TRACE 380 <- [1,1,null,{"sessionId":"751acf41-2324-4542-8155-c5db39395163","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:21 INFO - 1499142441986 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
21:27:21 INFO - 1499142441987 Marionette TRACE 380 <- [1,2,null,{}]
21:27:21 INFO - 1499142441989 Marionette DEBUG Closed connection 380
21:27:21 INFO - 1499142441990 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49788
21:27:21 INFO - 1499142441990 Marionette DEBUG Closed connection 381
21:27:21 INFO - 1499142441991 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49789
21:27:21 INFO - 1499142441992 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:21 INFO - 1499142441992 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:21 INFO - 1499142441994 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142441997 Marionette TRACE 382 <- [1,1,null,{"sessionId":"4d0652ab-1ee9-423f-9bbd-2195054c7ec7","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142441998 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"}]
21:27:22 INFO - 1499142441999 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"
21:27:22 INFO - 1499142442001 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"
21:27:22 INFO - 1499142442001 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"
21:27:22 INFO - 1499142442010 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"
21:27:22 INFO - 1499142442018 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"
21:27:22 INFO - 1499142442022 Marionette TRACE 382 <- [1,2,null,{}]
21:27:22 INFO - 1499142442023 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
21:27:22 INFO - 1499142442024 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"62087cc8-170d-42e0-a858-0e03b1bcb9ad","ELEMENT":"62087cc8-170d-42e0-a858-0e03b1bcb9ad"}}]
21:27:22 INFO - 1499142442025 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"62087cc8-170d-42e0-a858-0e03b1bcb9ad"}]
21:27:22 INFO - 1499142442266 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:27:22 INFO - 1499142442267 Marionette TRACE 382 <- [1,4,null,{}]
21:27:22 INFO - 1499142442269 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}]
21:27:22 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499142442271 Marionette TRACE 382 <- [1,5,null,{"value":null}]
21:27:22 INFO - 1499142442271 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
21:27:22 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 325ms
21:27:22 INFO - TEST-START | test_click.py TestClick.test_input_file
21:27:22 INFO - 1499142442273 Marionette TRACE 382 <- [1,6,null,{}]
21:27:22 INFO - 1499142442274 Marionette DEBUG Closed connection 382
21:27:22 INFO - 1499142442275 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49790
21:27:22 INFO - 1499142442276 Marionette DEBUG Closed connection 383
21:27:22 INFO - 1499142442276 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49791
21:27:22 INFO - 1499142442277 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442278 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442280 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442282 Marionette TRACE 384 <- [1,1,null,{"sessionId":"5e9f0beb-3fb4-41b5-9867-bb384b1a0066","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442284 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
21:27:22 INFO - 1499142442284 Marionette TRACE 384 <- [1,2,null,{}]
21:27:22 INFO - 1499142442285 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:22 INFO - 1499142442285 Marionette TRACE 384 <- [1,3,null,{}]
21:27:22 INFO - 1499142442286 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:22 INFO - 1499142442287 Marionette TRACE 384 <- [1,4,null,{}]
21:27:22 INFO - 1499142442288 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}]
21:27:22 INFO - TEST-START: test_click.py TestClick.test_input_file1499142442290 Marionette TRACE 384 <- [1,5,null,{"value":null}]
21:27:22 INFO - 1499142442291 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
21:27:22 INFO - 1499142442292 Marionette TRACE 384 <- [1,6,null,{}]
21:27:22 INFO - 1499142442294 Marionette DEBUG Closed connection 384
21:27:22 INFO - 1499142442294 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49792
21:27:22 INFO - 1499142442295 Marionette DEBUG Closed connection 385
21:27:22 INFO - 1499142442296 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49793
21:27:22 INFO - 1499142442297 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442297 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442299 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442302 Marionette TRACE 386 <- [1,1,null,{"sessionId":"e9eee17e-8484-4748-8c1a-890eeb26b972","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442303 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
21:27:22 INFO - 1499142442304 Marionette TRACE 386 <- [1,2,null,{}]
21:27:22 INFO - 1499142442306 Marionette DEBUG Closed connection 386
21:27:22 INFO - 1499142442307 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49794
21:27:22 INFO - 1499142442307 Marionette DEBUG Closed connection 387
21:27:22 INFO - 1499142442308 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49795
21:27:22 INFO - 1499142442309 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:22 INFO - 1499142442309 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442311 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442314 Marionette TRACE 388 <- [1,1,null,{"sessionId":"86108be3-acbb-41f6-a446-3055e391bd36","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442315 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
21:27:22 INFO - 1499142442316 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"
21:27:22 INFO - 1499142442318 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"
21:27:22 INFO - 1499142442318 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"
21:27:22 INFO - 1499142442327 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:27:22 INFO - 1499142442336 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:27:22 INFO - 1499142442340 Marionette TRACE 388 <- [1,2,null,{}]
21:27:22 INFO - 1499142442341 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
21:27:22 INFO - 1499142442342 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ce740e74-ce58-4738-9f0d-041ae12811e2","ELEMENT":"ce740e74-ce58-4738-9f0d-041ae12811e2"}}]
21:27:22 INFO - 1499142442343 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"ce740e74-ce58-4738-9f0d-041ae12811e2"}]
21:27:22 INFO - 1499142442378 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
21:27:22 INFO - 1499142442380 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}]
21:27:22 INFO - TEST-END: test_click.py TestClick.test_input_file1499142442382 Marionette TRACE 388 <- [1,5,null,{"value":null}]
21:27:22 INFO - 1499142442383 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
21:27:22 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 112ms
21:27:22 INFO - TEST-START | test_click.py TestClick.test_obscured_element
21:27:22 INFO - 1499142442384 Marionette TRACE 388 <- [1,6,null,{}]
21:27:22 INFO - 1499142442386 Marionette DEBUG Closed connection 388
21:27:22 INFO - 1499142442387 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49796
21:27:22 INFO - 1499142442388 Marionette DEBUG Closed connection 389
21:27:22 INFO - 1499142442388 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49797
21:27:22 INFO - 1499142442389 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442389 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442391 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442394 Marionette TRACE 390 <- [1,1,null,{"sessionId":"927a9cf6-1e27-4431-acf9-20819c0e1aa4","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442395 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
21:27:22 INFO - 1499142442395 Marionette TRACE 390 <- [1,2,null,{}]
21:27:22 INFO - 1499142442396 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:22 INFO - 1499142442397 Marionette TRACE 390 <- [1,3,null,{}]
21:27:22 INFO - 1499142442398 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:22 INFO - 1499142442398 Marionette TRACE 390 <- [1,4,null,{}]
21:27:22 INFO - 1499142442400 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}]
21:27:22 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499142442402 Marionette TRACE 390 <- [1,5,null,{"value":null}]
21:27:22 INFO - 1499142442403 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
21:27:22 INFO - 1499142442404 Marionette TRACE 390 <- [1,6,null,{}]
21:27:22 INFO - 1499142442405 Marionette DEBUG Closed connection 390
21:27:22 INFO - 1499142442406 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49798
21:27:22 INFO - 1499142442407 Marionette DEBUG Closed connection 391
21:27:22 INFO - 1499142442408 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49799
21:27:22 INFO - 1499142442408 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442409 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442411 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442414 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b9a58745-7417-406b-ab6d-bfdda99beced","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442415 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
21:27:22 INFO - 1499142442417 Marionette TRACE 392 <- [1,2,null,{}]
21:27:22 INFO - 1499142442418 Marionette DEBUG Closed connection 392
21:27:22 INFO - 1499142442419 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49800
21:27:22 INFO - 1499142442420 Marionette DEBUG Closed connection 393
21:27:22 INFO - 1499142442420 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49801
21:27:22 INFO - 1499142442421 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:22 INFO - 1499142442422 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442424 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442426 Marionette TRACE 394 <- [1,1,null,{"sessionId":"17b30166-60ff-45b5-a85b-f1b5df9aa270","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442427 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"}]
21:27:22 INFO - 1499142442428 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:27:22 INFO - 1499142442430 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:27:22 INFO - 1499142442430 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
21:27:22 INFO - 1499142442439 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"
21:27:22 INFO - 1499142442442 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"
21:27:22 INFO - 1499142442445 Marionette TRACE 394 <- [1,2,null,{}]
21:27:22 INFO - 1499142442451 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
21:27:22 INFO - 1499142442454 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"022e0e58-4a4c-4fee-9cb5-354102a356cb","ELEMENT":"022e0e58-4a4c-4fee-9cb5-354102a356cb"}}]
21:27:22 INFO - 1499142442455 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
21:27:22 INFO - 1499142442456 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d6425b28-c672-46f3-ad2e-18866b3bf557","ELEMENT":"d6425b28-c672-46f3-ad2e-18866b3bf557"}}]
21:27:22 INFO - 1499142442457 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"022e0e58-4a4c-4fee-9cb5-354102a356cb"}]
21:27:22 INFO - 1499142442691 Marionette DEBUG Canceled page load listener because no navigation has been detected
21:27:22 INFO - 1499142442692 Marionette TRACE 394 <- [1,5,null,{}]
21:27:22 INFO - 1499142442693 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"d6425b28-c672-46f3-ad2e-18866b3bf557"}]
21:27:22 INFO - 1499142442706 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
21:27:22 INFO - 1499142442708 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
21:27:22 INFO - 1499142442710 Marionette TRACE 394 <- [1,7,null,{"value":false}]
21:27:22 INFO - 1499142442712 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}]
21:27:22 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499142442713 Marionette TRACE 394 <- [1,8,null,{"value":null}]
21:27:22 INFO - 1499142442714 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
21:27:22 INFO - 1499142442715 Marionette TRACE 394 <- [1,9,null,{}]
21:27:22 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 330ms
21:27:22 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
21:27:22 INFO - 1499142442717 Marionette DEBUG Closed connection 394
21:27:22 INFO - 1499142442718 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49802
21:27:22 INFO - 1499142442718 Marionette DEBUG Closed connection 395
21:27:22 INFO - 1499142442719 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49803
21:27:22 INFO - 1499142442720 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442720 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442722 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442725 Marionette TRACE 396 <- [1,1,null,{"sessionId":"978c7b9f-f8a4-4b5f-8b17-6da5b3d89f03","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442726 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
21:27:22 INFO - 1499142442726 Marionette TRACE 396 <- [1,2,null,{}]
21:27:22 INFO - 1499142442727 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
21:27:22 INFO - 1499142442728 Marionette TRACE 396 <- [1,3,null,{}]
21:27:22 INFO - 1499142442728 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
21:27:22 INFO - 1499142442729 Marionette TRACE 396 <- [1,4,null,{}]
21:27:22 INFO - 1499142442730 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}]
21:27:22 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499142442732 Marionette TRACE 396 <- [1,5,null,{"value":null}]
21:27:22 INFO - 1499142442733 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
21:27:22 INFO - 1499142442734 Marionette TRACE 396 <- [1,6,null,{}]
21:27:22 INFO - 1499142442735 Marionette DEBUG Closed connection 396
21:27:22 INFO - 1499142442736 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49804
21:27:22 INFO - 1499142442736 Marionette DEBUG Closed connection 397
21:27:22 INFO - 1499142442737 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49805
21:27:22 INFO - 1499142442737 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
21:27:22 INFO - 1499142442738 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442740 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442742 Marionette TRACE 398 <- [1,1,null,{"sessionId":"1f534b27-6c93-4423-8d17-f235138d0892","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442743 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
21:27:22 INFO - 1499142442744 Marionette TRACE 398 <- [1,2,null,{}]
21:27:22 INFO - 1499142442746 Marionette DEBUG Closed connection 398
21:27:22 INFO - 1499142442746 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49806
21:27:22 INFO - 1499142442747 Marionette DEBUG Closed connection 399
21:27:22 INFO - 1499142442747 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49807
21:27:22 INFO - 1499142442748 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
21:27:22 INFO - 1499142442749 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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}
21:27:22 INFO - 1499142442751 Marionette DEBUG Register listener.js for window 12
21:27:22 INFO - 1499142442753 Marionette TRACE 400 <- [1,1,null,{"sessionId":"1296ad9c-6886-4cff-afbc-13de9973a054","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":3368,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-108.001\\AppData\\Local\\Temp\\tmp1g1gmm.mozrunner","moz:accessibilityChecks":false}}]
21:27:22 INFO - 1499142442754 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"}]
21:27:22 INFO - 1499142442755 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"
21:27:22 INFO - 1499142442757 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"
21:27:22 INFO - 1499142442757 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"
21:27:22 INFO - 1499142442775 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"
21:27:22 INFO - 1499142442778 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"
21:27:22 INFO - 1499142442785 Marionette TRACE 400 <- [1,2,null,{}]
21:27:22 INFO - 1499142442787 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
21:27:22 INFO - 1499142442788 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0ac43660-8b4a-4023-8c0d-a48528f213f1","ELEMENT":"0ac43660-8b4a-4023-8c0d-a48528f213f1"}}]
21:27:22 INFO - 1499142442790 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0ac43660-8b4a-4023-8c0d-a48528f213f1"}]
21:27:22 INFO - 1499142442817 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
21:27:22 INFO - 1499142442819 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0ac43660-8b4a-4023-8c0d-a48528f213f1"}]
21:27:22 INFO - 1499142442835 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element