could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
04:54:08 INFO - 1501070048142 Marionette TRACE 353 -> [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}]
04:54:08 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1501070048144 Marionette TRACE 353 <- [1,5,null,{"value":null}]
04:54:08 INFO - 1501070048145 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
04:54:08 INFO - 1501070048146 Marionette TRACE 353 <- [1,6,null,{}]
04:54:08 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 135ms
04:54:08 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
04:54:08 INFO - 1501070048148 Marionette DEBUG Closed connection 353
04:54:08 INFO - 1501070048149 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49750
04:54:08 INFO - 1501070048150 Marionette DEBUG Closed connection 354
04:54:08 INFO - 1501070048150 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49751
04:54:08 INFO - 1501070048151 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048152 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048154 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048156 Marionette TRACE 355 <- [1,1,null,{"sessionId":"4e41cbcc-a120-43c6-af23-0e494d6ee870","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048164 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
04:54:08 INFO - 1501070048165 Marionette TRACE 355 <- [1,2,null,{}]
04:54:08 INFO - 1501070048166 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:08 INFO - 1501070048166 Marionette TRACE 355 <- [1,3,null,{}]
04:54:08 INFO - 1501070048166 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:08 INFO - 1501070048167 Marionette TRACE 355 <- [1,4,null,{}]
04:54:08 INFO - 1501070048168 Marionette TRACE 355 -> [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}]
04:54:08 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1501070048170 Marionette TRACE 355 <- [1,5,null,{"value":null}]
04:54:08 INFO - 1501070048171 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
04:54:08 INFO - 1501070048173 Marionette TRACE 355 <- [1,6,null,{}]
04:54:08 INFO - 1501070048175 Marionette DEBUG Closed connection 355
04:54:08 INFO - 1501070048175 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49752
04:54:08 INFO - 1501070048176 Marionette DEBUG Closed connection 356
04:54:08 INFO - 1501070048176 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49753
04:54:08 INFO - 1501070048177 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048178 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048180 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048183 Marionette TRACE 357 <- [1,1,null,{"sessionId":"9ee8bd3a-f9d1-4dbc-9674-4da3b5c31289","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048185 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
04:54:08 INFO - 1501070048186 Marionette TRACE 357 <- [1,2,null,{}]
04:54:08 INFO - 1501070048188 Marionette DEBUG Closed connection 357
04:54:08 INFO - 1501070048189 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49754
04:54:08 INFO - 1501070048189 Marionette DEBUG Closed connection 358
04:54:08 INFO - 1501070048190 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49755
04:54:08 INFO - 1501070048191 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:08 INFO - 1501070048191 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048193 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048195 Marionette TRACE 359 <- [1,1,null,{"sessionId":"0e6b3eec-ecec-4019-8df4-8240914ef351","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048197 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49323/clicks.html"}]
04:54:08 INFO - 1501070048198 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/hidden.html"
04:54:08 INFO - 1501070048203 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/hidden.html"
04:54:08 INFO - 1501070048203 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/hidden.html"
04:54:08 INFO - 1501070048218 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/clicks.html"
04:54:08 INFO - 1501070048221 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/clicks.html"
04:54:08 INFO - 1501070048224 Marionette TRACE 359 <- [1,2,null,{}]
04:54:08 INFO - 1501070048231 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
04:54:08 INFO - 1501070048233 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"da6bae12-c60a-4a14-94f6-de2249bfb585","ELEMENT":"da6bae12-c60a-4a14-94f6-de2249bfb585"}}]
04:54:08 INFO - 1501070048234 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"da6bae12-c60a-4a14-94f6-de2249bfb585"}]
04:54:08 INFO - 1501070048269 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/clicks.html"
04:54:08 INFO - 1501070048274 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/clicks.html"
04:54:08 INFO - 1501070048274 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/clicks.html"
04:54:08 INFO - 1501070048291 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/test.html"
04:54:08 INFO - 1501070048296 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/test.html"
04:54:08 INFO - 1501070048299 Marionette TRACE 359 <- [1,4,null,{}]
04:54:08 INFO - 1501070048301 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
04:54:08 INFO - 1501070048302 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"df1b6644-fac1-4c48-b043-d2839fe7d144","ELEMENT":"df1b6644-fac1-4c48-b043-d2839fe7d144"}}]
04:54:08 INFO - 1501070048304 Marionette TRACE 359 -> [0,6,"getTitle",{}]
04:54:08 INFO - 1501070048304 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
04:54:08 INFO - 1501070048306 Marionette TRACE 359 -> [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}]
04:54:08 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1501070048308 Marionette TRACE 359 <- [1,7,null,{"value":null}]
04:54:08 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 168ms
04:54:08 INFO - TEST-START | test_click.py TestClick.test_container_element
04:54:08 INFO - 1501070048314 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
04:54:08 INFO - 1501070048316 Marionette TRACE 359 <- [1,8,null,{}]
04:54:08 INFO - 1501070048318 Marionette DEBUG Closed connection 359
04:54:08 INFO - 1501070048319 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49758
04:54:08 INFO - 1501070048319 Marionette DEBUG Closed connection 360
04:54:08 INFO - 1501070048320 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49759
04:54:08 INFO - 1501070048321 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048321 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048323 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048326 Marionette TRACE 361 <- [1,1,null,{"sessionId":"4e9e45fb-a2dc-45ab-a6fc-f51532499a0d","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048328 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
04:54:08 INFO - 1501070048329 Marionette TRACE 361 <- [1,2,null,{}]
04:54:08 INFO - 1501070048330 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:08 INFO - 1501070048330 Marionette TRACE 361 <- [1,3,null,{}]
04:54:08 INFO - 1501070048331 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:08 INFO - 1501070048331 Marionette TRACE 361 <- [1,4,null,{}]
04:54:08 INFO - 1501070048333 Marionette TRACE 361 -> [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}]
04:54:08 INFO - TEST-START: test_click.py TestClick.test_container_element1501070048335 Marionette TRACE 361 <- [1,5,null,{"value":null}]
04:54:08 INFO - 1501070048336 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
04:54:08 INFO - 1501070048337 Marionette TRACE 361 <- [1,6,null,{}]
04:54:08 INFO - 1501070048339 Marionette DEBUG Closed connection 361
04:54:08 INFO - 1501070048339 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49760
04:54:08 INFO - 1501070048340 Marionette DEBUG Closed connection 362
04:54:08 INFO - 1501070048340 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49761
04:54:08 INFO - 1501070048341 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048342 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048344 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048348 Marionette TRACE 363 <- [1,1,null,{"sessionId":"119d445d-0aca-4aaf-b8e8-3ebede0b5f56","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048350 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
04:54:08 INFO - 1501070048351 Marionette TRACE 363 <- [1,2,null,{}]
04:54:08 INFO - 1501070048353 Marionette DEBUG Closed connection 363
04:54:08 INFO - 1501070048354 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49762
04:54:08 INFO - 1501070048354 Marionette DEBUG Closed connection 364
04:54:08 INFO - 1501070048355 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49763
04:54:08 INFO - 1501070048356 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:08 INFO - 1501070048356 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048358 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048361 Marionette TRACE 365 <- [1,1,null,{"sessionId":"1413aaa3-308b-4ff0-815a-490ea09bc66c","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048363 Marionette TRACE 365 -> [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"}]
04:54:08 INFO - 1501070048364 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/test.html"
04:54:08 INFO - 1501070048366 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/test.html"
04:54:08 INFO - 1501070048366 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/test.html"
04:54:08 INFO - 1501070048386 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"
04:54:08 INFO - 1501070048388 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"
04:54:08 INFO - 1501070048391 Marionette TRACE 365 <- [1,2,null,{}]
04:54:08 INFO - 1501070048397 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:54:08 INFO - 1501070048399 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9c1d0161-e5f1-4e55-af11-03867e3b48d0","ELEMENT":"9c1d0161-e5f1-4e55-af11-03867e3b48d0"}}]
04:54:08 INFO - 1501070048400 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"9c1d0161-e5f1-4e55-af11-03867e3b48d0"}]
04:54:08 INFO - 1501070048643 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:54:08 INFO - 1501070048643 Marionette TRACE 365 <- [1,4,null,{}]
04:54:08 INFO - 1501070048645 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"9c1d0161-e5f1-4e55-af11-03867e3b48d0","name":"selected"}]
04:54:08 INFO - 1501070048648 Marionette TRACE 365 <- [1,5,null,{"value":true}]
04:54:08 INFO - 1501070048650 Marionette TRACE 365 -> [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}]
04:54:08 INFO - TEST-END: test_click.py TestClick.test_container_element1501070048652 Marionette TRACE 365 <- [1,6,null,{"value":null}]
04:54:08 INFO - 1501070048653 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
04:54:08 INFO - 1501070048654 Marionette TRACE 365 <- [1,7,null,{}]
04:54:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 340ms
04:54:08 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
04:54:08 INFO - 1501070048656 Marionette DEBUG Closed connection 365
04:54:08 INFO - 1501070048657 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49764
04:54:08 INFO - 1501070048658 Marionette DEBUG Closed connection 366
04:54:08 INFO - 1501070048658 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49765
04:54:08 INFO - 1501070048659 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048660 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048661 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048664 Marionette TRACE 367 <- [1,1,null,{"sessionId":"9512e502-ae3b-4e9f-b71b-97ad9bfa891c","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048666 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
04:54:08 INFO - 1501070048666 Marionette TRACE 367 <- [1,2,null,{}]
04:54:08 INFO - 1501070048667 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:08 INFO - 1501070048667 Marionette TRACE 367 <- [1,3,null,{}]
04:54:08 INFO - 1501070048668 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:08 INFO - 1501070048668 Marionette TRACE 367 <- [1,4,null,{}]
04:54:08 INFO - 1501070048670 Marionette TRACE 367 -> [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}]
04:54:08 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1501070048672 Marionette TRACE 367 <- [1,5,null,{"value":null}]
04:54:08 INFO - 1501070048673 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
04:54:08 INFO - 1501070048674 Marionette TRACE 367 <- [1,6,null,{}]
04:54:08 INFO - 1501070048676 Marionette DEBUG Closed connection 367
04:54:08 INFO - 1501070048676 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49766
04:54:08 INFO - 1501070048677 Marionette DEBUG Closed connection 368
04:54:08 INFO - 1501070048677 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49767
04:54:08 INFO - 1501070048678 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048679 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048681 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048683 Marionette TRACE 369 <- [1,1,null,{"sessionId":"ad01f5f2-167e-4a54-bcf7-b2fa13e1863f","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048686 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
04:54:08 INFO - 1501070048687 Marionette TRACE 369 <- [1,2,null,{}]
04:54:08 INFO - 1501070048689 Marionette DEBUG Closed connection 369
04:54:08 INFO - 1501070048689 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49768
04:54:08 INFO - 1501070048690 Marionette DEBUG Closed connection 370
04:54:08 INFO - 1501070048690 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49769
04:54:08 INFO - 1501070048692 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:08 INFO - 1501070048692 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048694 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048697 Marionette TRACE 371 <- [1,1,null,{"sessionId":"6cee8c59-c781-4daf-8570-429fac80219e","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048699 Marionette TRACE 371 -> [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"}]
04:54:08 INFO - 1501070048700 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"
04:54:08 INFO - 1501070048702 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"
04:54:08 INFO - 1501070048702 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"
04:54:08 INFO - 1501070048717 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"
04:54:08 INFO - 1501070048719 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"
04:54:08 INFO - 1501070048722 Marionette TRACE 371 <- [1,2,null,{}]
04:54:08 INFO - 1501070048723 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:54:08 INFO - 1501070048732 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ba64dfb7-7634-4b6d-80be-a64febd42348","ELEMENT":"ba64dfb7-7634-4b6d-80be-a64febd42348"}}]
04:54:08 INFO - 1501070048733 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"ba64dfb7-7634-4b6d-80be-a64febd42348"}]
04:54:08 INFO - 1501070048969 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:54:08 INFO - 1501070048970 Marionette TRACE 371 <- [1,4,null,{}]
04:54:08 INFO - 1501070048971 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"ba64dfb7-7634-4b6d-80be-a64febd42348","name":"selected"}]
04:54:08 INFO - 1501070048975 Marionette TRACE 371 <- [1,5,null,{"value":true}]
04:54:08 INFO - 1501070048976 Marionette TRACE 371 -> [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}]
04:54:08 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1501070048978 Marionette TRACE 371 <- [1,6,null,{"value":null}]
04:54:08 INFO - 1501070048979 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
04:54:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 324ms
04:54:08 INFO - 1501070048980 Marionette TRACE 371 <- [1,7,null,{}]
04:54:08 INFO - TEST-START | test_click.py TestClick.test_css_transforms
04:54:08 INFO - 1501070048982 Marionette DEBUG Closed connection 371
04:54:08 INFO - 1501070048983 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49770
04:54:08 INFO - 1501070048984 Marionette DEBUG Closed connection 372
04:54:08 INFO - 1501070048985 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49771
04:54:08 INFO - 1501070048985 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:08 INFO - 1501070048986 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:08 INFO - 1501070048987 Marionette DEBUG Register listener.js for window 12
04:54:08 INFO - 1501070048990 Marionette TRACE 373 <- [1,1,null,{"sessionId":"a2e56067-2e91-4604-be5e-726d02401c90","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:08 INFO - 1501070048991 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
04:54:08 INFO - 1501070048992 Marionette TRACE 373 <- [1,2,null,{}]
04:54:08 INFO - 1501070048993 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:08 INFO - 1501070048993 Marionette TRACE 373 <- [1,3,null,{}]
04:54:08 INFO - 1501070048994 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:08 INFO - 1501070048994 Marionette TRACE 373 <- [1,4,null,{}]
04:54:08 INFO - 1501070048995 Marionette TRACE 373 -> [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}]
04:54:09 INFO - TEST-START: test_click.py TestClick.test_css_transforms1501070048997 Marionette TRACE 373 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070048998 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070048999 Marionette TRACE 373 <- [1,6,null,{}]
04:54:09 INFO - 1501070049001 Marionette DEBUG Closed connection 373
04:54:09 INFO - 1501070049001 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49772
04:54:09 INFO - 1501070049002 Marionette DEBUG Closed connection 374
04:54:09 INFO - 1501070049002 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49773
04:54:09 INFO - 1501070049003 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049004 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049005 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049015 Marionette TRACE 375 <- [1,1,null,{"sessionId":"2c21b301-e9f1-4996-9c34-fc7b21aecf84","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049017 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
04:54:09 INFO - 1501070049018 Marionette TRACE 375 <- [1,2,null,{}]
04:54:09 INFO - 1501070049020 Marionette DEBUG Closed connection 375
04:54:09 INFO - 1501070049020 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49774
04:54:09 INFO - 1501070049021 Marionette DEBUG Closed connection 376
04:54:09 INFO - 1501070049021 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49775
04:54:09 INFO - 1501070049022 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:09 INFO - 1501070049023 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049025 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049027 Marionette TRACE 377 <- [1,1,null,{"sessionId":"df64ff36-768e-42bf-a348-f6e701675b17","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049029 Marionette TRACE 377 -> [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"}]
04:54:09 INFO - 1501070049030 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"
04:54:09 INFO - 1501070049031 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"
04:54:09 INFO - 1501070049032 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"
04:54:09 INFO - 1501070049048 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"
04:54:09 INFO - 1501070049049 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"
04:54:09 INFO - 1501070049052 Marionette TRACE 377 <- [1,2,null,{}]
04:54:09 INFO - 1501070049053 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
04:54:09 INFO - 1501070049055 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"02a80b78-cc81-4fad-8f92-2df5a69d6e54","ELEMENT":"02a80b78-cc81-4fad-8f92-2df5a69d6e54"}}]
04:54:09 INFO - 1501070049055 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"02a80b78-cc81-4fad-8f92-2df5a69d6e54"}]
04:54:09 INFO - 1501070049295 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:54:09 INFO - 1501070049295 Marionette TRACE 377 <- [1,4,null,{}]
04:54:09 INFO - 1501070049297 Marionette TRACE 377 -> [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}]
04:54:09 INFO - TEST-END: test_click.py TestClick.test_css_transforms1501070049299 Marionette TRACE 377 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049300 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
04:54:09 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 320ms
04:54:09 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
04:54:09 INFO - 1501070049301 Marionette TRACE 377 <- [1,6,null,{}]
04:54:09 INFO - 1501070049303 Marionette DEBUG Closed connection 377
04:54:09 INFO - 1501070049304 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49776
04:54:09 INFO - 1501070049304 Marionette DEBUG Closed connection 378
04:54:09 INFO - 1501070049305 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49777
04:54:09 INFO - 1501070049306 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049306 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049308 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049311 Marionette TRACE 379 <- [1,1,null,{"sessionId":"8172e5da-49a6-4689-aa24-accf95b3534e","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049312 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
04:54:09 INFO - 1501070049313 Marionette TRACE 379 <- [1,2,null,{}]
04:54:09 INFO - 1501070049314 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:09 INFO - 1501070049314 Marionette TRACE 379 <- [1,3,null,{}]
04:54:09 INFO - 1501070049315 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:09 INFO - 1501070049315 Marionette TRACE 379 <- [1,4,null,{}]
04:54:09 INFO - 1501070049317 Marionette TRACE 379 -> [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}]
04:54:09 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1501070049320 Marionette TRACE 379 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049321 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070049323 Marionette TRACE 379 <- [1,6,null,{}]
04:54:09 INFO - 1501070049324 Marionette DEBUG Closed connection 379
04:54:09 INFO - 1501070049325 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49778
04:54:09 INFO - 1501070049326 Marionette DEBUG Closed connection 380
04:54:09 INFO - 1501070049326 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49779
04:54:09 INFO - 1501070049327 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049327 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049329 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049332 Marionette TRACE 381 <- [1,1,null,{"sessionId":"3cd8cf1d-12b4-419b-ad65-b9865b774e22","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049334 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
04:54:09 INFO - 1501070049335 Marionette TRACE 381 <- [1,2,null,{}]
04:54:09 INFO - 1501070049337 Marionette DEBUG Closed connection 381
04:54:09 INFO - 1501070049337 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49780
04:54:09 INFO - 1501070049338 Marionette DEBUG Closed connection 382
04:54:09 INFO - 1501070049338 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49781
04:54:09 INFO - 1501070049339 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:09 INFO - 1501070049340 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049341 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049344 Marionette TRACE 383 <- [1,1,null,{"sessionId":"fefbfef4-1f69-49ba-abbe-0041c9b7a11f","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049346 Marionette TRACE 383 -> [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"}]
04:54:09 INFO - 1501070049347 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"
04:54:09 INFO - 1501070049348 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"
04:54:09 INFO - 1501070049349 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"
04:54:09 INFO - 1501070049364 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"
04:54:09 INFO - 1501070049366 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"
04:54:09 INFO - 1501070049369 Marionette TRACE 383 <- [1,2,null,{}]
04:54:09 INFO - 1501070049370 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
04:54:09 INFO - 1501070049372 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9c3fbdb0-2f83-4fab-b547-fa05418ab530","ELEMENT":"9c3fbdb0-2f83-4fab-b547-fa05418ab530"}}]
04:54:09 INFO - 1501070049378 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"9c3fbdb0-2f83-4fab-b547-fa05418ab530"}]
04:54:09 INFO - 1501070049621 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:54:09 INFO - 1501070049622 Marionette TRACE 383 <- [1,4,null,{}]
04:54:09 INFO - 1501070049624 Marionette TRACE 383 -> [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}]
04:54:09 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1501070049626 Marionette TRACE 383 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049627 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070049628 Marionette TRACE 383 <- [1,6,null,{}]
04:54:09 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 327ms
04:54:09 INFO - TEST-START | test_click.py TestClick.test_input_file
04:54:09 INFO - 1501070049630 Marionette DEBUG Closed connection 383
04:54:09 INFO - 1501070049630 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49782
04:54:09 INFO - 1501070049631 Marionette DEBUG Closed connection 384
04:54:09 INFO - 1501070049632 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49783
04:54:09 INFO - 1501070049633 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049633 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049635 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049637 Marionette TRACE 385 <- [1,1,null,{"sessionId":"85378cbd-23f3-4e05-baba-aa8b04b9e56f","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049639 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
04:54:09 INFO - 1501070049639 Marionette TRACE 385 <- [1,2,null,{}]
04:54:09 INFO - 1501070049640 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:09 INFO - 1501070049640 Marionette TRACE 385 <- [1,3,null,{}]
04:54:09 INFO - 1501070049641 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:09 INFO - 1501070049641 Marionette TRACE 385 <- [1,4,null,{}]
04:54:09 INFO - 1501070049643 Marionette TRACE 385 -> [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}]
04:54:09 INFO - TEST-START: test_click.py TestClick.test_input_file1501070049645 Marionette TRACE 385 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049646 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070049647 Marionette TRACE 385 <- [1,6,null,{}]
04:54:09 INFO - 1501070049648 Marionette DEBUG Closed connection 385
04:54:09 INFO - 1501070049649 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49784
04:54:09 INFO - 1501070049649 Marionette DEBUG Closed connection 386
04:54:09 INFO - 1501070049650 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49785
04:54:09 INFO - 1501070049651 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049651 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049653 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049655 Marionette TRACE 387 <- [1,1,null,{"sessionId":"b3353c91-b7ec-4755-801d-4ad1045fac73","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049657 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
04:54:09 INFO - 1501070049658 Marionette TRACE 387 <- [1,2,null,{}]
04:54:09 INFO - 1501070049660 Marionette DEBUG Closed connection 387
04:54:09 INFO - 1501070049660 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49786
04:54:09 INFO - 1501070049661 Marionette DEBUG Closed connection 388
04:54:09 INFO - 1501070049661 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49787
04:54:09 INFO - 1501070049662 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:09 INFO - 1501070049663 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049664 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049666 Marionette TRACE 389 <- [1,1,null,{"sessionId":"e38b123e-3655-4eef-9260-d37101def590","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049668 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
04:54:09 INFO - 1501070049669 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"
04:54:09 INFO - 1501070049671 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"
04:54:09 INFO - 1501070049671 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"
04:54:09 INFO - 1501070049686 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:54:09 INFO - 1501070049688 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:54:09 INFO - 1501070049691 Marionette TRACE 389 <- [1,2,null,{}]
04:54:09 INFO - 1501070049697 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
04:54:09 INFO - 1501070049699 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1b72f16d-5b70-4c8f-a577-2a1cc9157eee","ELEMENT":"1b72f16d-5b70-4c8f-a577-2a1cc9157eee"}}]
04:54:09 INFO - 1501070049700 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"1b72f16d-5b70-4c8f-a577-2a1cc9157eee"}]
04:54:09 INFO - 1501070049724 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
04:54:09 INFO - 1501070049726 Marionette TRACE 389 -> [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}]
04:54:09 INFO - TEST-END: test_click.py TestClick.test_input_file1501070049728 Marionette TRACE 389 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049729 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070049730 Marionette TRACE 389 <- [1,6,null,{}]
04:54:09 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 102ms
04:54:09 INFO - TEST-START | test_click.py TestClick.test_obscured_element
04:54:09 INFO - 1501070049732 Marionette DEBUG Closed connection 389
04:54:09 INFO - 1501070049733 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49788
04:54:09 INFO - 1501070049734 Marionette DEBUG Closed connection 390
04:54:09 INFO - 1501070049734 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49789
04:54:09 INFO - 1501070049735 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049736 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049738 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049740 Marionette TRACE 391 <- [1,1,null,{"sessionId":"2e93b3e0-5346-40e8-b576-315e1107c519","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049742 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
04:54:09 INFO - 1501070049742 Marionette TRACE 391 <- [1,2,null,{}]
04:54:09 INFO - 1501070049743 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:09 INFO - 1501070049744 Marionette TRACE 391 <- [1,3,null,{}]
04:54:09 INFO - 1501070049745 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:09 INFO - 1501070049745 Marionette TRACE 391 <- [1,4,null,{}]
04:54:09 INFO - 1501070049746 Marionette TRACE 391 -> [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}]
04:54:09 INFO - TEST-START: test_click.py TestClick.test_obscured_element1501070049749 Marionette TRACE 391 <- [1,5,null,{"value":null}]
04:54:09 INFO - 1501070049750 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
04:54:09 INFO - 1501070049751 Marionette TRACE 391 <- [1,6,null,{}]
04:54:09 INFO - 1501070049753 Marionette DEBUG Closed connection 391
04:54:09 INFO - 1501070049753 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49790
04:54:09 INFO - 1501070049754 Marionette DEBUG Closed connection 392
04:54:09 INFO - 1501070049754 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49791
04:54:09 INFO - 1501070049755 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:09 INFO - 1501070049756 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049757 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049760 Marionette TRACE 393 <- [1,1,null,{"sessionId":"ad102d61-6e66-441a-8417-ac5389ed2d7a","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049762 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
04:54:09 INFO - 1501070049763 Marionette TRACE 393 <- [1,2,null,{}]
04:54:09 INFO - 1501070049764 Marionette DEBUG Closed connection 393
04:54:09 INFO - 1501070049765 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49792
04:54:09 INFO - 1501070049766 Marionette DEBUG Closed connection 394
04:54:09 INFO - 1501070049766 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49793
04:54:09 INFO - 1501070049767 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:09 INFO - 1501070049767 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:09 INFO - 1501070049769 Marionette DEBUG Register listener.js for window 12
04:54:09 INFO - 1501070049778 Marionette TRACE 395 <- [1,1,null,{"sessionId":"d7267245-603f-43eb-b7ca-71b14c7d750f","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:09 INFO - 1501070049780 Marionette TRACE 395 -> [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"}]
04:54:09 INFO - 1501070049781 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:54:09 INFO - 1501070049782 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:54:09 INFO - 1501070049783 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:54:09 INFO - 1501070049799 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"
04:54:09 INFO - 1501070049800 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"
04:54:09 INFO - 1501070049803 Marionette TRACE 395 <- [1,2,null,{}]
04:54:09 INFO - 1501070049804 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
04:54:09 INFO - 1501070049811 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b35b9675-2f86-4950-a889-666fcfa287ff","ELEMENT":"b35b9675-2f86-4950-a889-666fcfa287ff"}}]
04:54:09 INFO - 1501070049813 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
04:54:09 INFO - 1501070049815 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0cba3e91-de42-4b94-baf8-86d3682810ed","ELEMENT":"0cba3e91-de42-4b94-baf8-86d3682810ed"}}]
04:54:09 INFO - 1501070049820 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"b35b9675-2f86-4950-a889-666fcfa287ff"}]
04:54:10 INFO - 1501070050053 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:54:10 INFO - 1501070050054 Marionette TRACE 395 <- [1,5,null,{}]
04:54:10 INFO - 1501070050055 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"0cba3e91-de42-4b94-baf8-86d3682810ed"}]
04:54:10 INFO - 1501070050068 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
04:54:10 INFO - 1501070050070 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
04:54:10 INFO - 1501070050073 Marionette TRACE 395 <- [1,7,null,{"value":false}]
04:54:10 INFO - 1501070050074 Marionette TRACE 395 -> [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}]
04:54:10 INFO - TEST-END: test_click.py TestClick.test_obscured_element1501070050076 Marionette TRACE 395 <- [1,8,null,{"value":null}]
04:54:10 INFO - 1501070050077 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
04:54:10 INFO - 1501070050078 Marionette TRACE 395 <- [1,9,null,{}]
04:54:10 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 347ms
04:54:10 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
04:54:10 INFO - 1501070050080 Marionette DEBUG Closed connection 395
04:54:10 INFO - 1501070050081 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49794
04:54:10 INFO - 1501070050082 Marionette DEBUG Closed connection 396
04:54:10 INFO - 1501070050082 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49795
04:54:10 INFO - 1501070050083 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:10 INFO - 1501070050084 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:10 INFO - 1501070050085 Marionette DEBUG Register listener.js for window 12
04:54:10 INFO - 1501070050088 Marionette TRACE 397 <- [1,1,null,{"sessionId":"464af2ed-089c-4a10-8687-5cabe85ae6e1","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:10 INFO - 1501070050090 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
04:54:10 INFO - 1501070050090 Marionette TRACE 397 <- [1,2,null,{}]
04:54:10 INFO - 1501070050091 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:54:10 INFO - 1501070050091 Marionette TRACE 397 <- [1,3,null,{}]
04:54:10 INFO - 1501070050092 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
04:54:10 INFO - 1501070050092 Marionette TRACE 397 <- [1,4,null,{}]
04:54:10 INFO - 1501070050094 Marionette TRACE 397 -> [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}]
04:54:10 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1501070050096 Marionette TRACE 397 <- [1,5,null,{"value":null}]
04:54:10 INFO - 1501070050097 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
04:54:10 INFO - 1501070050098 Marionette TRACE 397 <- [1,6,null,{}]
04:54:10 INFO - 1501070050099 Marionette DEBUG Closed connection 397
04:54:10 INFO - 1501070050100 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49796
04:54:10 INFO - 1501070050101 Marionette DEBUG Closed connection 398
04:54:10 INFO - 1501070050101 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49797
04:54:10 INFO - 1501070050102 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:54:10 INFO - 1501070050103 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:10 INFO - 1501070050104 Marionette DEBUG Register listener.js for window 12
04:54:10 INFO - 1501070050106 Marionette TRACE 399 <- [1,1,null,{"sessionId":"335a14f7-29b0-453d-9e53-47304ee830fb","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:10 INFO - 1501070050108 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
04:54:10 INFO - 1501070050109 Marionette TRACE 399 <- [1,2,null,{}]
04:54:10 INFO - 1501070050111 Marionette DEBUG Closed connection 399
04:54:10 INFO - 1501070050111 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49798
04:54:10 INFO - 1501070050112 Marionette DEBUG Closed connection 400
04:54:10 INFO - 1501070050112 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49799
04:54:10 INFO - 1501070050113 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:54:10 INFO - 1501070050114 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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}
04:54:10 INFO - 1501070050116 Marionette DEBUG Register listener.js for window 12
04:54:10 INFO - 1501070050118 Marionette TRACE 401 <- [1,1,null,{"sessionId":"45209af7-7bf7-40a5-92f1-a4841e39bd56","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":764,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpdfxzlc.mozrunner","moz:accessibilityChecks":false}}]
04:54:10 INFO - 1501070050120 Marionette TRACE 401 -> [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"}]
04:54:10 INFO - 1501070050121 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"
04:54:10 INFO - 1501070050123 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"
04:54:10 INFO - 1501070050123 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"
04:54:10 INFO - 1501070050134 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"
04:54:10 INFO - 1501070050138 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"
04:54:10 INFO - 1501070050146 Marionette TRACE 401 <- [1,2,null,{}]
04:54:10 INFO - 1501070050148 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
04:54:10 INFO - 1501070050150 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6cba05ef-4a57-4491-b303-2d891b1092f0","ELEMENT":"6cba05ef-4a57-4491-b303-2d891b1092f0"}}]
04:54:10 INFO - 1501070050151 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"6cba05ef-4a57-4491-b303-2d891b1092f0"}]
04:54:10 INFO - 1501070050178 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
04:54:10 INFO - 1501070050179 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"6cba05ef-4a57-4491-b303-2d891b1092f0"}]
04:54:10 INFO - 1501070050195 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element