could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
03:37:16 INFO - 1499078236228 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:37:16 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499078236230 Marionette TRACE 352 <- [1,5,null,{"value":null}]
03:37:16 INFO - 1499078236231 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
03:37:16 INFO - 1499078236232 Marionette TRACE 352 <- [1,6,null,{}]
03:37:16 INFO - 1499078236233 Marionette DEBUG Closed connection 352
03:37:16 INFO - 1499078236234 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49771
03:37:16 INFO - 1499078236235 Marionette DEBUG Closed connection 353
03:37:16 INFO - 1499078236236 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49772
03:37:16 INFO - 1499078236237 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236237 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236239 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236242 Marionette TRACE 354 <- [1,1,null,{"sessionId":"35423458-7ae9-42c3-9b36-09e8fdf9e577","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236243 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
03:37:16 INFO - 1499078236243 Marionette TRACE 354 <- [1,2,null,{}]
03:37:16 INFO - 1499078236244 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:16 INFO - 1499078236244 Marionette TRACE 354 <- [1,3,null,{}]
03:37:16 INFO - 1499078236245 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:16 INFO - 1499078236245 Marionette TRACE 354 <- [1,4,null,{}]
03:37:16 INFO - 1499078236246 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:37:16 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499078236249 Marionette TRACE 354 <- [1,5,null,{"value":null}]
03:37:16 INFO - 1499078236249 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
03:37:16 INFO - 1499078236250 Marionette TRACE 354 <- [1,6,null,{}]
03:37:16 INFO - 1499078236251 Marionette DEBUG Closed connection 354
03:37:16 INFO - 1499078236252 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49773
03:37:16 INFO - 1499078236253 Marionette DEBUG Closed connection 355
03:37:16 INFO - 1499078236253 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49774
03:37:16 INFO - 1499078236254 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236255 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236257 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236259 Marionette TRACE 356 <- [1,1,null,{"sessionId":"fda88821-ee2d-4fe0-94c5-1dca9cdeab31","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236260 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
03:37:16 INFO - 1499078236261 Marionette TRACE 356 <- [1,2,null,{}]
03:37:16 INFO - 1499078236262 Marionette DEBUG Closed connection 356
03:37:16 INFO - 1499078236263 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49775
03:37:16 INFO - 1499078236264 Marionette DEBUG Closed connection 357
03:37:16 INFO - 1499078236264 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49776
03:37:16 INFO - 1499078236265 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:16 INFO - 1499078236266 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236268 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236271 Marionette TRACE 358 <- [1,1,null,{"sessionId":"e772e853-15bc-4f1d-a8d6-bbfa10675c40","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236272 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
03:37:16 INFO - 1499078236274 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
03:37:16 INFO - 1499078236280 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
03:37:16 INFO - 1499078236281 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
03:37:16 INFO - 1499078236286 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
03:37:16 INFO - 1499078236292 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
03:37:16 INFO - 1499078236294 Marionette TRACE 358 <- [1,2,null,{}]
03:37:16 INFO - 1499078236298 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
03:37:16 INFO - 1499078236300 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2e77d5dc-994a-4c31-9ae7-4894fd4727f0","ELEMENT":"2e77d5dc-994a-4c31-9ae7-4894fd4727f0"}}]
03:37:16 INFO - 1499078236300 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"2e77d5dc-994a-4c31-9ae7-4894fd4727f0"}]
03:37:16 INFO - 1499078236337 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
03:37:16 INFO - 1499078236344 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
03:37:16 INFO - 1499078236344 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
03:37:16 INFO - 1499078236351 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
03:37:16 INFO - 1499078236357 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
03:37:16 INFO - 1499078236363 Marionette TRACE 358 <- [1,4,null,{}]
03:37:16 INFO - 1499078236368 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
03:37:16 INFO - 1499078236370 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"63e03ad7-167c-4917-8ed1-5d5aad383afc","ELEMENT":"63e03ad7-167c-4917-8ed1-5d5aad383afc"}}]
03:37:16 INFO - 1499078236371 Marionette TRACE 358 -> [0,6,"getTitle",{}]
03:37:16 INFO - 1499078236375 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
03:37:16 INFO - 1499078236377 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:37:16 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 148ms
03:37:16 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499078236379 Marionette TRACE 358 <- [1,7,null,{"value":null}]
03:37:16 INFO - 1499078236380 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
03:37:16 INFO - 1499078236381 Marionette TRACE 358 <- [1,8,null,{}]
03:37:16 INFO - TEST-START | test_click.py TestClick.test_container_element
03:37:16 INFO - 1499078236382 Marionette DEBUG Closed connection 358
03:37:16 INFO - 1499078236384 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49779
03:37:16 INFO - 1499078236385 Marionette DEBUG Closed connection 359
03:37:16 INFO - 1499078236385 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49780
03:37:16 INFO - 1499078236386 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236387 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236389 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236392 Marionette TRACE 360 <- [1,1,null,{"sessionId":"24405ccf-6b0c-4cb0-8d53-edd0738a1708","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236393 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
03:37:16 INFO - 1499078236394 Marionette TRACE 360 <- [1,2,null,{}]
03:37:16 INFO - 1499078236395 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:16 INFO - 1499078236395 Marionette TRACE 360 <- [1,3,null,{}]
03:37:16 INFO - 1499078236396 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:16 INFO - 1499078236396 Marionette TRACE 360 <- [1,4,null,{}]
03:37:16 INFO - 1499078236398 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:37:16 INFO - TEST-START: test_click.py TestClick.test_container_element1499078236400 Marionette TRACE 360 <- [1,5,null,{"value":null}]
03:37:16 INFO - 1499078236401 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
03:37:16 INFO - 1499078236402 Marionette TRACE 360 <- [1,6,null,{}]
03:37:16 INFO - 1499078236403 Marionette DEBUG Closed connection 360
03:37:16 INFO - 1499078236404 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49781
03:37:16 INFO - 1499078236405 Marionette DEBUG Closed connection 361
03:37:16 INFO - 1499078236405 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49782
03:37:16 INFO - 1499078236406 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236406 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236409 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236419 Marionette TRACE 362 <- [1,1,null,{"sessionId":"c945da31-5f89-414c-bf3d-41f2ad7733c8","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236420 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
03:37:16 INFO - 1499078236421 Marionette TRACE 362 <- [1,2,null,{}]
03:37:16 INFO - 1499078236423 Marionette DEBUG Closed connection 362
03:37:16 INFO - 1499078236423 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49783
03:37:16 INFO - 1499078236424 Marionette DEBUG Closed connection 363
03:37:16 INFO - 1499078236425 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49784
03:37:16 INFO - 1499078236425 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:16 INFO - 1499078236426 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236428 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236431 Marionette TRACE 364 <- [1,1,null,{"sessionId":"9604943a-dc3a-4aaa-b983-718d6d0fbf5e","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236432 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:37:16 INFO - 1499078236434 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
03:37:16 INFO - 1499078236435 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
03:37:16 INFO - 1499078236435 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
03:37:16 INFO - 1499078236444 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:37:16 INFO - 1499078236445 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:37:16 INFO - 1499078236451 Marionette TRACE 364 <- [1,2,null,{}]
03:37:16 INFO - 1499078236455 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:37:16 INFO - 1499078236460 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"10e5d8a4-705b-464f-9864-79e210eed938","ELEMENT":"10e5d8a4-705b-464f-9864-79e210eed938"}}]
03:37:16 INFO - 1499078236461 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"10e5d8a4-705b-464f-9864-79e210eed938"}]
03:37:16 INFO - 1499078236703 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:37:16 INFO - 1499078236704 Marionette TRACE 364 <- [1,4,null,{}]
03:37:16 INFO - 1499078236705 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"10e5d8a4-705b-464f-9864-79e210eed938","name":"selected"}]
03:37:16 INFO - 1499078236709 Marionette TRACE 364 <- [1,5,null,{"value":true}]
03:37:16 INFO - 1499078236711 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:37:16 INFO - TEST-END: test_click.py TestClick.test_container_element1499078236713 Marionette TRACE 364 <- [1,6,null,{"value":null}]
03:37:16 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 333ms
03:37:16 INFO - 1499078236714 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
03:37:16 INFO - 1499078236715 Marionette TRACE 364 <- [1,7,null,{}]
03:37:16 INFO - 1499078236716 Marionette DEBUG Closed connection 364
03:37:16 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
03:37:16 INFO - 1499078236718 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49785
03:37:16 INFO - 1499078236719 Marionette DEBUG Closed connection 365
03:37:16 INFO - 1499078236719 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49786
03:37:16 INFO - 1499078236720 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236721 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236723 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236725 Marionette TRACE 366 <- [1,1,null,{"sessionId":"12c53f1d-0e44-4ad1-9c76-6aee64e491ff","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236727 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
03:37:16 INFO - 1499078236727 Marionette TRACE 366 <- [1,2,null,{}]
03:37:16 INFO - 1499078236728 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:16 INFO - 1499078236729 Marionette TRACE 366 <- [1,3,null,{}]
03:37:16 INFO - 1499078236730 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:16 INFO - 1499078236730 Marionette TRACE 366 <- [1,4,null,{}]
03:37:16 INFO - 1499078236731 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:37:16 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499078236734 Marionette TRACE 366 <- [1,5,null,{"value":null}]
03:37:16 INFO - 1499078236735 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
03:37:16 INFO - 1499078236736 Marionette TRACE 366 <- [1,6,null,{}]
03:37:16 INFO - 1499078236737 Marionette DEBUG Closed connection 366
03:37:16 INFO - 1499078236738 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49787
03:37:16 INFO - 1499078236739 Marionette DEBUG Closed connection 367
03:37:16 INFO - 1499078236739 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49788
03:37:16 INFO - 1499078236740 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:16 INFO - 1499078236741 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236743 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236746 Marionette TRACE 368 <- [1,1,null,{"sessionId":"b6bc87ec-f028-4960-8100-c1b67cd0f76e","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236747 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
03:37:16 INFO - 1499078236748 Marionette TRACE 368 <- [1,2,null,{}]
03:37:16 INFO - 1499078236749 Marionette DEBUG Closed connection 368
03:37:16 INFO - 1499078236750 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49789
03:37:16 INFO - 1499078236750 Marionette DEBUG Closed connection 369
03:37:16 INFO - 1499078236751 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49790
03:37:16 INFO - 1499078236752 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:16 INFO - 1499078236752 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:16 INFO - 1499078236754 Marionette DEBUG Register listener.js for window 4294967297
03:37:16 INFO - 1499078236757 Marionette TRACE 370 <- [1,1,null,{"sessionId":"a0358484-1385-4ef2-b41d-0bf790115763","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:16 INFO - 1499078236758 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:37:16 INFO - 1499078236759 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:37:16 INFO - 1499078236761 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:37:16 INFO - 1499078236761 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:37:16 INFO - 1499078236766 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:37:16 INFO - 1499078236769 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:37:16 INFO - 1499078236770 Marionette TRACE 370 <- [1,2,null,{}]
03:37:16 INFO - 1499078236776 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:37:16 INFO - 1499078236779 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f090e2c9-391e-44ae-a182-f0a704b76083","ELEMENT":"f090e2c9-391e-44ae-a182-f0a704b76083"}}]
03:37:16 INFO - 1499078236780 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"f090e2c9-391e-44ae-a182-f0a704b76083"}]
03:37:17 INFO - 1499078237016 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:37:17 INFO - 1499078237017 Marionette TRACE 370 <- [1,4,null,{}]
03:37:17 INFO - 1499078237018 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"f090e2c9-391e-44ae-a182-f0a704b76083","name":"selected"}]
03:37:17 INFO - 1499078237022 Marionette TRACE 370 <- [1,5,null,{"value":true}]
03:37:17 INFO - 1499078237024 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:37:17 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499078237026 Marionette TRACE 370 <- [1,6,null,{"value":null}]
03:37:17 INFO - 1499078237027 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
03:37:17 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 312ms
03:37:17 INFO - TEST-START | test_click.py TestClick.test_css_transforms
03:37:17 INFO - 1499078237028 Marionette TRACE 370 <- [1,7,null,{}]
03:37:17 INFO - 1499078237029 Marionette DEBUG Closed connection 370
03:37:17 INFO - 1499078237030 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49791
03:37:17 INFO - 1499078237031 Marionette DEBUG Closed connection 371
03:37:17 INFO - 1499078237031 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49792
03:37:17 INFO - 1499078237032 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237033 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237035 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237038 Marionette TRACE 372 <- [1,1,null,{"sessionId":"c0a53f60-2cbb-46e7-a3d0-548a313a0491","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237039 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
03:37:17 INFO - 1499078237039 Marionette TRACE 372 <- [1,2,null,{}]
03:37:17 INFO - 1499078237040 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:17 INFO - 1499078237041 Marionette TRACE 372 <- [1,3,null,{}]
03:37:17 INFO - 1499078237041 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:17 INFO - 1499078237042 Marionette TRACE 372 <- [1,4,null,{}]
03:37:17 INFO - 1499078237043 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:37:17 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499078237045 Marionette TRACE 372 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237046 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237047 Marionette TRACE 372 <- [1,6,null,{}]
03:37:17 INFO - 1499078237049 Marionette DEBUG Closed connection 372
03:37:17 INFO - 1499078237049 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49793
03:37:17 INFO - 1499078237050 Marionette DEBUG Closed connection 373
03:37:17 INFO - 1499078237051 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49794
03:37:17 INFO - 1499078237051 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237052 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237054 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237057 Marionette TRACE 374 <- [1,1,null,{"sessionId":"1aff9626-5f73-46c4-94f2-2189770ffa13","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237058 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
03:37:17 INFO - 1499078237059 Marionette TRACE 374 <- [1,2,null,{}]
03:37:17 INFO - 1499078237060 Marionette DEBUG Closed connection 374
03:37:17 INFO - 1499078237061 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49795
03:37:17 INFO - 1499078237062 Marionette DEBUG Closed connection 375
03:37:17 INFO - 1499078237062 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49796
03:37:17 INFO - 1499078237063 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:17 INFO - 1499078237064 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237066 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237068 Marionette TRACE 376 <- [1,1,null,{"sessionId":"0bbc5db6-ea63-402f-9013-b29a3a82c23d","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237069 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:37:17 INFO - 1499078237071 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:37:17 INFO - 1499078237072 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:37:17 INFO - 1499078237073 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:37:17 INFO - 1499078237078 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:37:17 INFO - 1499078237080 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:37:17 INFO - 1499078237082 Marionette TRACE 376 <- [1,2,null,{}]
03:37:17 INFO - 1499078237085 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
03:37:17 INFO - 1499078237088 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4348bdab-e2e9-4bfb-a840-75b3b8d09825","ELEMENT":"4348bdab-e2e9-4bfb-a840-75b3b8d09825"}}]
03:37:17 INFO - 1499078237094 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"4348bdab-e2e9-4bfb-a840-75b3b8d09825"}]
03:37:17 INFO - 1499078237332 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:37:17 INFO - 1499078237333 Marionette TRACE 376 <- [1,4,null,{}]
03:37:17 INFO - 1499078237335 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:37:17 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499078237337 Marionette TRACE 376 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237338 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
03:37:17 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 311ms
03:37:17 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
03:37:17 INFO - 1499078237339 Marionette TRACE 376 <- [1,6,null,{}]
03:37:17 INFO - 1499078237341 Marionette DEBUG Closed connection 376
03:37:17 INFO - 1499078237341 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49797
03:37:17 INFO - 1499078237342 Marionette DEBUG Closed connection 377
03:37:17 INFO - 1499078237342 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49798
03:37:17 INFO - 1499078237343 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237344 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237346 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237348 Marionette TRACE 378 <- [1,1,null,{"sessionId":"f679f4e3-c391-4934-9da9-2beba6a4b978","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237350 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
03:37:17 INFO - 1499078237350 Marionette TRACE 378 <- [1,2,null,{}]
03:37:17 INFO - 1499078237351 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:17 INFO - 1499078237352 Marionette TRACE 378 <- [1,3,null,{}]
03:37:17 INFO - 1499078237352 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:17 INFO - 1499078237353 Marionette TRACE 378 <- [1,4,null,{}]
03:37:17 INFO - 1499078237355 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:37:17 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499078237357 Marionette TRACE 378 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237358 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237359 Marionette TRACE 378 <- [1,6,null,{}]
03:37:17 INFO - 1499078237360 Marionette DEBUG Closed connection 378
03:37:17 INFO - 1499078237361 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49799
03:37:17 INFO - 1499078237362 Marionette DEBUG Closed connection 379
03:37:17 INFO - 1499078237362 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49800
03:37:17 INFO - 1499078237363 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237364 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237366 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237368 Marionette TRACE 380 <- [1,1,null,{"sessionId":"dd5daec4-f80d-42bd-b5f2-1839c57bf996","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237369 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
03:37:17 INFO - 1499078237370 Marionette TRACE 380 <- [1,2,null,{}]
03:37:17 INFO - 1499078237371 Marionette DEBUG Closed connection 380
03:37:17 INFO - 1499078237372 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49801
03:37:17 INFO - 1499078237372 Marionette DEBUG Closed connection 381
03:37:17 INFO - 1499078237373 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49802
03:37:17 INFO - 1499078237374 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:17 INFO - 1499078237374 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237376 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237379 Marionette TRACE 382 <- [1,1,null,{"sessionId":"41484c5a-4a83-4a7b-8a7d-4a83737cd5a8","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237380 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:37:17 INFO - 1499078237381 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:37:17 INFO - 1499078237383 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:37:17 INFO - 1499078237383 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:37:17 INFO - 1499078237388 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:37:17 INFO - 1499078237392 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:37:17 INFO - 1499078237396 Marionette TRACE 382 <- [1,2,null,{}]
03:37:17 INFO - 1499078237399 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
03:37:17 INFO - 1499078237401 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5db12712-c3c2-4b8c-af19-1dca88cc3766","ELEMENT":"5db12712-c3c2-4b8c-af19-1dca88cc3766"}}]
03:37:17 INFO - 1499078237402 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"5db12712-c3c2-4b8c-af19-1dca88cc3766"}]
03:37:17 INFO - 1499078237641 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:37:17 INFO - 1499078237642 Marionette TRACE 382 <- [1,4,null,{}]
03:37:17 INFO - 1499078237644 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:37:17 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 308ms
03:37:17 INFO - TEST-START | test_click.py TestClick.test_input_file
03:37:17 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499078237646 Marionette TRACE 382 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237647 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237648 Marionette TRACE 382 <- [1,6,null,{}]
03:37:17 INFO - 1499078237649 Marionette DEBUG Closed connection 382
03:37:17 INFO - 1499078237650 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49803
03:37:17 INFO - 1499078237651 Marionette DEBUG Closed connection 383
03:37:17 INFO - 1499078237651 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49804
03:37:17 INFO - 1499078237652 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237653 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237655 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237657 Marionette TRACE 384 <- [1,1,null,{"sessionId":"c94e1edf-49de-4bbe-8dfc-28187621db74","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237658 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
03:37:17 INFO - 1499078237658 Marionette TRACE 384 <- [1,2,null,{}]
03:37:17 INFO - 1499078237659 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:17 INFO - 1499078237659 Marionette TRACE 384 <- [1,3,null,{}]
03:37:17 INFO - 1499078237660 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:17 INFO - 1499078237660 Marionette TRACE 384 <- [1,4,null,{}]
03:37:17 INFO - 1499078237662 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:37:17 INFO - TEST-START: test_click.py TestClick.test_input_file1499078237664 Marionette TRACE 384 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237665 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237666 Marionette TRACE 384 <- [1,6,null,{}]
03:37:17 INFO - 1499078237667 Marionette DEBUG Closed connection 384
03:37:17 INFO - 1499078237668 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49805
03:37:17 INFO - 1499078237668 Marionette DEBUG Closed connection 385
03:37:17 INFO - 1499078237669 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49806
03:37:17 INFO - 1499078237670 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237670 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237673 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237675 Marionette TRACE 386 <- [1,1,null,{"sessionId":"6d9f4261-17d7-4c36-a515-387a99ee429e","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237676 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
03:37:17 INFO - 1499078237677 Marionette TRACE 386 <- [1,2,null,{}]
03:37:17 INFO - 1499078237678 Marionette DEBUG Closed connection 386
03:37:17 INFO - 1499078237679 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49807
03:37:17 INFO - 1499078237679 Marionette DEBUG Closed connection 387
03:37:17 INFO - 1499078237680 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49808
03:37:17 INFO - 1499078237680 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:17 INFO - 1499078237681 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237683 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237686 Marionette TRACE 388 <- [1,1,null,{"sessionId":"893797d8-c7a1-4345-a754-5c677411a8b4","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237687 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
03:37:17 INFO - 1499078237688 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:37:17 INFO - 1499078237690 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:37:17 INFO - 1499078237690 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:37:17 INFO - 1499078237695 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:37:17 INFO - 1499078237699 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:37:17 INFO - 1499078237700 Marionette TRACE 388 <- [1,2,null,{}]
03:37:17 INFO - 1499078237702 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
03:37:17 INFO - 1499078237705 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f317deab-96df-4c7e-9f81-b062195e591c","ELEMENT":"f317deab-96df-4c7e-9f81-b062195e591c"}}]
03:37:17 INFO - 1499078237709 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"f317deab-96df-4c7e-9f81-b062195e591c"}]
03:37:17 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 98ms
03:37:17 INFO - TEST-START | test_click.py TestClick.test_obscured_element
03:37:17 INFO - 1499078237740 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
03:37:17 INFO - 1499078237742 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:37:17 INFO - TEST-END: test_click.py TestClick.test_input_file1499078237744 Marionette TRACE 388 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237745 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237746 Marionette TRACE 388 <- [1,6,null,{}]
03:37:17 INFO - 1499078237748 Marionette DEBUG Closed connection 388
03:37:17 INFO - 1499078237748 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49809
03:37:17 INFO - 1499078237749 Marionette DEBUG Closed connection 389
03:37:17 INFO - 1499078237750 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49810
03:37:17 INFO - 1499078237751 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237751 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237753 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237756 Marionette TRACE 390 <- [1,1,null,{"sessionId":"8c785754-67a9-42ac-a7a1-21261a3fb115","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237757 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
03:37:17 INFO - 1499078237757 Marionette TRACE 390 <- [1,2,null,{}]
03:37:17 INFO - 1499078237758 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:17 INFO - 1499078237758 Marionette TRACE 390 <- [1,3,null,{}]
03:37:17 INFO - 1499078237759 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:17 INFO - 1499078237760 Marionette TRACE 390 <- [1,4,null,{}]
03:37:17 INFO - 1499078237761 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:37:17 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499078237763 Marionette TRACE 390 <- [1,5,null,{"value":null}]
03:37:17 INFO - 1499078237764 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
03:37:17 INFO - 1499078237765 Marionette TRACE 390 <- [1,6,null,{}]
03:37:17 INFO - 1499078237766 Marionette DEBUG Closed connection 390
03:37:17 INFO - 1499078237767 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49811
03:37:17 INFO - 1499078237768 Marionette DEBUG Closed connection 391
03:37:17 INFO - 1499078237768 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49812
03:37:17 INFO - 1499078237769 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:17 INFO - 1499078237769 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237771 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237774 Marionette TRACE 392 <- [1,1,null,{"sessionId":"001ce5da-170d-4862-9e50-2b2abd47c8f4","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237775 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
03:37:17 INFO - 1499078237776 Marionette TRACE 392 <- [1,2,null,{}]
03:37:17 INFO - 1499078237777 Marionette DEBUG Closed connection 392
03:37:17 INFO - 1499078237778 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49813
03:37:17 INFO - 1499078237778 Marionette DEBUG Closed connection 393
03:37:17 INFO - 1499078237779 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49814
03:37:17 INFO - 1499078237780 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:17 INFO - 1499078237780 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:17 INFO - 1499078237782 Marionette DEBUG Register listener.js for window 4294967297
03:37:17 INFO - 1499078237785 Marionette TRACE 394 <- [1,1,null,{"sessionId":"2c68b273-a4cf-4672-830a-f7afed8a7d21","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:17 INFO - 1499078237786 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:37:17 INFO - 1499078237787 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:37:17 INFO - 1499078237789 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:37:17 INFO - 1499078237790 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:37:17 INFO - 1499078237795 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:37:17 INFO - 1499078237797 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:37:17 INFO - 1499078237811 Marionette TRACE 394 <- [1,2,null,{}]
03:37:17 INFO - 1499078237813 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
03:37:17 INFO - 1499078237825 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"147494c6-a61f-4dd1-95a5-ad325ef03c0e","ELEMENT":"147494c6-a61f-4dd1-95a5-ad325ef03c0e"}}]
03:37:17 INFO - 1499078237826 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
03:37:17 INFO - 1499078237828 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8d765f02-fb49-42a1-9520-d6cf71880be4","ELEMENT":"8d765f02-fb49-42a1-9520-d6cf71880be4"}}]
03:37:17 INFO - 1499078237829 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"147494c6-a61f-4dd1-95a5-ad325ef03c0e"}]
03:37:18 INFO - 1499078238075 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:37:18 INFO - 1499078238075 Marionette TRACE 394 <- [1,5,null,{}]
03:37:18 INFO - 1499078238076 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"8d765f02-fb49-42a1-9520-d6cf71880be4"}]
03:37:18 INFO - 1499078238090 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1330:5\n"},null]
03:37:18 INFO - 1499078238092 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
03:37:18 INFO - 1499078238094 Marionette TRACE 394 <- [1,7,null,{"value":false}]
03:37:18 INFO - 1499078238096 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:37:18 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499078238098 Marionette TRACE 394 <- [1,8,null,{"value":null}]
03:37:18 INFO - 1499078238099 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
03:37:18 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 353ms
03:37:18 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
03:37:18 INFO - 1499078238100 Marionette TRACE 394 <- [1,9,null,{}]
03:37:18 INFO - 1499078238101 Marionette DEBUG Closed connection 394
03:37:18 INFO - 1499078238102 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49815
03:37:18 INFO - 1499078238103 Marionette DEBUG Closed connection 395
03:37:18 INFO - 1499078238103 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49816
03:37:18 INFO - 1499078238104 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:18 INFO - 1499078238105 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:18 INFO - 1499078238107 Marionette DEBUG Register listener.js for window 4294967297
03:37:18 INFO - 1499078238109 Marionette TRACE 396 <- [1,1,null,{"sessionId":"ed413c82-7f08-4439-8973-043f7d06eacf","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:18 INFO - 1499078238110 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
03:37:18 INFO - 1499078238111 Marionette TRACE 396 <- [1,2,null,{}]
03:37:18 INFO - 1499078238111 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:37:18 INFO - 1499078238112 Marionette TRACE 396 <- [1,3,null,{}]
03:37:18 INFO - 1499078238113 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
03:37:18 INFO - 1499078238113 Marionette TRACE 396 <- [1,4,null,{}]
03:37:18 INFO - 1499078238114 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:37:18 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499078238117 Marionette TRACE 396 <- [1,5,null,{"value":null}]
03:37:18 INFO - 1499078238117 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
03:37:18 INFO - 1499078238118 Marionette TRACE 396 <- [1,6,null,{}]
03:37:18 INFO - 1499078238120 Marionette DEBUG Closed connection 396
03:37:18 INFO - 1499078238120 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49817
03:37:18 INFO - 1499078238121 Marionette DEBUG Closed connection 397
03:37:18 INFO - 1499078238121 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49818
03:37:18 INFO - 1499078238122 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:37:18 INFO - 1499078238123 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:18 INFO - 1499078238125 Marionette DEBUG Register listener.js for window 4294967297
03:37:18 INFO - 1499078238127 Marionette TRACE 398 <- [1,1,null,{"sessionId":"98c36276-d1dd-4ce4-8a7a-d891cbdc7524","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:18 INFO - 1499078238128 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
03:37:18 INFO - 1499078238129 Marionette TRACE 398 <- [1,2,null,{}]
03:37:18 INFO - 1499078238130 Marionette DEBUG Closed connection 398
03:37:18 INFO - 1499078238131 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49819
03:37:18 INFO - 1499078238132 Marionette DEBUG Closed connection 399
03:37:18 INFO - 1499078238132 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49820
03:37:18 INFO - 1499078238133 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:37:18 INFO - 1499078238134 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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}
03:37:18 INFO - 1499078238136 Marionette DEBUG Register listener.js for window 4294967297
03:37:18 INFO - 1499078238138 Marionette TRACE 400 <- [1,1,null,{"sessionId":"e82c2aaa-cba7-4a6a-91c0-62ef0fe72032","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":2204,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-229.001\\AppData\\Local\\Temp\\tmpuaxnl0.mozrunner","moz:accessibilityChecks":false}}]
03:37:18 INFO - 1499078238139 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:37:18 INFO - 1499078238141 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:37:18 INFO - 1499078238142 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:37:18 INFO - 1499078238142 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:37:18 INFO - 1499078238148 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:37:18 INFO - 1499078238150 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:37:18 INFO - 1499078238153 Marionette TRACE 400 <- [1,2,null,{}]
03:37:18 INFO - 1499078238159 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
03:37:18 INFO - 1499078238161 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"543b4854-6577-4b98-8d79-24eec3ea1c32","ELEMENT":"543b4854-6577-4b98-8d79-24eec3ea1c32"}}]
03:37:18 INFO - 1499078238163 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"543b4854-6577-4b98-8d79-24eec3ea1c32"}]
03:37:18 INFO - 1499078238184 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
03:37:18 INFO - 1499078238185 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"543b4854-6577-4b98-8d79-24eec3ea1c32"}]
03:37:18 INFO - 1499078238198 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element