could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:54:14 INFO - 1499856854144 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}]
03:54:14 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499856854147 Marionette TRACE 352 <- [1,5,null,{"value":null}]
03:54:14 INFO - 1499856854148 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
03:54:14 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 152ms
03:54:14 INFO - 1499856854149 Marionette TRACE 352 <- [1,6,null,{}]
03:54:14 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
03:54:14 INFO - 1499856854152 Marionette DEBUG Closed connection 352
03:54:14 INFO - 1499856854152 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49757
03:54:14 INFO - 1499856854153 Marionette DEBUG Closed connection 353
03:54:14 INFO - 1499856854154 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49758
03:54:14 INFO - 1499856854155 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854156 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854158 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854161 Marionette TRACE 354 <- [1,1,null,{"sessionId":"c3a23ada-a00a-4971-a2c9-3661e0fe955e","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854164 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
03:54:14 INFO - 1499856854165 Marionette TRACE 354 <- [1,2,null,{}]
03:54:14 INFO - 1499856854166 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:14 INFO - 1499856854166 Marionette TRACE 354 <- [1,3,null,{}]
03:54:14 INFO - 1499856854167 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:14 INFO - 1499856854168 Marionette TRACE 354 <- [1,4,null,{}]
03:54:14 INFO - 1499856854169 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}]
03:54:14 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499856854172 Marionette TRACE 354 <- [1,5,null,{"value":null}]
03:54:14 INFO - 1499856854173 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
03:54:14 INFO - 1499856854174 Marionette TRACE 354 <- [1,6,null,{}]
03:54:14 INFO - 1499856854176 Marionette DEBUG Closed connection 354
03:54:14 INFO - 1499856854177 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49759
03:54:14 INFO - 1499856854178 Marionette DEBUG Closed connection 355
03:54:14 INFO - 1499856854178 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49760
03:54:14 INFO - 1499856854179 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854180 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854183 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854186 Marionette TRACE 356 <- [1,1,null,{"sessionId":"5469b10f-48fa-447e-bbeb-093bc3f647f4","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854188 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
03:54:14 INFO - 1499856854190 Marionette TRACE 356 <- [1,2,null,{}]
03:54:14 INFO - 1499856854192 Marionette DEBUG Closed connection 356
03:54:14 INFO - 1499856854192 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49761
03:54:14 INFO - 1499856854193 Marionette DEBUG Closed connection 357
03:54:14 INFO - 1499856854193 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49762
03:54:14 INFO - 1499856854195 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:14 INFO - 1499856854195 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854198 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854202 Marionette TRACE 358 <- [1,1,null,{"sessionId":"b55eed7e-d7d9-444e-84aa-72d515f7e32f","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854204 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49324/clicks.html"}]
03:54:14 INFO - 1499856854206 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/hidden.html"
03:54:14 INFO - 1499856854211 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/hidden.html"
03:54:14 INFO - 1499856854212 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/hidden.html"
03:54:14 INFO - 1499856854238 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/clicks.html"
03:54:14 INFO - 1499856854240 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/clicks.html"
03:54:14 INFO - 1499856854243 Marionette TRACE 358 <- [1,2,null,{}]
03:54:14 INFO - 1499856854245 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
03:54:14 INFO - 1499856854254 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2d31ff01-deeb-432c-8c14-2446b6e2f153","ELEMENT":"2d31ff01-deeb-432c-8c14-2446b6e2f153"}}]
03:54:14 INFO - 1499856854255 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"2d31ff01-deeb-432c-8c14-2446b6e2f153"}]
03:54:14 INFO - 1499856854305 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/clicks.html"
03:54:14 INFO - 1499856854310 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/clicks.html"
03:54:14 INFO - 1499856854311 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/clicks.html"
03:54:14 INFO - 1499856854335 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49324/test.html"
03:54:14 INFO - 1499856854336 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49324/test.html"
03:54:14 INFO - 1499856854339 Marionette TRACE 358 <- [1,4,null,{}]
03:54:14 INFO - 1499856854340 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
03:54:14 INFO - 1499856854343 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e7f010e5-878e-4141-a4d7-e7a20401ac9e","ELEMENT":"e7f010e5-878e-4141-a4d7-e7a20401ac9e"}}]
03:54:14 INFO - 1499856854344 Marionette TRACE 358 -> [0,6,"getTitle",{}]
03:54:14 INFO - 1499856854345 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
03:54:14 INFO - 1499856854352 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}]
03:54:14 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499856854354 Marionette TRACE 358 <- [1,7,null,{"value":null}]
03:54:14 INFO - 1499856854355 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
03:54:14 INFO - 1499856854357 Marionette TRACE 358 <- [1,8,null,{}]
03:54:14 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 207ms
03:54:14 INFO - TEST-START | test_click.py TestClick.test_container_element
03:54:14 INFO - 1499856854360 Marionette DEBUG Closed connection 358
03:54:14 INFO - 1499856854360 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49765
03:54:14 INFO - 1499856854361 Marionette DEBUG Closed connection 359
03:54:14 INFO - 1499856854362 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49766
03:54:14 INFO - 1499856854364 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854364 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854367 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854370 Marionette TRACE 360 <- [1,1,null,{"sessionId":"fa9bbb3f-41ad-416d-94c4-c486091b3e08","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854372 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
03:54:14 INFO - 1499856854373 Marionette TRACE 360 <- [1,2,null,{}]
03:54:14 INFO - 1499856854374 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:14 INFO - 1499856854375 Marionette TRACE 360 <- [1,3,null,{}]
03:54:14 INFO - 1499856854375 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:14 INFO - 1499856854376 Marionette TRACE 360 <- [1,4,null,{}]
03:54:14 INFO - 1499856854377 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}]
03:54:14 INFO - TEST-START: test_click.py TestClick.test_container_element1499856854381 Marionette TRACE 360 <- [1,5,null,{"value":null}]
03:54:14 INFO - 1499856854382 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
03:54:14 INFO - 1499856854384 Marionette TRACE 360 <- [1,6,null,{}]
03:54:14 INFO - 1499856854386 Marionette DEBUG Closed connection 360
03:54:14 INFO - 1499856854386 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49767
03:54:14 INFO - 1499856854387 Marionette DEBUG Closed connection 361
03:54:14 INFO - 1499856854388 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49768
03:54:14 INFO - 1499856854389 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854389 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854392 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854396 Marionette TRACE 362 <- [1,1,null,{"sessionId":"937804f6-86c9-4b28-b085-ae0ee0a8523a","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854399 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
03:54:14 INFO - 1499856854400 Marionette TRACE 362 <- [1,2,null,{}]
03:54:14 INFO - 1499856854403 Marionette DEBUG Closed connection 362
03:54:14 INFO - 1499856854403 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49769
03:54:14 INFO - 1499856854404 Marionette DEBUG Closed connection 363
03:54:14 INFO - 1499856854404 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49770
03:54:14 INFO - 1499856854405 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:14 INFO - 1499856854406 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854409 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854412 Marionette TRACE 364 <- [1,1,null,{"sessionId":"d6d4bde8-766e-478e-a8ac-58ba52722b83","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854416 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"}]
03:54:14 INFO - 1499856854418 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49324/test.html"
03:54:14 INFO - 1499856854420 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49324/test.html"
03:54:14 INFO - 1499856854420 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49324/test.html"
03:54:14 INFO - 1499856854444 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"
03:54:14 INFO - 1499856854451 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"
03:54:14 INFO - 1499856854455 Marionette TRACE 364 <- [1,2,null,{}]
03:54:14 INFO - 1499856854456 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:54:14 INFO - 1499856854459 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dc26dff3-7be7-44c7-8321-41e42df003ef","ELEMENT":"dc26dff3-7be7-44c7-8321-41e42df003ef"}}]
03:54:14 INFO - 1499856854460 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"dc26dff3-7be7-44c7-8321-41e42df003ef"}]
03:54:14 INFO - 1499856854712 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:54:14 INFO - 1499856854713 Marionette TRACE 364 <- [1,4,null,{}]
03:54:14 INFO - 1499856854714 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"dc26dff3-7be7-44c7-8321-41e42df003ef","name":"selected"}]
03:54:14 INFO - 1499856854718 Marionette TRACE 364 <- [1,5,null,{"value":true}]
03:54:14 INFO - 1499856854720 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}]
03:54:14 INFO - TEST-END: test_click.py TestClick.test_container_element1499856854723 Marionette TRACE 364 <- [1,6,null,{"value":null}]
03:54:14 INFO - 1499856854724 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
03:54:14 INFO - 1499856854725 Marionette TRACE 364 <- [1,7,null,{}]
03:54:14 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 368ms
03:54:14 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
03:54:14 INFO - 1499856854727 Marionette DEBUG Closed connection 364
03:54:14 INFO - 1499856854728 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49771
03:54:14 INFO - 1499856854729 Marionette DEBUG Closed connection 365
03:54:14 INFO - 1499856854729 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49772
03:54:14 INFO - 1499856854730 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854731 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854734 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854737 Marionette TRACE 366 <- [1,1,null,{"sessionId":"b0f6b66a-f664-4768-8221-0ef5c7f1a143","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854739 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
03:54:14 INFO - 1499856854739 Marionette TRACE 366 <- [1,2,null,{}]
03:54:14 INFO - 1499856854740 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:14 INFO - 1499856854740 Marionette TRACE 366 <- [1,3,null,{}]
03:54:14 INFO - 1499856854741 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:14 INFO - 1499856854743 Marionette TRACE 366 <- [1,4,null,{}]
03:54:14 INFO - 1499856854745 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}]
03:54:14 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499856854747 Marionette TRACE 366 <- [1,5,null,{"value":null}]
03:54:14 INFO - 1499856854748 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
03:54:14 INFO - 1499856854749 Marionette TRACE 366 <- [1,6,null,{}]
03:54:14 INFO - 1499856854752 Marionette DEBUG Closed connection 366
03:54:14 INFO - 1499856854753 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49773
03:54:14 INFO - 1499856854754 Marionette DEBUG Closed connection 367
03:54:14 INFO - 1499856854754 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49774
03:54:14 INFO - 1499856854756 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:14 INFO - 1499856854756 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854759 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854763 Marionette TRACE 368 <- [1,1,null,{"sessionId":"a323a360-7595-4dce-9f28-757f9a5d186e","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854773 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
03:54:14 INFO - 1499856854775 Marionette TRACE 368 <- [1,2,null,{}]
03:54:14 INFO - 1499856854777 Marionette DEBUG Closed connection 368
03:54:14 INFO - 1499856854777 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49775
03:54:14 INFO - 1499856854778 Marionette DEBUG Closed connection 369
03:54:14 INFO - 1499856854779 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49776
03:54:14 INFO - 1499856854780 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:14 INFO - 1499856854781 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:14 INFO - 1499856854784 Marionette DEBUG Register listener.js for window 15
03:54:14 INFO - 1499856854788 Marionette TRACE 370 <- [1,1,null,{"sessionId":"5a1b475c-cae9-471c-8e13-5a83be89b3cb","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:14 INFO - 1499856854790 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"}]
03:54:14 INFO - 1499856854792 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"
03:54:14 INFO - 1499856854794 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"
03:54:14 INFO - 1499856854794 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"
03:54:14 INFO - 1499856854815 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"
03:54:14 INFO - 1499856854817 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"
03:54:14 INFO - 1499856854820 Marionette TRACE 370 <- [1,2,null,{}]
03:54:14 INFO - 1499856854822 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:54:14 INFO - 1499856854824 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7b0cb3b3-213f-4346-acfb-697e7c72ae35","ELEMENT":"7b0cb3b3-213f-4346-acfb-697e7c72ae35"}}]
03:54:14 INFO - 1499856854825 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"7b0cb3b3-213f-4346-acfb-697e7c72ae35"}]
03:54:15 INFO - 1499856855082 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:54:15 INFO - 1499856855083 Marionette TRACE 370 <- [1,4,null,{}]
03:54:15 INFO - 1499856855084 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"7b0cb3b3-213f-4346-acfb-697e7c72ae35","name":"selected"}]
03:54:15 INFO - 1499856855089 Marionette TRACE 370 <- [1,5,null,{"value":true}]
03:54:15 INFO - 1499856855090 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}]
03:54:15 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499856855093 Marionette TRACE 370 <- [1,6,null,{"value":null}]
03:54:15 INFO - 1499856855094 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
03:54:15 INFO - 1499856855095 Marionette TRACE 370 <- [1,7,null,{}]
03:54:15 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 370ms
03:54:15 INFO - TEST-START | test_click.py TestClick.test_css_transforms
03:54:15 INFO - 1499856855097 Marionette DEBUG Closed connection 370
03:54:15 INFO - 1499856855098 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49777
03:54:15 INFO - 1499856855099 Marionette DEBUG Closed connection 371
03:54:15 INFO - 1499856855100 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49778
03:54:15 INFO - 1499856855101 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855101 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855104 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855107 Marionette TRACE 372 <- [1,1,null,{"sessionId":"ac1a2351-5a50-459c-8158-8f7d415e05b6","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855109 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
03:54:15 INFO - 1499856855109 Marionette TRACE 372 <- [1,2,null,{}]
03:54:15 INFO - 1499856855110 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:15 INFO - 1499856855111 Marionette TRACE 372 <- [1,3,null,{}]
03:54:15 INFO - 1499856855111 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:15 INFO - 1499856855112 Marionette TRACE 372 <- [1,4,null,{}]
03:54:15 INFO - 1499856855113 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}]
03:54:15 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499856855116 Marionette TRACE 372 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855117 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855118 Marionette TRACE 372 <- [1,6,null,{}]
03:54:15 INFO - 1499856855120 Marionette DEBUG Closed connection 372
03:54:15 INFO - 1499856855121 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49779
03:54:15 INFO - 1499856855121 Marionette DEBUG Closed connection 373
03:54:15 INFO - 1499856855122 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49780
03:54:15 INFO - 1499856855123 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855123 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855126 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855129 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c9400bef-6c4e-4ff8-b13d-3cfe89394932","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855132 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
03:54:15 INFO - 1499856855133 Marionette TRACE 374 <- [1,2,null,{}]
03:54:15 INFO - 1499856855135 Marionette DEBUG Closed connection 374
03:54:15 INFO - 1499856855136 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49781
03:54:15 INFO - 1499856855137 Marionette DEBUG Closed connection 375
03:54:15 INFO - 1499856855137 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49782
03:54:15 INFO - 1499856855138 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:15 INFO - 1499856855139 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855142 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855145 Marionette TRACE 376 <- [1,1,null,{"sessionId":"8dca2773-0a04-4e77-99a7-16711138a7f5","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855147 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"}]
03:54:15 INFO - 1499856855149 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"
03:54:15 INFO - 1499856855151 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"
03:54:15 INFO - 1499856855151 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"
03:54:15 INFO - 1499856855177 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"
03:54:15 INFO - 1499856855180 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"
03:54:15 INFO - 1499856855189 Marionette TRACE 376 <- [1,2,null,{}]
03:54:15 INFO - 1499856855191 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
03:54:15 INFO - 1499856855194 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5d11f9f1-ae28-440a-96a6-261b025a2918","ELEMENT":"5d11f9f1-ae28-440a-96a6-261b025a2918"}}]
03:54:15 INFO - 1499856855195 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"5d11f9f1-ae28-440a-96a6-261b025a2918"}]
03:54:15 INFO - 1499856855443 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:54:15 INFO - 1499856855444 Marionette TRACE 376 <- [1,4,null,{}]
03:54:15 INFO - 1499856855445 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}]
03:54:15 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499856855448 Marionette TRACE 376 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855449 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855450 Marionette TRACE 376 <- [1,6,null,{}]
03:54:15 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 355ms
03:54:15 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
03:54:15 INFO - 1499856855452 Marionette DEBUG Closed connection 376
03:54:15 INFO - 1499856855453 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49783
03:54:15 INFO - 1499856855454 Marionette DEBUG Closed connection 377
03:54:15 INFO - 1499856855455 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49784
03:54:15 INFO - 1499856855456 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855456 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855459 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855462 Marionette TRACE 378 <- [1,1,null,{"sessionId":"8f34e54d-8bcb-44b3-a9c5-74b4f4467f9b","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855464 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
03:54:15 INFO - 1499856855465 Marionette TRACE 378 <- [1,2,null,{}]
03:54:15 INFO - 1499856855466 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:15 INFO - 1499856855466 Marionette TRACE 378 <- [1,3,null,{}]
03:54:15 INFO - 1499856855467 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:15 INFO - 1499856855467 Marionette TRACE 378 <- [1,4,null,{}]
03:54:15 INFO - 1499856855469 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}]
03:54:15 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499856855472 Marionette TRACE 378 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855473 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855474 Marionette TRACE 378 <- [1,6,null,{}]
03:54:15 INFO - 1499856855476 Marionette DEBUG Closed connection 378
03:54:15 INFO - 1499856855477 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49785
03:54:15 INFO - 1499856855478 Marionette DEBUG Closed connection 379
03:54:15 INFO - 1499856855478 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49786
03:54:15 INFO - 1499856855479 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855480 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855483 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855486 Marionette TRACE 380 <- [1,1,null,{"sessionId":"23181c97-0ba8-4cf2-b50a-fa9870b7e86c","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855488 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
03:54:15 INFO - 1499856855489 Marionette TRACE 380 <- [1,2,null,{}]
03:54:15 INFO - 1499856855491 Marionette DEBUG Closed connection 380
03:54:15 INFO - 1499856855491 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49787
03:54:15 INFO - 1499856855492 Marionette DEBUG Closed connection 381
03:54:15 INFO - 1499856855493 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49788
03:54:15 INFO - 1499856855494 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:15 INFO - 1499856855495 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855497 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855501 Marionette TRACE 382 <- [1,1,null,{"sessionId":"727a6f91-8727-4a6b-847f-bc6eb8c1c0d0","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855504 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"}]
03:54:15 INFO - 1499856855505 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"
03:54:15 INFO - 1499856855507 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"
03:54:15 INFO - 1499856855508 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"
03:54:15 INFO - 1499856855526 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"
03:54:15 INFO - 1499856855529 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"
03:54:15 INFO - 1499856855539 Marionette TRACE 382 <- [1,2,null,{}]
03:54:15 INFO - 1499856855541 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
03:54:15 INFO - 1499856855543 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e62c11df-de4f-436a-8ec9-166e0fcda0c1","ELEMENT":"e62c11df-de4f-436a-8ec9-166e0fcda0c1"}}]
03:54:15 INFO - 1499856855544 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"e62c11df-de4f-436a-8ec9-166e0fcda0c1"}]
03:54:15 INFO - 1499856855790 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:54:15 INFO - 1499856855791 Marionette TRACE 382 <- [1,4,null,{}]
03:54:15 INFO - 1499856855793 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}]
03:54:15 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499856855796 Marionette TRACE 382 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855797 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855798 Marionette TRACE 382 <- [1,6,null,{}]
03:54:15 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 347ms
03:54:15 INFO - TEST-START | test_click.py TestClick.test_input_file
03:54:15 INFO - 1499856855801 Marionette DEBUG Closed connection 382
03:54:15 INFO - 1499856855801 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49789
03:54:15 INFO - 1499856855802 Marionette DEBUG Closed connection 383
03:54:15 INFO - 1499856855803 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49790
03:54:15 INFO - 1499856855804 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855805 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855807 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855810 Marionette TRACE 384 <- [1,1,null,{"sessionId":"c05e588b-a457-47a3-8b5a-56c5bf8a1aab","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855812 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
03:54:15 INFO - 1499856855813 Marionette TRACE 384 <- [1,2,null,{}]
03:54:15 INFO - 1499856855814 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:15 INFO - 1499856855814 Marionette TRACE 384 <- [1,3,null,{}]
03:54:15 INFO - 1499856855815 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:15 INFO - 1499856855815 Marionette TRACE 384 <- [1,4,null,{}]
03:54:15 INFO - 1499856855817 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}]
03:54:15 INFO - TEST-START: test_click.py TestClick.test_input_file1499856855819 Marionette TRACE 384 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855820 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855821 Marionette TRACE 384 <- [1,6,null,{}]
03:54:15 INFO - 1499856855824 Marionette DEBUG Closed connection 384
03:54:15 INFO - 1499856855824 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49791
03:54:15 INFO - 1499856855825 Marionette DEBUG Closed connection 385
03:54:15 INFO - 1499856855826 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49792
03:54:15 INFO - 1499856855827 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855828 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855830 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855834 Marionette TRACE 386 <- [1,1,null,{"sessionId":"aba02b4b-40d4-447c-b93b-a73679bab588","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855836 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
03:54:15 INFO - 1499856855837 Marionette TRACE 386 <- [1,2,null,{}]
03:54:15 INFO - 1499856855839 Marionette DEBUG Closed connection 386
03:54:15 INFO - 1499856855840 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49793
03:54:15 INFO - 1499856855841 Marionette DEBUG Closed connection 387
03:54:15 INFO - 1499856855841 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49794
03:54:15 INFO - 1499856855842 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:15 INFO - 1499856855843 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855846 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855849 Marionette TRACE 388 <- [1,1,null,{"sessionId":"4430c251-e48a-4565-b7bb-26109150da6f","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855858 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
03:54:15 INFO - 1499856855860 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"
03:54:15 INFO - 1499856855862 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"
03:54:15 INFO - 1499856855862 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"
03:54:15 INFO - 1499856855873 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:54:15 INFO - 1499856855877 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:54:15 INFO - 1499856855886 Marionette TRACE 388 <- [1,2,null,{}]
03:54:15 INFO - 1499856855888 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
03:54:15 INFO - 1499856855890 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0073417-1b6e-4228-b401-12bdcd92f3da","ELEMENT":"e0073417-1b6e-4228-b401-12bdcd92f3da"}}]
03:54:15 INFO - 1499856855891 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"e0073417-1b6e-4228-b401-12bdcd92f3da"}]
03:54:15 INFO - 1499856855919 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:54:15 INFO - 1499856855921 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}]
03:54:15 INFO - TEST-END: test_click.py TestClick.test_input_file1499856855923 Marionette TRACE 388 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855924 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855925 Marionette TRACE 388 <- [1,6,null,{}]
03:54:15 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 126ms
03:54:15 INFO - TEST-START | test_click.py TestClick.test_obscured_element
03:54:15 INFO - 1499856855928 Marionette DEBUG Closed connection 388
03:54:15 INFO - 1499856855928 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49795
03:54:15 INFO - 1499856855930 Marionette DEBUG Closed connection 389
03:54:15 INFO - 1499856855930 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49796
03:54:15 INFO - 1499856855931 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855932 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855935 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855938 Marionette TRACE 390 <- [1,1,null,{"sessionId":"14e084c8-89cd-4a38-af48-cb39cd23a0d5","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855940 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
03:54:15 INFO - 1499856855940 Marionette TRACE 390 <- [1,2,null,{}]
03:54:15 INFO - 1499856855941 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:15 INFO - 1499856855941 Marionette TRACE 390 <- [1,3,null,{}]
03:54:15 INFO - 1499856855942 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:15 INFO - 1499856855943 Marionette TRACE 390 <- [1,4,null,{}]
03:54:15 INFO - 1499856855945 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}]
03:54:15 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499856855947 Marionette TRACE 390 <- [1,5,null,{"value":null}]
03:54:15 INFO - 1499856855948 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
03:54:15 INFO - 1499856855950 Marionette TRACE 390 <- [1,6,null,{}]
03:54:15 INFO - 1499856855952 Marionette DEBUG Closed connection 390
03:54:15 INFO - 1499856855953 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49797
03:54:15 INFO - 1499856855953 Marionette DEBUG Closed connection 391
03:54:15 INFO - 1499856855954 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49798
03:54:15 INFO - 1499856855955 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:15 INFO - 1499856855956 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855958 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855961 Marionette TRACE 392 <- [1,1,null,{"sessionId":"51c66c4a-ddf9-461b-83a8-db1227c49479","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855963 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
03:54:15 INFO - 1499856855965 Marionette TRACE 392 <- [1,2,null,{}]
03:54:15 INFO - 1499856855967 Marionette DEBUG Closed connection 392
03:54:15 INFO - 1499856855968 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49799
03:54:15 INFO - 1499856855968 Marionette DEBUG Closed connection 393
03:54:15 INFO - 1499856855969 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49800
03:54:15 INFO - 1499856855970 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:15 INFO - 1499856855971 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:15 INFO - 1499856855973 Marionette DEBUG Register listener.js for window 15
03:54:15 INFO - 1499856855977 Marionette TRACE 394 <- [1,1,null,{"sessionId":"e9d583e6-a64c-4e82-ad71-db31ee6700a4","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:15 INFO - 1499856855979 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"}]
03:54:15 INFO - 1499856855981 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:54:15 INFO - 1499856855983 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:54:15 INFO - 1499856855984 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:54:16 INFO - 1499856856005 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"
03:54:16 INFO - 1499856856007 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"
03:54:16 INFO - 1499856856010 Marionette TRACE 394 <- [1,2,null,{}]
03:54:16 INFO - 1499856856017 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
03:54:16 INFO - 1499856856019 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e1574f9f-44c4-4920-9cb2-ce416902ba49","ELEMENT":"e1574f9f-44c4-4920-9cb2-ce416902ba49"}}]
03:54:16 INFO - 1499856856020 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
03:54:16 INFO - 1499856856022 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"018c0ef6-938f-4770-ab4e-289be5041c00","ELEMENT":"018c0ef6-938f-4770-ab4e-289be5041c00"}}]
03:54:16 INFO - 1499856856023 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"e1574f9f-44c4-4920-9cb2-ce416902ba49"}]
03:54:16 INFO - 1499856856330 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:54:16 INFO - 1499856856332 Marionette TRACE 394 <- [1,5,null,{}]
03:54:16 INFO - 1499856856334 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"018c0ef6-938f-4770-ab4e-289be5041c00"}]
03:54:16 INFO - 1499856856357 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:54:16 INFO - 1499856856359 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
03:54:16 INFO - 1499856856365 Marionette TRACE 394 <- [1,7,null,{"value":false}]
03:54:16 INFO - 1499856856367 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}]
03:54:16 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499856856372 Marionette TRACE 394 <- [1,8,null,{"value":null}]
03:54:16 INFO - 1499856856373 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
03:54:16 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 450ms
03:54:16 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
03:54:16 INFO - 1499856856376 Marionette TRACE 394 <- [1,9,null,{}]
03:54:16 INFO - 1499856856379 Marionette DEBUG Closed connection 394
03:54:16 INFO - 1499856856381 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49801
03:54:16 INFO - 1499856856383 Marionette DEBUG Closed connection 395
03:54:16 INFO - 1499856856384 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49802
03:54:16 INFO - 1499856856394 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:16 INFO - 1499856856397 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:16 INFO - 1499856856401 Marionette DEBUG Register listener.js for window 15
03:54:16 INFO - 1499856856408 Marionette TRACE 396 <- [1,1,null,{"sessionId":"5c55bc47-7dab-4663-ae5e-8714dbd62405","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:16 INFO - 1499856856412 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
03:54:16 INFO - 1499856856413 Marionette TRACE 396 <- [1,2,null,{}]
03:54:16 INFO - 1499856856414 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:54:16 INFO - 1499856856415 Marionette TRACE 396 <- [1,3,null,{}]
03:54:16 INFO - 1499856856416 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
03:54:16 INFO - 1499856856417 Marionette TRACE 396 <- [1,4,null,{}]
03:54:16 INFO - 1499856856419 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}]
03:54:16 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499856856423 Marionette TRACE 396 <- [1,5,null,{"value":null}]
03:54:16 INFO - 1499856856424 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
03:54:16 INFO - 1499856856427 Marionette TRACE 396 <- [1,6,null,{}]
03:54:16 INFO - 1499856856432 Marionette DEBUG Closed connection 396
03:54:16 INFO - 1499856856433 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49803
03:54:16 INFO - 1499856856434 Marionette DEBUG Closed connection 397
03:54:16 INFO - 1499856856435 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49804
03:54:16 INFO - 1499856856438 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:54:16 INFO - 1499856856439 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:16 INFO - 1499856856443 Marionette DEBUG Register listener.js for window 15
03:54:16 INFO - 1499856856448 Marionette TRACE 398 <- [1,1,null,{"sessionId":"002d28a2-eb26-4fa4-84ff-f32ea9448ce0","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:16 INFO - 1499856856451 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
03:54:16 INFO - 1499856856453 Marionette TRACE 398 <- [1,2,null,{}]
03:54:16 INFO - 1499856856455 Marionette DEBUG Closed connection 398
03:54:16 INFO - 1499856856456 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49805
03:54:16 INFO - 1499856856457 Marionette DEBUG Closed connection 399
03:54:16 INFO - 1499856856458 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49806
03:54:16 INFO - 1499856856459 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:54:16 INFO - 1499856856460 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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}
03:54:16 INFO - 1499856856463 Marionette DEBUG Register listener.js for window 15
03:54:16 INFO - 1499856856467 Marionette TRACE 400 <- [1,1,null,{"sessionId":"ff49e735-4524-4e2a-88b6-496cc01126a1","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":1296,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-046.001\\AppData\\Local\\Temp\\tmp8cnczv.mozrunner","moz:accessibilityChecks":false}}]
03:54:16 INFO - 1499856856470 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"}]
03:54:16 INFO - 1499856856472 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"
03:54:16 INFO - 1499856856477 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"
03:54:16 INFO - 1499856856477 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"
03:54:16 INFO - 1499856856502 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"
03:54:16 INFO - 1499856856505 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"
03:54:16 INFO - 1499856856510 Marionette TRACE 400 <- [1,2,null,{}]
03:54:16 INFO - 1499856856517 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
03:54:16 INFO - 1499856856532 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e80b0daa-08f6-4e1c-9af8-0fc3c32550aa","ELEMENT":"e80b0daa-08f6-4e1c-9af8-0fc3c32550aa"}}]
03:54:16 INFO - 1499856856533 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"e80b0daa-08f6-4e1c-9af8-0fc3c32550aa"}]
03:54:16 INFO - 1499856856561 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
03:54:16 INFO - 1499856856562 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"e80b0daa-08f6-4e1c-9af8-0fc3c32550aa"}]
03:54:16 INFO - 1499856856584 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element