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]
15:37:39 INFO - 1500417459617 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}]
15:37:39 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500417459620 Marionette TRACE 352 <- [1,5,null,{"value":null}]
15:37:39 INFO - 1500417459621 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
15:37:39 INFO - 1500417459623 Marionette TRACE 352 <- [1,6,null,{}]
15:37:39 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 151ms
15:37:39 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
15:37:39 INFO - 1500417459625 Marionette DEBUG Closed connection 352
15:37:39 INFO - 1500417459626 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49755
15:37:39 INFO - 1500417459627 Marionette DEBUG Closed connection 353
15:37:39 INFO - 1500417459628 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49756
15:37:39 INFO - 1500417459629 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:39 INFO - 1500417459630 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459632 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459636 Marionette TRACE 354 <- [1,1,null,{"sessionId":"0b09e43b-8d12-4d7c-b75d-1007a92b1c13","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459638 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
15:37:39 INFO - 1500417459638 Marionette TRACE 354 <- [1,2,null,{}]
15:37:39 INFO - 1500417459639 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:39 INFO - 1500417459640 Marionette TRACE 354 <- [1,3,null,{}]
15:37:39 INFO - 1500417459641 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:39 INFO - 1500417459641 Marionette TRACE 354 <- [1,4,null,{}]
15:37:39 INFO - 1500417459643 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}]
15:37:39 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500417459645 Marionette TRACE 354 <- [1,5,null,{"value":null}]
15:37:39 INFO - 1500417459646 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
15:37:39 INFO - 1500417459648 Marionette TRACE 354 <- [1,6,null,{}]
15:37:39 INFO - 1500417459650 Marionette DEBUG Closed connection 354
15:37:39 INFO - 1500417459651 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49757
15:37:39 INFO - 1500417459651 Marionette DEBUG Closed connection 355
15:37:39 INFO - 1500417459652 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49758
15:37:39 INFO - 1500417459653 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:39 INFO - 1500417459654 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459656 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459660 Marionette TRACE 356 <- [1,1,null,{"sessionId":"eff0730b-a70e-4052-a2d6-6e27a4965e62","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459662 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
15:37:39 INFO - 1500417459663 Marionette TRACE 356 <- [1,2,null,{}]
15:37:39 INFO - 1500417459666 Marionette DEBUG Closed connection 356
15:37:39 INFO - 1500417459666 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49759
15:37:39 INFO - 1500417459667 Marionette DEBUG Closed connection 357
15:37:39 INFO - 1500417459668 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49760
15:37:39 INFO - 1500417459669 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:39 INFO - 1500417459669 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459672 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459675 Marionette TRACE 358 <- [1,1,null,{"sessionId":"01de4696-c69b-4d6e-a4a7-cd200cf9e7fb","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459678 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49328/clicks.html"}]
15:37:39 INFO - 1500417459679 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/hidden.html"
15:37:39 INFO - 1500417459689 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/hidden.html"
15:37:39 INFO - 1500417459690 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/hidden.html"
15:37:39 INFO - 1500417459708 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/clicks.html"
15:37:39 INFO - 1500417459710 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/clicks.html"
15:37:39 INFO - 1500417459714 Marionette TRACE 358 <- [1,2,null,{}]
15:37:39 INFO - 1500417459715 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
15:37:39 INFO - 1500417459723 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"83c66b06-c231-4269-95aa-0aff913d85c1","ELEMENT":"83c66b06-c231-4269-95aa-0aff913d85c1"}}]
15:37:39 INFO - 1500417459724 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"83c66b06-c231-4269-95aa-0aff913d85c1"}]
15:37:39 INFO - 1500417459776 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/clicks.html"
15:37:39 INFO - 1500417459781 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/clicks.html"
15:37:39 INFO - 1500417459781 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/clicks.html"
15:37:39 INFO - 1500417459800 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/test.html"
15:37:39 INFO - 1500417459806 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/test.html"
15:37:39 INFO - 1500417459809 Marionette TRACE 358 <- [1,4,null,{}]
15:37:39 INFO - 1500417459810 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
15:37:39 INFO - 1500417459812 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8cdd07a7-2512-4e21-83fc-7e27f4ad0c85","ELEMENT":"8cdd07a7-2512-4e21-83fc-7e27f4ad0c85"}}]
15:37:39 INFO - 1500417459813 Marionette TRACE 358 -> [0,6,"getTitle",{}]
15:37:39 INFO - 1500417459814 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
15:37:39 INFO - 1500417459815 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}]
15:37:39 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500417459824 Marionette TRACE 358 <- [1,7,null,{"value":null}]
15:37:39 INFO - 1500417459825 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
15:37:39 INFO - 1500417459827 Marionette TRACE 358 <- [1,8,null,{}]
15:37:39 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 203ms
15:37:39 INFO - TEST-START | test_click.py TestClick.test_container_element
15:37:39 INFO - 1500417459829 Marionette DEBUG Closed connection 358
15:37:39 INFO - 1500417459829 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49763
15:37:39 INFO - 1500417459830 Marionette DEBUG Closed connection 359
15:37:39 INFO - 1500417459831 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49764
15:37:39 INFO - 1500417459832 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:39 INFO - 1500417459832 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459835 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459839 Marionette TRACE 360 <- [1,1,null,{"sessionId":"04ab1a9d-0767-495c-aab3-bbace659daed","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459841 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
15:37:39 INFO - 1500417459842 Marionette TRACE 360 <- [1,2,null,{}]
15:37:39 INFO - 1500417459842 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:39 INFO - 1500417459843 Marionette TRACE 360 <- [1,3,null,{}]
15:37:39 INFO - 1500417459844 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:39 INFO - 1500417459844 Marionette TRACE 360 <- [1,4,null,{}]
15:37:39 INFO - 1500417459846 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}]
15:37:39 INFO - TEST-START: test_click.py TestClick.test_container_element1500417459848 Marionette TRACE 360 <- [1,5,null,{"value":null}]
15:37:39 INFO - 1500417459849 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
15:37:39 INFO - 1500417459851 Marionette TRACE 360 <- [1,6,null,{}]
15:37:39 INFO - 1500417459855 Marionette DEBUG Closed connection 360
15:37:39 INFO - 1500417459855 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49765
15:37:39 INFO - 1500417459856 Marionette DEBUG Closed connection 361
15:37:39 INFO - 1500417459857 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49766
15:37:39 INFO - 1500417459858 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:39 INFO - 1500417459859 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459862 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459866 Marionette TRACE 362 <- [1,1,null,{"sessionId":"1334a516-a8e7-4ee4-98af-5b44557b1b64","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459869 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
15:37:39 INFO - 1500417459871 Marionette TRACE 362 <- [1,2,null,{}]
15:37:39 INFO - 1500417459873 Marionette DEBUG Closed connection 362
15:37:39 INFO - 1500417459873 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49767
15:37:39 INFO - 1500417459874 Marionette DEBUG Closed connection 363
15:37:39 INFO - 1500417459875 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49768
15:37:39 INFO - 1500417459876 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:39 INFO - 1500417459877 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:39 INFO - 1500417459879 Marionette DEBUG Register listener.js for window 15
15:37:39 INFO - 1500417459883 Marionette TRACE 364 <- [1,1,null,{"sessionId":"7e6229d7-682d-4388-a395-04e32fc3d3e9","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:39 INFO - 1500417459886 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"}]
15:37:39 INFO - 1500417459887 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/test.html"
15:37:39 INFO - 1500417459889 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/test.html"
15:37:39 INFO - 1500417459889 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/test.html"
15:37:39 INFO - 1500417459913 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"
15:37:39 INFO - 1500417459917 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"
15:37:39 INFO - 1500417459926 Marionette TRACE 364 <- [1,2,null,{}]
15:37:39 INFO - 1500417459927 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:37:39 INFO - 1500417459930 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9c1fd347-c81e-4436-92ee-ee2e22c7d207","ELEMENT":"9c1fd347-c81e-4436-92ee-ee2e22c7d207"}}]
15:37:39 INFO - 1500417459931 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"9c1fd347-c81e-4436-92ee-ee2e22c7d207"}]
15:37:40 INFO - 1500417460178 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:37:40 INFO - 1500417460179 Marionette TRACE 364 <- [1,4,null,{}]
15:37:40 INFO - 1500417460180 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"9c1fd347-c81e-4436-92ee-ee2e22c7d207","name":"selected"}]
15:37:40 INFO - 1500417460185 Marionette TRACE 364 <- [1,5,null,{"value":true}]
15:37:40 INFO - 1500417460187 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}]
15:37:40 INFO - TEST-END: test_click.py TestClick.test_container_element1500417460189 Marionette TRACE 364 <- [1,6,null,{"value":null}]
15:37:40 INFO - 1500417460190 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
15:37:40 INFO - 1500417460191 Marionette TRACE 364 <- [1,7,null,{}]
15:37:40 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 365ms
15:37:40 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
15:37:40 INFO - 1500417460194 Marionette DEBUG Closed connection 364
15:37:40 INFO - 1500417460194 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49769
15:37:40 INFO - 1500417460195 Marionette DEBUG Closed connection 365
15:37:40 INFO - 1500417460196 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49770
15:37:40 INFO - 1500417460197 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460197 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460200 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460203 Marionette TRACE 366 <- [1,1,null,{"sessionId":"0637fdfa-bfa6-4a5e-ac3f-68d7f0f27bd4","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460205 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
15:37:40 INFO - 1500417460205 Marionette TRACE 366 <- [1,2,null,{}]
15:37:40 INFO - 1500417460207 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:40 INFO - 1500417460207 Marionette TRACE 366 <- [1,3,null,{}]
15:37:40 INFO - 1500417460208 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:40 INFO - 1500417460210 Marionette TRACE 366 <- [1,4,null,{}]
15:37:40 INFO - 1500417460211 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}]
15:37:40 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500417460214 Marionette TRACE 366 <- [1,5,null,{"value":null}]
15:37:40 INFO - 1500417460215 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
15:37:40 INFO - 1500417460216 Marionette TRACE 366 <- [1,6,null,{}]
15:37:40 INFO - 1500417460218 Marionette DEBUG Closed connection 366
15:37:40 INFO - 1500417460219 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49771
15:37:40 INFO - 1500417460220 Marionette DEBUG Closed connection 367
15:37:40 INFO - 1500417460220 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49772
15:37:40 INFO - 1500417460221 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460222 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460225 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460236 Marionette TRACE 368 <- [1,1,null,{"sessionId":"98c3bf8a-95aa-41b4-bc85-66f0b9488991","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460238 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
15:37:40 INFO - 1500417460240 Marionette TRACE 368 <- [1,2,null,{}]
15:37:40 INFO - 1500417460242 Marionette DEBUG Closed connection 368
15:37:40 INFO - 1500417460242 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49773
15:37:40 INFO - 1500417460243 Marionette DEBUG Closed connection 369
15:37:40 INFO - 1500417460244 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49774
15:37:40 INFO - 1500417460248 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:40 INFO - 1500417460249 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460251 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460255 Marionette TRACE 370 <- [1,1,null,{"sessionId":"88118b8a-5eb8-4cae-a490-4f6624158795","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460257 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"}]
15:37:40 INFO - 1500417460259 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"
15:37:40 INFO - 1500417460261 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"
15:37:40 INFO - 1500417460261 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"
15:37:40 INFO - 1500417460281 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"
15:37:40 INFO - 1500417460284 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"
15:37:40 INFO - 1500417460295 Marionette TRACE 370 <- [1,2,null,{}]
15:37:40 INFO - 1500417460297 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:37:40 INFO - 1500417460300 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dfae0130-f816-4067-8a27-2c588ece3d06","ELEMENT":"dfae0130-f816-4067-8a27-2c588ece3d06"}}]
15:37:40 INFO - 1500417460301 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"dfae0130-f816-4067-8a27-2c588ece3d06"}]
15:37:40 INFO - 1500417460545 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:37:40 INFO - 1500417460546 Marionette TRACE 370 <- [1,4,null,{}]
15:37:40 INFO - 1500417460547 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"dfae0130-f816-4067-8a27-2c588ece3d06","name":"selected"}]
15:37:40 INFO - 1500417460552 Marionette TRACE 370 <- [1,5,null,{"value":true}]
15:37:40 INFO - 1500417460553 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}]
15:37:40 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500417460556 Marionette TRACE 370 <- [1,6,null,{"value":null}]
15:37:40 INFO - 1500417460557 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
15:37:40 INFO - 1500417460558 Marionette TRACE 370 <- [1,7,null,{}]
15:37:40 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 366ms
15:37:40 INFO - TEST-START | test_click.py TestClick.test_css_transforms
15:37:40 INFO - 1500417460560 Marionette DEBUG Closed connection 370
15:37:40 INFO - 1500417460562 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49775
15:37:40 INFO - 1500417460562 Marionette DEBUG Closed connection 371
15:37:40 INFO - 1500417460563 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49776
15:37:40 INFO - 1500417460564 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460565 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460567 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460570 Marionette TRACE 372 <- [1,1,null,{"sessionId":"327bd05b-6067-4257-aa35-2817610c8fad","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460573 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
15:37:40 INFO - 1500417460573 Marionette TRACE 372 <- [1,2,null,{}]
15:37:40 INFO - 1500417460574 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:40 INFO - 1500417460574 Marionette TRACE 372 <- [1,3,null,{}]
15:37:40 INFO - 1500417460575 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:40 INFO - 1500417460575 Marionette TRACE 372 <- [1,4,null,{}]
15:37:40 INFO - 1500417460577 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}]
15:37:40 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500417460580 Marionette TRACE 372 <- [1,5,null,{"value":null}]
15:37:40 INFO - 1500417460581 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
15:37:40 INFO - 1500417460582 Marionette TRACE 372 <- [1,6,null,{}]
15:37:40 INFO - 1500417460584 Marionette DEBUG Closed connection 372
15:37:40 INFO - 1500417460585 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49777
15:37:40 INFO - 1500417460586 Marionette DEBUG Closed connection 373
15:37:40 INFO - 1500417460586 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49778
15:37:40 INFO - 1500417460587 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460588 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460590 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460594 Marionette TRACE 374 <- [1,1,null,{"sessionId":"b5011eda-05a9-4a77-b48e-8ba093903a6a","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460596 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
15:37:40 INFO - 1500417460597 Marionette TRACE 374 <- [1,2,null,{}]
15:37:40 INFO - 1500417460599 Marionette DEBUG Closed connection 374
15:37:40 INFO - 1500417460599 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49779
15:37:40 INFO - 1500417460601 Marionette DEBUG Closed connection 375
15:37:40 INFO - 1500417460602 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49780
15:37:40 INFO - 1500417460603 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:40 INFO - 1500417460604 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460606 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460609 Marionette TRACE 376 <- [1,1,null,{"sessionId":"a9ab2853-0a1e-4cfd-a265-65e68fed99c1","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460611 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"}]
15:37:40 INFO - 1500417460613 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"
15:37:40 INFO - 1500417460615 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"
15:37:40 INFO - 1500417460615 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"
15:37:40 INFO - 1500417460633 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"
15:37:40 INFO - 1500417460636 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"
15:37:40 INFO - 1500417460645 Marionette TRACE 376 <- [1,2,null,{}]
15:37:40 INFO - 1500417460647 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
15:37:40 INFO - 1500417460649 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"69536528-9f1e-4223-baf6-656b3bd43f56","ELEMENT":"69536528-9f1e-4223-baf6-656b3bd43f56"}}]
15:37:40 INFO - 1500417460651 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"69536528-9f1e-4223-baf6-656b3bd43f56"}]
15:37:40 INFO - 1500417460899 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:37:40 INFO - 1500417460899 Marionette TRACE 376 <- [1,4,null,{}]
15:37:40 INFO - 1500417460901 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}]
15:37:40 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500417460904 Marionette TRACE 376 <- [1,5,null,{"value":null}]
15:37:40 INFO - 1500417460905 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
15:37:40 INFO - 1500417460906 Marionette TRACE 376 <- [1,6,null,{}]
15:37:40 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 346ms
15:37:40 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
15:37:40 INFO - 1500417460908 Marionette DEBUG Closed connection 376
15:37:40 INFO - 1500417460909 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49781
15:37:40 INFO - 1500417460910 Marionette DEBUG Closed connection 377
15:37:40 INFO - 1500417460910 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49782
15:37:40 INFO - 1500417460912 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460912 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460915 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460918 Marionette TRACE 378 <- [1,1,null,{"sessionId":"e1ffd003-fb4f-4582-912a-0c4f540b7234","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460920 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
15:37:40 INFO - 1500417460921 Marionette TRACE 378 <- [1,2,null,{}]
15:37:40 INFO - 1500417460922 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:40 INFO - 1500417460922 Marionette TRACE 378 <- [1,3,null,{}]
15:37:40 INFO - 1500417460923 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:40 INFO - 1500417460923 Marionette TRACE 378 <- [1,4,null,{}]
15:37:40 INFO - 1500417460925 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}]
15:37:40 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500417460927 Marionette TRACE 378 <- [1,5,null,{"value":null}]
15:37:40 INFO - 1500417460928 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
15:37:40 INFO - 1500417460930 Marionette TRACE 378 <- [1,6,null,{}]
15:37:40 INFO - 1500417460932 Marionette DEBUG Closed connection 378
15:37:40 INFO - 1500417460932 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49783
15:37:40 INFO - 1500417460933 Marionette DEBUG Closed connection 379
15:37:40 INFO - 1500417460934 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49784
15:37:40 INFO - 1500417460936 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:40 INFO - 1500417460936 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460939 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460942 Marionette TRACE 380 <- [1,1,null,{"sessionId":"fbcdf8f8-e7e9-4b58-8ab7-bc570c0af2c1","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460944 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
15:37:40 INFO - 1500417460945 Marionette TRACE 380 <- [1,2,null,{}]
15:37:40 INFO - 1500417460947 Marionette DEBUG Closed connection 380
15:37:40 INFO - 1500417460948 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49785
15:37:40 INFO - 1500417460949 Marionette DEBUG Closed connection 381
15:37:40 INFO - 1500417460950 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49786
15:37:40 INFO - 1500417460951 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:40 INFO - 1500417460952 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:40 INFO - 1500417460954 Marionette DEBUG Register listener.js for window 15
15:37:40 INFO - 1500417460957 Marionette TRACE 382 <- [1,1,null,{"sessionId":"269aa775-a1c8-4991-813c-2430bf256da9","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:40 INFO - 1500417460960 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"}]
15:37:40 INFO - 1500417460961 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"
15:37:40 INFO - 1500417460963 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"
15:37:40 INFO - 1500417460964 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"
15:37:40 INFO - 1500417460982 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"
15:37:40 INFO - 1500417460985 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"
15:37:41 INFO - 1500417460994 Marionette TRACE 382 <- [1,2,null,{}]
15:37:41 INFO - 1500417460995 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
15:37:41 INFO - 1500417460997 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ebd6b7cb-146d-4731-9f66-357e228b0410","ELEMENT":"ebd6b7cb-146d-4731-9f66-357e228b0410"}}]
15:37:41 INFO - 1500417460998 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"ebd6b7cb-146d-4731-9f66-357e228b0410"}]
15:37:41 INFO - 1500417461243 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:37:41 INFO - 1500417461244 Marionette TRACE 382 <- [1,4,null,{}]
15:37:41 INFO - 1500417461250 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}]
15:37:41 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500417461254 Marionette TRACE 382 <- [1,5,null,{"value":null}]
15:37:41 INFO - 1500417461256 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
15:37:41 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 353ms
15:37:41 INFO - TEST-START | test_click.py TestClick.test_input_file
15:37:41 INFO - 1500417461259 Marionette TRACE 382 <- [1,6,null,{}]
15:37:41 INFO - 1500417461309 Marionette DEBUG Closed connection 382
15:37:41 INFO - 1500417461310 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49787
15:37:41 INFO - 1500417461311 Marionette DEBUG Closed connection 383
15:37:41 INFO - 1500417461312 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49788
15:37:41 INFO - 1500417461314 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:41 INFO - 1500417461317 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461320 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461326 Marionette TRACE 384 <- [1,1,null,{"sessionId":"be43d22d-c2eb-4227-9ef4-9c987033fd98","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461402 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
15:37:41 INFO - 1500417461404 Marionette TRACE 384 <- [1,2,null,{}]
15:37:41 INFO - 1500417461405 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:41 INFO - 1500417461407 Marionette TRACE 384 <- [1,3,null,{}]
15:37:41 INFO - 1500417461408 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:41 INFO - 1500417461410 Marionette TRACE 384 <- [1,4,null,{}]
15:37:41 INFO - 1500417461412 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}]
15:37:41 INFO - TEST-START: test_click.py TestClick.test_input_file1500417461416 Marionette TRACE 384 <- [1,5,null,{"value":null}]
15:37:41 INFO - 1500417461418 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
15:37:41 INFO - 1500417461421 Marionette TRACE 384 <- [1,6,null,{}]
15:37:41 INFO - 1500417461435 Marionette DEBUG Closed connection 384
15:37:41 INFO - 1500417461436 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49789
15:37:41 INFO - 1500417461441 Marionette DEBUG Closed connection 385
15:37:41 INFO - 1500417461441 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49790
15:37:41 INFO - 1500417461443 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:41 INFO - 1500417461446 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461449 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461455 Marionette TRACE 386 <- [1,1,null,{"sessionId":"f339f8b6-e4d1-4f69-98a1-5accc51b2ba9","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461459 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
15:37:41 INFO - 1500417461462 Marionette TRACE 386 <- [1,2,null,{}]
15:37:41 INFO - 1500417461465 Marionette DEBUG Closed connection 386
15:37:41 INFO - 1500417461466 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49791
15:37:41 INFO - 1500417461467 Marionette DEBUG Closed connection 387
15:37:41 INFO - 1500417461467 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49792
15:37:41 INFO - 1500417461470 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:41 INFO - 1500417461471 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461474 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461479 Marionette TRACE 388 <- [1,1,null,{"sessionId":"c6b899f2-05a4-4c64-ac49-e21a71251fdc","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461481 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
15:37:41 INFO - 1500417461484 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"
15:37:41 INFO - 1500417461487 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"
15:37:41 INFO - 1500417461488 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"
15:37:41 INFO - 1500417461511 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:37:41 INFO - 1500417461515 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:37:41 INFO - 1500417461520 Marionette TRACE 388 <- [1,2,null,{}]
15:37:41 INFO - 1500417461527 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
15:37:41 INFO - 1500417461531 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bdea93ba-109d-4f4e-a4bb-0e89ada5cdfd","ELEMENT":"bdea93ba-109d-4f4e-a4bb-0e89ada5cdfd"}}]
15:37:41 INFO - 1500417461534 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"bdea93ba-109d-4f4e-a4bb-0e89ada5cdfd"}]
15:37:41 INFO - 1500417461578 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
15:37:41 INFO - 1500417461581 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}]
15:37:41 INFO - TEST-END: test_click.py TestClick.test_input_file1500417461585 Marionette TRACE 388 <- [1,5,null,{"value":null}]
15:37:41 INFO - 1500417461586 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
15:37:41 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 329ms
15:37:41 INFO - TEST-START | test_click.py TestClick.test_obscured_element
15:37:41 INFO - 1500417461589 Marionette TRACE 388 <- [1,6,null,{}]
15:37:41 INFO - 1500417461591 Marionette DEBUG Closed connection 388
15:37:41 INFO - 1500417461592 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49793
15:37:41 INFO - 1500417461593 Marionette DEBUG Closed connection 389
15:37:41 INFO - 1500417461594 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49794
15:37:41 INFO - 1500417461595 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:41 INFO - 1500417461596 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461599 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461603 Marionette TRACE 390 <- [1,1,null,{"sessionId":"2308658f-d073-4724-a705-2bdff15e0565","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461606 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
15:37:41 INFO - 1500417461607 Marionette TRACE 390 <- [1,2,null,{}]
15:37:41 INFO - 1500417461608 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:41 INFO - 1500417461608 Marionette TRACE 390 <- [1,3,null,{}]
15:37:41 INFO - 1500417461609 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:41 INFO - 1500417461610 Marionette TRACE 390 <- [1,4,null,{}]
15:37:41 INFO - 1500417461612 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}]
15:37:41 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500417461624 Marionette TRACE 390 <- [1,5,null,{"value":null}]
15:37:41 INFO - 1500417461654 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
15:37:41 INFO - 1500417461656 Marionette TRACE 390 <- [1,6,null,{}]
15:37:41 INFO - 1500417461659 Marionette DEBUG Closed connection 390
15:37:41 INFO - 1500417461660 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49795
15:37:41 INFO - 1500417461661 Marionette DEBUG Closed connection 391
15:37:41 INFO - 1500417461663 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49796
15:37:41 INFO - 1500417461664 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:41 INFO - 1500417461665 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461669 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461674 Marionette TRACE 392 <- [1,1,null,{"sessionId":"51042081-2534-44cd-984c-174893d0e73d","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461680 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
15:37:41 INFO - 1500417461682 Marionette TRACE 392 <- [1,2,null,{}]
15:37:41 INFO - 1500417461685 Marionette DEBUG Closed connection 392
15:37:41 INFO - 1500417461686 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49797
15:37:41 INFO - 1500417461687 Marionette DEBUG Closed connection 393
15:37:41 INFO - 1500417461688 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49798
15:37:41 INFO - 1500417461689 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:41 INFO - 1500417461691 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:41 INFO - 1500417461694 Marionette DEBUG Register listener.js for window 15
15:37:41 INFO - 1500417461699 Marionette TRACE 394 <- [1,1,null,{"sessionId":"14f6727f-f0e5-4447-b339-3a285da76ff1","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:41 INFO - 1500417461705 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"}]
15:37:41 INFO - 1500417461707 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:37:41 INFO - 1500417461710 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:37:41 INFO - 1500417461710 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:37:41 INFO - 1500417461737 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"
15:37:41 INFO - 1500417461739 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"
15:37:41 INFO - 1500417461744 Marionette TRACE 394 <- [1,2,null,{}]
15:37:41 INFO - 1500417461745 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
15:37:41 INFO - 1500417461748 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9489113d-0f8e-47c1-821e-2d231c7e3a7c","ELEMENT":"9489113d-0f8e-47c1-821e-2d231c7e3a7c"}}]
15:37:41 INFO - 1500417461749 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
15:37:41 INFO - 1500417461758 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"46dbda06-599a-42a8-a1d4-c9544e519026","ELEMENT":"46dbda06-599a-42a8-a1d4-c9544e519026"}}]
15:37:41 INFO - 1500417461759 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"9489113d-0f8e-47c1-821e-2d231c7e3a7c"}]
15:37:42 INFO - 1500417462002 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:37:42 INFO - 1500417462003 Marionette TRACE 394 <- [1,5,null,{}]
15:37:42 INFO - 1500417462004 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"46dbda06-599a-42a8-a1d4-c9544e519026"}]
15:37:42 INFO - 1500417462023 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
15:37:42 INFO - 1500417462025 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
15:37:42 INFO - 1500417462028 Marionette TRACE 394 <- [1,7,null,{"value":false}]
15:37:42 INFO - 1500417462030 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}]
15:37:42 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500417462032 Marionette TRACE 394 <- [1,8,null,{"value":null}]
15:37:42 INFO - 1500417462033 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
15:37:42 INFO - 1500417462035 Marionette TRACE 394 <- [1,9,null,{}]
15:37:42 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 447ms
15:37:42 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
15:37:42 INFO - 1500417462038 Marionette DEBUG Closed connection 394
15:37:42 INFO - 1500417462040 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49799
15:37:42 INFO - 1500417462041 Marionette DEBUG Closed connection 395
15:37:42 INFO - 1500417462042 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49800
15:37:42 INFO - 1500417462043 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:42 INFO - 1500417462044 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:42 INFO - 1500417462047 Marionette DEBUG Register listener.js for window 15
15:37:42 INFO - 1500417462052 Marionette TRACE 396 <- [1,1,null,{"sessionId":"58e9ad2b-38e1-4619-87a4-6b2615659367","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:42 INFO - 1500417462054 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
15:37:42 INFO - 1500417462054 Marionette TRACE 396 <- [1,2,null,{}]
15:37:42 INFO - 1500417462056 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:37:42 INFO - 1500417462056 Marionette TRACE 396 <- [1,3,null,{}]
15:37:42 INFO - 1500417462057 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
15:37:42 INFO - 1500417462058 Marionette TRACE 396 <- [1,4,null,{}]
15:37:42 INFO - 1500417462060 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}]
15:37:42 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500417462063 Marionette TRACE 396 <- [1,5,null,{"value":null}]
15:37:42 INFO - 1500417462064 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
15:37:42 INFO - 1500417462065 Marionette TRACE 396 <- [1,6,null,{}]
15:37:42 INFO - 1500417462068 Marionette DEBUG Closed connection 396
15:37:42 INFO - 1500417462068 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49801
15:37:42 INFO - 1500417462069 Marionette DEBUG Closed connection 397
15:37:42 INFO - 1500417462070 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49802
15:37:42 INFO - 1500417462071 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:37:42 INFO - 1500417462072 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:42 INFO - 1500417462074 Marionette DEBUG Register listener.js for window 15
15:37:42 INFO - 1500417462078 Marionette TRACE 398 <- [1,1,null,{"sessionId":"0d236898-63fc-4dd6-b7bf-2248720a738b","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:42 INFO - 1500417462080 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
15:37:42 INFO - 1500417462082 Marionette TRACE 398 <- [1,2,null,{}]
15:37:42 INFO - 1500417462084 Marionette DEBUG Closed connection 398
15:37:42 INFO - 1500417462085 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49803
15:37:42 INFO - 1500417462086 Marionette DEBUG Closed connection 399
15:37:42 INFO - 1500417462087 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49804
15:37:42 INFO - 1500417462088 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:37:42 INFO - 1500417462089 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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}
15:37:42 INFO - 1500417462092 Marionette DEBUG Register listener.js for window 15
15:37:42 INFO - 1500417462095 Marionette TRACE 400 <- [1,1,null,{"sessionId":"84254cde-9814-4430-9734-f309295265fe","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":4812,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-051.001\\AppData\\Local\\Temp\\tmpoblvuv.mozrunner","moz:accessibilityChecks":false}}]
15:37:42 INFO - 1500417462098 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"}]
15:37:42 INFO - 1500417462099 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"
15:37:42 INFO - 1500417462102 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"
15:37:42 INFO - 1500417462102 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"
15:37:42 INFO - 1500417462117 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"
15:37:42 INFO - 1500417462121 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"
15:37:42 INFO - 1500417462132 Marionette TRACE 400 <- [1,2,null,{}]
15:37:42 INFO - 1500417462134 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
15:37:42 INFO - 1500417462137 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f7bf0d1c-57aa-4fee-b05f-dde436b0f971","ELEMENT":"f7bf0d1c-57aa-4fee-b05f-dde436b0f971"}}]
15:37:42 INFO - 1500417462138 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"f7bf0d1c-57aa-4fee-b05f-dde436b0f971"}]
15:37:42 INFO - 1500417462164 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
15:37:42 INFO - 1500417462165 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"f7bf0d1c-57aa-4fee-b05f-dde436b0f971"}]
15:37:42 INFO - 1500417462182 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element