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]
10:48:25 INFO - 1500659305373 Marionette TRACE 353 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:48:25 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500659305375 Marionette TRACE 353 <- [1,5,null,{"value":null}]
10:48:25 INFO - 1500659305376 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
10:48:25 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 161ms
10:48:25 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:48:25 INFO - 1500659305378 Marionette TRACE 353 <- [1,6,null,{}]
10:48:25 INFO - 1500659305379 Marionette DEBUG Closed connection 353
10:48:25 INFO - 1500659305380 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49770
10:48:25 INFO - 1500659305381 Marionette DEBUG Closed connection 354
10:48:25 INFO - 1500659305381 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49771
10:48:25 INFO - 1500659305383 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305383 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305386 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305390 Marionette TRACE 355 <- [1,1,null,{"sessionId":"6e1ff0e4-8636-4629-afde-e3541a6e05f0","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305392 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
10:48:25 INFO - 1500659305392 Marionette TRACE 355 <- [1,2,null,{}]
10:48:25 INFO - 1500659305393 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:25 INFO - 1500659305394 Marionette TRACE 355 <- [1,3,null,{}]
10:48:25 INFO - 1500659305395 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:25 INFO - 1500659305395 Marionette TRACE 355 <- [1,4,null,{}]
10:48:25 INFO - 1500659305397 Marionette TRACE 355 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:48:25 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500659305399 Marionette TRACE 355 <- [1,5,null,{"value":null}]
10:48:25 INFO - 1500659305400 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
10:48:25 INFO - 1500659305402 Marionette TRACE 355 <- [1,6,null,{}]
10:48:25 INFO - 1500659305404 Marionette DEBUG Closed connection 355
10:48:25 INFO - 1500659305404 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49772
10:48:25 INFO - 1500659305405 Marionette DEBUG Closed connection 356
10:48:25 INFO - 1500659305406 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49773
10:48:25 INFO - 1500659305407 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305407 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305410 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305414 Marionette TRACE 357 <- [1,1,null,{"sessionId":"5fb668ca-c9ed-4911-8384-bda0b0259825","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305415 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
10:48:25 INFO - 1500659305416 Marionette TRACE 357 <- [1,2,null,{}]
10:48:25 INFO - 1500659305418 Marionette DEBUG Closed connection 357
10:48:25 INFO - 1500659305419 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49774
10:48:25 INFO - 1500659305419 Marionette DEBUG Closed connection 358
10:48:25 INFO - 1500659305420 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49775
10:48:25 INFO - 1500659305421 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:25 INFO - 1500659305422 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305425 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305428 Marionette TRACE 359 <- [1,1,null,{"sessionId":"59e7c282-2c52-4920-9b3d-f7286753ade8","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305430 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49330/clicks.html"}]
10:48:25 INFO - 1500659305432 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/hidden.html"
10:48:25 INFO - 1500659305442 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/hidden.html"
10:48:25 INFO - 1500659305442 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/hidden.html"
10:48:25 INFO - 1500659305449 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/clicks.html"
10:48:25 INFO - 1500659305454 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/clicks.html"
10:48:25 INFO - 1500659305461 Marionette TRACE 359 <- [1,2,null,{}]
10:48:25 INFO - 1500659305465 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:48:25 INFO - 1500659305468 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"004410d9-bf6d-4314-9cab-bfdef1b06a05","ELEMENT":"004410d9-bf6d-4314-9cab-bfdef1b06a05"}}]
10:48:25 INFO - 1500659305469 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"004410d9-bf6d-4314-9cab-bfdef1b06a05"}]
10:48:25 INFO - 1500659305519 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/clicks.html"
10:48:25 INFO - 1500659305526 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/clicks.html"
10:48:25 INFO - 1500659305527 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/clicks.html"
10:48:25 INFO - 1500659305534 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/test.html"
10:48:25 INFO - 1500659305537 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/test.html"
10:48:25 INFO - 1500659305543 Marionette TRACE 359 <- [1,4,null,{}]
10:48:25 INFO - 1500659305547 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:48:25 INFO - 1500659305550 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"afbbc18d-f8dc-4f74-8e4a-716e929b45b3","ELEMENT":"afbbc18d-f8dc-4f74-8e4a-716e929b45b3"}}]
10:48:25 INFO - 1500659305551 Marionette TRACE 359 -> [0,6,"getTitle",{}]
10:48:25 INFO - 1500659305551 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
10:48:25 INFO - 1500659305553 Marionette TRACE 359 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:48:25 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500659305559 Marionette TRACE 359 <- [1,7,null,{"value":null}]
10:48:25 INFO - 1500659305560 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
10:48:25 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 184ms
10:48:25 INFO - 1500659305563 Marionette TRACE 359 <- [1,8,null,{}]
10:48:25 INFO - TEST-START | test_click.py TestClick.test_container_element
10:48:25 INFO - 1500659305565 Marionette DEBUG Closed connection 359
10:48:25 INFO - 1500659305565 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49778
10:48:25 INFO - 1500659305566 Marionette DEBUG Closed connection 360
10:48:25 INFO - 1500659305567 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49779
10:48:25 INFO - 1500659305568 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305569 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305572 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305576 Marionette TRACE 361 <- [1,1,null,{"sessionId":"45067984-7812-476c-9a5f-1e158c5590d2","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305577 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
10:48:25 INFO - 1500659305578 Marionette TRACE 361 <- [1,2,null,{}]
10:48:25 INFO - 1500659305578 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:25 INFO - 1500659305579 Marionette TRACE 361 <- [1,3,null,{}]
10:48:25 INFO - 1500659305580 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:25 INFO - 1500659305580 Marionette TRACE 361 <- [1,4,null,{}]
10:48:25 INFO - 1500659305582 Marionette TRACE 361 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:48:25 INFO - TEST-START: test_click.py TestClick.test_container_element1500659305585 Marionette TRACE 361 <- [1,5,null,{"value":null}]
10:48:25 INFO - 1500659305586 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
10:48:25 INFO - 1500659305587 Marionette TRACE 361 <- [1,6,null,{}]
10:48:25 INFO - 1500659305589 Marionette DEBUG Closed connection 361
10:48:25 INFO - 1500659305590 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49780
10:48:25 INFO - 1500659305591 Marionette DEBUG Closed connection 362
10:48:25 INFO - 1500659305591 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49781
10:48:25 INFO - 1500659305592 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305593 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305596 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305599 Marionette TRACE 363 <- [1,1,null,{"sessionId":"a9afd85c-ff35-4fd9-9150-02684802679a","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305600 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
10:48:25 INFO - 1500659305602 Marionette TRACE 363 <- [1,2,null,{}]
10:48:25 INFO - 1500659305604 Marionette DEBUG Closed connection 363
10:48:25 INFO - 1500659305604 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49782
10:48:25 INFO - 1500659305605 Marionette DEBUG Closed connection 364
10:48:25 INFO - 1500659305606 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49783
10:48:25 INFO - 1500659305607 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:25 INFO - 1500659305608 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305611 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305614 Marionette TRACE 365 <- [1,1,null,{"sessionId":"6756cd6a-af33-4432-8a21-fc938859f815","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305615 Marionette TRACE 365 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:48:25 INFO - 1500659305617 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/test.html"
10:48:25 INFO - 1500659305620 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/test.html"
10:48:25 INFO - 1500659305621 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/test.html"
10:48:25 INFO - 1500659305629 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"
10:48:25 INFO - 1500659305635 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"
10:48:25 INFO - 1500659305636 Marionette TRACE 365 <- [1,2,null,{}]
10:48:25 INFO - 1500659305645 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:48:25 INFO - 1500659305648 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7fe9dfb9-dc46-4e12-b58f-2f3626120c8a","ELEMENT":"7fe9dfb9-dc46-4e12-b58f-2f3626120c8a"}}]
10:48:25 INFO - 1500659305649 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"7fe9dfb9-dc46-4e12-b58f-2f3626120c8a"}]
10:48:25 INFO - 1500659305893 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:48:25 INFO - 1500659305894 Marionette TRACE 365 <- [1,4,null,{}]
10:48:25 INFO - 1500659305895 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"7fe9dfb9-dc46-4e12-b58f-2f3626120c8a","name":"selected"}]
10:48:25 INFO - 1500659305900 Marionette TRACE 365 <- [1,5,null,{"value":true}]
10:48:25 INFO - 1500659305902 Marionette TRACE 365 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:48:25 INFO - TEST-END: test_click.py TestClick.test_container_element1500659305905 Marionette TRACE 365 <- [1,6,null,{"value":null}]
10:48:25 INFO - 1500659305906 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
10:48:25 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 343ms
10:48:25 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:48:25 INFO - 1500659305907 Marionette TRACE 365 <- [1,7,null,{}]
10:48:25 INFO - 1500659305909 Marionette DEBUG Closed connection 365
10:48:25 INFO - 1500659305909 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49784
10:48:25 INFO - 1500659305910 Marionette DEBUG Closed connection 366
10:48:25 INFO - 1500659305911 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49785
10:48:25 INFO - 1500659305912 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305913 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305916 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305919 Marionette TRACE 367 <- [1,1,null,{"sessionId":"b9feb10f-4904-479f-b5d1-459bf1a431f6","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305920 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
10:48:25 INFO - 1500659305921 Marionette TRACE 367 <- [1,2,null,{}]
10:48:25 INFO - 1500659305922 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:25 INFO - 1500659305922 Marionette TRACE 367 <- [1,3,null,{}]
10:48:25 INFO - 1500659305923 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:25 INFO - 1500659305924 Marionette TRACE 367 <- [1,4,null,{}]
10:48:25 INFO - 1500659305925 Marionette TRACE 367 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:48:25 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500659305928 Marionette TRACE 367 <- [1,5,null,{"value":null}]
10:48:25 INFO - 1500659305929 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
10:48:25 INFO - 1500659305930 Marionette TRACE 367 <- [1,6,null,{}]
10:48:25 INFO - 1500659305932 Marionette DEBUG Closed connection 367
10:48:25 INFO - 1500659305933 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49786
10:48:25 INFO - 1500659305933 Marionette DEBUG Closed connection 368
10:48:25 INFO - 1500659305934 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49787
10:48:25 INFO - 1500659305935 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:25 INFO - 1500659305936 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305939 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305943 Marionette TRACE 369 <- [1,1,null,{"sessionId":"d4e81447-ad57-48c3-a9f3-096a5db80cf2","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305944 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
10:48:25 INFO - 1500659305946 Marionette TRACE 369 <- [1,2,null,{}]
10:48:25 INFO - 1500659305948 Marionette DEBUG Closed connection 369
10:48:25 INFO - 1500659305948 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49788
10:48:25 INFO - 1500659305949 Marionette DEBUG Closed connection 370
10:48:25 INFO - 1500659305950 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49789
10:48:25 INFO - 1500659305951 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:25 INFO - 1500659305952 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:25 INFO - 1500659305954 Marionette DEBUG Register listener.js for window 6442450945
10:48:25 INFO - 1500659305958 Marionette TRACE 371 <- [1,1,null,{"sessionId":"b0b398fe-8045-4e20-8468-9c9380b9290f","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:25 INFO - 1500659305959 Marionette TRACE 371 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:48:25 INFO - 1500659305961 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"
10:48:25 INFO - 1500659305963 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"
10:48:25 INFO - 1500659305963 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"
10:48:25 INFO - 1500659305970 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"
10:48:25 INFO - 1500659305979 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"
10:48:25 INFO - 1500659305986 Marionette TRACE 371 <- [1,2,null,{}]
10:48:26 INFO - 1500659305994 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:48:26 INFO - 1500659305996 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2afe5c65-542e-43eb-b721-177148572827","ELEMENT":"2afe5c65-542e-43eb-b721-177148572827"}}]
10:48:26 INFO - 1500659305997 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"2afe5c65-542e-43eb-b721-177148572827"}]
10:48:26 INFO - 1500659306241 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:48:26 INFO - 1500659306242 Marionette TRACE 371 <- [1,4,null,{}]
10:48:26 INFO - 1500659306244 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"2afe5c65-542e-43eb-b721-177148572827","name":"selected"}]
10:48:26 INFO - 1500659306248 Marionette TRACE 371 <- [1,5,null,{"value":true}]
10:48:26 INFO - 1500659306250 Marionette TRACE 371 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:48:26 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500659306252 Marionette TRACE 371 <- [1,6,null,{"value":null}]
10:48:26 INFO - 1500659306253 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
10:48:26 INFO - 1500659306255 Marionette TRACE 371 <- [1,7,null,{}]
10:48:26 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 347ms
10:48:26 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:48:26 INFO - 1500659306256 Marionette DEBUG Closed connection 371
10:48:26 INFO - 1500659306257 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49790
10:48:26 INFO - 1500659306258 Marionette DEBUG Closed connection 372
10:48:26 INFO - 1500659306258 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49791
10:48:26 INFO - 1500659306259 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306260 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306263 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306266 Marionette TRACE 373 <- [1,1,null,{"sessionId":"c65c3490-0346-4f21-b287-e648b4b49642","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306267 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
10:48:26 INFO - 1500659306268 Marionette TRACE 373 <- [1,2,null,{}]
10:48:26 INFO - 1500659306269 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:26 INFO - 1500659306269 Marionette TRACE 373 <- [1,3,null,{}]
10:48:26 INFO - 1500659306270 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:26 INFO - 1500659306271 Marionette TRACE 373 <- [1,4,null,{}]
10:48:26 INFO - 1500659306272 Marionette TRACE 373 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:48:26 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500659306275 Marionette TRACE 373 <- [1,5,null,{"value":null}]
10:48:26 INFO - 1500659306276 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
10:48:26 INFO - 1500659306278 Marionette TRACE 373 <- [1,6,null,{}]
10:48:26 INFO - 1500659306280 Marionette DEBUG Closed connection 373
10:48:26 INFO - 1500659306280 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49792
10:48:26 INFO - 1500659306281 Marionette DEBUG Closed connection 374
10:48:26 INFO - 1500659306282 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49793
10:48:26 INFO - 1500659306283 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306283 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306293 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306296 Marionette TRACE 375 <- [1,1,null,{"sessionId":"8ca537cf-e92d-4122-8f22-86f0a25bfeed","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306297 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
10:48:26 INFO - 1500659306299 Marionette TRACE 375 <- [1,2,null,{}]
10:48:26 INFO - 1500659306301 Marionette DEBUG Closed connection 375
10:48:26 INFO - 1500659306301 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49794
10:48:26 INFO - 1500659306302 Marionette DEBUG Closed connection 376
10:48:26 INFO - 1500659306303 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49795
10:48:26 INFO - 1500659306304 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:26 INFO - 1500659306304 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306307 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306311 Marionette TRACE 377 <- [1,1,null,{"sessionId":"a212ea08-1023-4a6a-8fc7-b64319395700","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306312 Marionette TRACE 377 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:48:26 INFO - 1500659306314 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"
10:48:26 INFO - 1500659306316 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"
10:48:26 INFO - 1500659306317 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"
10:48:26 INFO - 1500659306326 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"
10:48:26 INFO - 1500659306327 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"
10:48:26 INFO - 1500659306335 Marionette TRACE 377 <- [1,2,null,{}]
10:48:26 INFO - 1500659306339 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:48:26 INFO - 1500659306344 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4387b9f1-f25b-4538-a7c8-558b551de9e2","ELEMENT":"4387b9f1-f25b-4538-a7c8-558b551de9e2"}}]
10:48:26 INFO - 1500659306345 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"4387b9f1-f25b-4538-a7c8-558b551de9e2"}]
10:48:26 INFO - 1500659306586 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:48:26 INFO - 1500659306587 Marionette TRACE 377 <- [1,4,null,{}]
10:48:26 INFO - 1500659306589 Marionette TRACE 377 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:48:26 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500659306592 Marionette TRACE 377 <- [1,5,null,{"value":null}]
10:48:26 INFO - 1500659306593 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
10:48:26 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 339ms
10:48:26 INFO - 1500659306594 Marionette TRACE 377 <- [1,6,null,{}]
10:48:26 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:48:26 INFO - 1500659306596 Marionette DEBUG Closed connection 377
10:48:26 INFO - 1500659306597 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49796
10:48:26 INFO - 1500659306598 Marionette DEBUG Closed connection 378
10:48:26 INFO - 1500659306599 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49797
10:48:26 INFO - 1500659306600 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306600 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306603 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306614 Marionette TRACE 379 <- [1,1,null,{"sessionId":"4ab9b100-eb2f-439d-8391-cf5ba48874a4","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306616 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
10:48:26 INFO - 1500659306616 Marionette TRACE 379 <- [1,2,null,{}]
10:48:26 INFO - 1500659306617 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:26 INFO - 1500659306618 Marionette TRACE 379 <- [1,3,null,{}]
10:48:26 INFO - 1500659306619 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:26 INFO - 1500659306620 Marionette TRACE 379 <- [1,4,null,{}]
10:48:26 INFO - 1500659306621 Marionette TRACE 379 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:48:26 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500659306625 Marionette TRACE 379 <- [1,5,null,{"value":null}]
10:48:26 INFO - 1500659306626 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
10:48:26 INFO - 1500659306627 Marionette TRACE 379 <- [1,6,null,{}]
10:48:26 INFO - 1500659306629 Marionette DEBUG Closed connection 379
10:48:26 INFO - 1500659306629 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49798
10:48:26 INFO - 1500659306630 Marionette DEBUG Closed connection 380
10:48:26 INFO - 1500659306631 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49799
10:48:26 INFO - 1500659306632 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306632 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306635 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306638 Marionette TRACE 381 <- [1,1,null,{"sessionId":"b0f6bcba-8b46-4b94-a7ab-366a14755ae6","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306640 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
10:48:26 INFO - 1500659306641 Marionette TRACE 381 <- [1,2,null,{}]
10:48:26 INFO - 1500659306643 Marionette DEBUG Closed connection 381
10:48:26 INFO - 1500659306643 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49800
10:48:26 INFO - 1500659306644 Marionette DEBUG Closed connection 382
10:48:26 INFO - 1500659306645 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49801
10:48:26 INFO - 1500659306646 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:26 INFO - 1500659306647 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306650 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306653 Marionette TRACE 383 <- [1,1,null,{"sessionId":"d6395014-83f3-4da1-bb6b-5c61dc731706","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306654 Marionette TRACE 383 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:48:26 INFO - 1500659306657 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"
10:48:26 INFO - 1500659306658 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"
10:48:26 INFO - 1500659306659 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"
10:48:26 INFO - 1500659306665 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"
10:48:26 INFO - 1500659306668 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"
10:48:26 INFO - 1500659306671 Marionette TRACE 383 <- [1,2,null,{}]
10:48:26 INFO - 1500659306680 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:48:26 INFO - 1500659306683 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ece68c15-bf68-4760-a553-4a59855dee7e","ELEMENT":"ece68c15-bf68-4760-a553-4a59855dee7e"}}]
10:48:26 INFO - 1500659306684 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"ece68c15-bf68-4760-a553-4a59855dee7e"}]
10:48:26 INFO - 1500659306932 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:48:26 INFO - 1500659306933 Marionette TRACE 383 <- [1,4,null,{}]
10:48:26 INFO - 1500659306934 Marionette TRACE 383 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:48:26 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500659306937 Marionette TRACE 383 <- [1,5,null,{"value":null}]
10:48:26 INFO - 1500659306938 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
10:48:26 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 345ms
10:48:26 INFO - 1500659306940 Marionette TRACE 383 <- [1,6,null,{}]
10:48:26 INFO - TEST-START | test_click.py TestClick.test_input_file
10:48:26 INFO - 1500659306941 Marionette DEBUG Closed connection 383
10:48:26 INFO - 1500659306944 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49802
10:48:26 INFO - 1500659306945 Marionette DEBUG Closed connection 384
10:48:26 INFO - 1500659306946 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49803
10:48:26 INFO - 1500659306947 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306947 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306950 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306953 Marionette TRACE 385 <- [1,1,null,{"sessionId":"608b261c-2100-49a4-84f2-2b0c7a52562b","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306955 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
10:48:26 INFO - 1500659306955 Marionette TRACE 385 <- [1,2,null,{}]
10:48:26 INFO - 1500659306956 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:26 INFO - 1500659306957 Marionette TRACE 385 <- [1,3,null,{}]
10:48:26 INFO - 1500659306958 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:26 INFO - 1500659306958 Marionette TRACE 385 <- [1,4,null,{}]
10:48:26 INFO - 1500659306960 Marionette TRACE 385 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:48:26 INFO - TEST-START: test_click.py TestClick.test_input_file1500659306963 Marionette TRACE 385 <- [1,5,null,{"value":null}]
10:48:26 INFO - 1500659306964 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
10:48:26 INFO - 1500659306966 Marionette TRACE 385 <- [1,6,null,{}]
10:48:26 INFO - 1500659306967 Marionette DEBUG Closed connection 385
10:48:26 INFO - 1500659306968 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49804
10:48:26 INFO - 1500659306968 Marionette DEBUG Closed connection 386
10:48:26 INFO - 1500659306969 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49805
10:48:26 INFO - 1500659306970 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:26 INFO - 1500659306971 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306974 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306977 Marionette TRACE 387 <- [1,1,null,{"sessionId":"aa087db0-1124-4b5e-a4ae-3fcf1749a7fa","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306978 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
10:48:26 INFO - 1500659306980 Marionette TRACE 387 <- [1,2,null,{}]
10:48:26 INFO - 1500659306981 Marionette DEBUG Closed connection 387
10:48:26 INFO - 1500659306982 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49806
10:48:26 INFO - 1500659306983 Marionette DEBUG Closed connection 388
10:48:26 INFO - 1500659306983 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49807
10:48:26 INFO - 1500659306984 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:26 INFO - 1500659306985 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:26 INFO - 1500659306988 Marionette DEBUG Register listener.js for window 6442450945
10:48:26 INFO - 1500659306991 Marionette TRACE 389 <- [1,1,null,{"sessionId":"b5d60602-cc91-4c02-a8af-226777d60dd1","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:26 INFO - 1500659306993 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:48:26 INFO - 1500659306995 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"
10:48:26 INFO - 1500659306997 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"
10:48:26 INFO - 1500659306997 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"
10:48:27 INFO - 1500659307004 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:48:27 INFO - 1500659307008 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:48:27 INFO - 1500659307014 Marionette TRACE 389 <- [1,2,null,{}]
10:48:27 INFO - 1500659307018 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:48:27 INFO - 1500659307021 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3a38b143-c819-4e79-9748-1cafad00cd3f","ELEMENT":"3a38b143-c819-4e79-9748-1cafad00cd3f"}}]
10:48:27 INFO - 1500659307026 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"3a38b143-c819-4e79-9748-1cafad00cd3f"}]
10:48:27 INFO - 1500659307056 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:48:27 INFO - 1500659307058 Marionette TRACE 389 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:48:27 INFO - TEST-END: test_click.py TestClick.test_input_file1500659307061 Marionette TRACE 389 <- [1,5,null,{"value":null}]
10:48:27 INFO - 1500659307061 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
10:48:27 INFO - 1500659307063 Marionette TRACE 389 <- [1,6,null,{}]
10:48:27 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 121ms
10:48:27 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:48:27 INFO - 1500659307064 Marionette DEBUG Closed connection 389
10:48:27 INFO - 1500659307065 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49808
10:48:27 INFO - 1500659307066 Marionette DEBUG Closed connection 390
10:48:27 INFO - 1500659307067 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49809
10:48:27 INFO - 1500659307069 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:27 INFO - 1500659307069 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307072 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307075 Marionette TRACE 391 <- [1,1,null,{"sessionId":"e3024a70-50c3-4e5f-b641-4b31ad1117b1","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307077 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
10:48:27 INFO - 1500659307077 Marionette TRACE 391 <- [1,2,null,{}]
10:48:27 INFO - 1500659307078 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:27 INFO - 1500659307079 Marionette TRACE 391 <- [1,3,null,{}]
10:48:27 INFO - 1500659307080 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:27 INFO - 1500659307080 Marionette TRACE 391 <- [1,4,null,{}]
10:48:27 INFO - 1500659307082 Marionette TRACE 391 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:48:27 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500659307085 Marionette TRACE 391 <- [1,5,null,{"value":null}]
10:48:27 INFO - 1500659307086 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
10:48:27 INFO - 1500659307087 Marionette TRACE 391 <- [1,6,null,{}]
10:48:27 INFO - 1500659307089 Marionette DEBUG Closed connection 391
10:48:27 INFO - 1500659307089 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49810
10:48:27 INFO - 1500659307090 Marionette DEBUG Closed connection 392
10:48:27 INFO - 1500659307091 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49811
10:48:27 INFO - 1500659307092 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:27 INFO - 1500659307092 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307096 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307099 Marionette TRACE 393 <- [1,1,null,{"sessionId":"e07e59a7-782e-400e-91aa-ec34bc367969","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307100 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
10:48:27 INFO - 1500659307102 Marionette TRACE 393 <- [1,2,null,{}]
10:48:27 INFO - 1500659307103 Marionette DEBUG Closed connection 393
10:48:27 INFO - 1500659307104 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49812
10:48:27 INFO - 1500659307105 Marionette DEBUG Closed connection 394
10:48:27 INFO - 1500659307106 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49813
10:48:27 INFO - 1500659307107 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:27 INFO - 1500659307107 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307110 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307113 Marionette TRACE 395 <- [1,1,null,{"sessionId":"d2931735-c349-4a4a-81ba-da4d3c01fcf5","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307115 Marionette TRACE 395 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:48:27 INFO - 1500659307117 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:48:27 INFO - 1500659307119 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:48:27 INFO - 1500659307119 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:48:27 INFO - 1500659307127 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"
10:48:27 INFO - 1500659307128 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"
10:48:27 INFO - 1500659307133 Marionette TRACE 395 <- [1,2,null,{}]
10:48:27 INFO - 1500659307136 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:48:27 INFO - 1500659307145 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"80a6c911-564c-4bf6-ab33-6e5c207b46fa","ELEMENT":"80a6c911-564c-4bf6-ab33-6e5c207b46fa"}}]
10:48:27 INFO - 1500659307146 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:48:27 INFO - 1500659307149 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0522209-8eb2-4a40-9e14-3d4cc57512e6","ELEMENT":"e0522209-8eb2-4a40-9e14-3d4cc57512e6"}}]
10:48:27 INFO - 1500659307149 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"80a6c911-564c-4bf6-ab33-6e5c207b46fa"}]
10:48:27 INFO - 1500659307396 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:48:27 INFO - 1500659307397 Marionette TRACE 395 <- [1,5,null,{}]
10:48:27 INFO - 1500659307398 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"e0522209-8eb2-4a40-9e14-3d4cc57512e6"}]
10:48:27 INFO - 1500659307415 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:48:27 INFO - 1500659307417 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
10:48:27 INFO - 1500659307420 Marionette TRACE 395 <- [1,7,null,{"value":false}]
10:48:27 INFO - 1500659307421 Marionette TRACE 395 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:48:27 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500659307424 Marionette TRACE 395 <- [1,8,null,{"value":null}]
10:48:27 INFO - 1500659307425 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
10:48:27 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 363ms
10:48:27 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:48:27 INFO - 1500659307426 Marionette TRACE 395 <- [1,9,null,{}]
10:48:27 INFO - 1500659307428 Marionette DEBUG Closed connection 395
10:48:27 INFO - 1500659307429 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49814
10:48:27 INFO - 1500659307429 Marionette DEBUG Closed connection 396
10:48:27 INFO - 1500659307430 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49815
10:48:27 INFO - 1500659307431 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:27 INFO - 1500659307432 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307435 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307438 Marionette TRACE 397 <- [1,1,null,{"sessionId":"bbacd26b-7366-45b8-8bb8-75ce00bf93b3","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307439 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
10:48:27 INFO - 1500659307440 Marionette TRACE 397 <- [1,2,null,{}]
10:48:27 INFO - 1500659307441 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:48:27 INFO - 1500659307441 Marionette TRACE 397 <- [1,3,null,{}]
10:48:27 INFO - 1500659307442 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
10:48:27 INFO - 1500659307443 Marionette TRACE 397 <- [1,4,null,{}]
10:48:27 INFO - 1500659307445 Marionette TRACE 397 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:48:27 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500659307447 Marionette TRACE 397 <- [1,5,null,{"value":null}]
10:48:27 INFO - 1500659307448 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
10:48:27 INFO - 1500659307450 Marionette TRACE 397 <- [1,6,null,{}]
10:48:27 INFO - 1500659307451 Marionette DEBUG Closed connection 397
10:48:27 INFO - 1500659307452 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49816
10:48:27 INFO - 1500659307453 Marionette DEBUG Closed connection 398
10:48:27 INFO - 1500659307453 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49817
10:48:27 INFO - 1500659307455 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:48:27 INFO - 1500659307455 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307458 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307462 Marionette TRACE 399 <- [1,1,null,{"sessionId":"de8038a1-6e05-4012-8827-1ca93313fb63","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307463 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
10:48:27 INFO - 1500659307465 Marionette TRACE 399 <- [1,2,null,{}]
10:48:27 INFO - 1500659307467 Marionette DEBUG Closed connection 399
10:48:27 INFO - 1500659307467 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49818
10:48:27 INFO - 1500659307468 Marionette DEBUG Closed connection 400
10:48:27 INFO - 1500659307468 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49819
10:48:27 INFO - 1500659307469 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:48:27 INFO - 1500659307470 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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}
10:48:27 INFO - 1500659307473 Marionette DEBUG Register listener.js for window 6442450945
10:48:27 INFO - 1500659307477 Marionette TRACE 401 <- [1,1,null,{"sessionId":"30c79d23-b745-4027-997b-4dc069cc5eb8","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":2068,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-074.001\\AppData\\Local\\Temp\\tmpkmexxy.mozrunner","moz:accessibilityChecks":false}}]
10:48:27 INFO - 1500659307478 Marionette TRACE 401 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:48:27 INFO - 1500659307480 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"
10:48:27 INFO - 1500659307482 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"
10:48:27 INFO - 1500659307482 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"
10:48:27 INFO - 1500659307492 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"
10:48:27 INFO - 1500659307494 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"
10:48:27 INFO - 1500659307500 Marionette TRACE 401 <- [1,2,null,{}]
10:48:27 INFO - 1500659307503 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:48:27 INFO - 1500659307510 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"832d54a4-72ba-4f81-81ef-4a635803d182","ELEMENT":"832d54a4-72ba-4f81-81ef-4a635803d182"}}]
10:48:27 INFO - 1500659307511 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"832d54a4-72ba-4f81-81ef-4a635803d182"}]
10:48:27 INFO - 1500659307539 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
10:48:27 INFO - 1500659307541 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"832d54a4-72ba-4f81-81ef-4a635803d182"}]
10:48:27 INFO - 1500659307558 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element