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]
06:07:51 INFO - 1500556071782 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}]
06:07:51 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500556071785 Marionette TRACE 352 <- [1,5,null,{"value":null}]
06:07:51 INFO - 1500556071786 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
06:07:51 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 148ms
06:07:51 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
06:07:51 INFO - 1500556071787 Marionette TRACE 352 <- [1,6,null,{}]
06:07:51 INFO - 1500556071789 Marionette DEBUG Closed connection 352
06:07:51 INFO - 1500556071790 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49762
06:07:51 INFO - 1500556071790 Marionette DEBUG Closed connection 353
06:07:51 INFO - 1500556071791 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49763
06:07:51 INFO - 1500556071792 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:51 INFO - 1500556071793 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:51 INFO - 1500556071795 Marionette DEBUG Register listener.js for window 6442450945
06:07:51 INFO - 1500556071799 Marionette TRACE 354 <- [1,1,null,{"sessionId":"8d6821ea-6b62-4a65-99e0-b2f04611391f","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:51 INFO - 1500556071800 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
06:07:51 INFO - 1500556071801 Marionette TRACE 354 <- [1,2,null,{}]
06:07:51 INFO - 1500556071801 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:51 INFO - 1500556071802 Marionette TRACE 354 <- [1,3,null,{}]
06:07:51 INFO - 1500556071803 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:51 INFO - 1500556071803 Marionette TRACE 354 <- [1,4,null,{}]
06:07:51 INFO - 1500556071806 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}]
06:07:51 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500556071808 Marionette TRACE 354 <- [1,5,null,{"value":null}]
06:07:51 INFO - 1500556071809 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
06:07:51 INFO - 1500556071811 Marionette TRACE 354 <- [1,6,null,{}]
06:07:51 INFO - 1500556071812 Marionette DEBUG Closed connection 354
06:07:51 INFO - 1500556071813 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49764
06:07:51 INFO - 1500556071813 Marionette DEBUG Closed connection 355
06:07:51 INFO - 1500556071814 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49765
06:07:51 INFO - 1500556071815 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:51 INFO - 1500556071816 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:51 INFO - 1500556071819 Marionette DEBUG Register listener.js for window 6442450945
06:07:51 INFO - 1500556071822 Marionette TRACE 356 <- [1,1,null,{"sessionId":"b0ee4954-5b08-41f3-ba4b-2407e6023313","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:51 INFO - 1500556071823 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
06:07:51 INFO - 1500556071824 Marionette TRACE 356 <- [1,2,null,{}]
06:07:51 INFO - 1500556071826 Marionette DEBUG Closed connection 356
06:07:51 INFO - 1500556071827 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49766
06:07:51 INFO - 1500556071827 Marionette DEBUG Closed connection 357
06:07:51 INFO - 1500556071828 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49767
06:07:51 INFO - 1500556071829 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:51 INFO - 1500556071830 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:51 INFO - 1500556071833 Marionette DEBUG Register listener.js for window 6442450945
06:07:51 INFO - 1500556071836 Marionette TRACE 358 <- [1,1,null,{"sessionId":"3f338efc-85d9-4cd0-bf8f-732adeef9b9e","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:51 INFO - 1500556071837 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49326/clicks.html"}]
06:07:51 INFO - 1500556071839 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49326/hidden.html"
06:07:51 INFO - 1500556071847 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49326/hidden.html"
06:07:51 INFO - 1500556071847 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49326/hidden.html"
06:07:51 INFO - 1500556071853 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49326/clicks.html"
06:07:51 INFO - 1500556071859 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49326/clicks.html"
06:07:51 INFO - 1500556071876 Marionette TRACE 358 <- [1,2,null,{}]
06:07:51 INFO - 1500556071883 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
06:07:51 INFO - 1500556071886 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7abcbe0d-5e2e-4589-8e80-7c39fdeb7ece","ELEMENT":"7abcbe0d-5e2e-4589-8e80-7c39fdeb7ece"}}]
06:07:51 INFO - 1500556071887 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"7abcbe0d-5e2e-4589-8e80-7c39fdeb7ece"}]
06:07:51 INFO - 1500556071935 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49326/clicks.html"
06:07:51 INFO - 1500556071942 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49326/clicks.html"
06:07:51 INFO - 1500556071942 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49326/clicks.html"
06:07:51 INFO - 1500556071950 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49326/test.html"
06:07:51 INFO - 1500556071953 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49326/test.html"
06:07:51 INFO - 1500556071956 Marionette TRACE 358 <- [1,4,null,{}]
06:07:51 INFO - 1500556071964 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
06:07:51 INFO - 1500556071967 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c59361d8-b0e0-4d37-8441-aa63996fd92a","ELEMENT":"c59361d8-b0e0-4d37-8441-aa63996fd92a"}}]
06:07:51 INFO - 1500556071968 Marionette TRACE 358 -> [0,6,"getTitle",{}]
06:07:51 INFO - 1500556071969 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
06:07:51 INFO - 1500556071970 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}]
06:07:51 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500556071974 Marionette TRACE 358 <- [1,7,null,{"value":null}]
06:07:51 INFO - 1500556071975 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
06:07:51 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 192ms
06:07:51 INFO - TEST-START | test_click.py TestClick.test_container_element
06:07:51 INFO - 1500556071978 Marionette TRACE 358 <- [1,8,null,{}]
06:07:51 INFO - 1500556071981 Marionette DEBUG Closed connection 358
06:07:51 INFO - 1500556071982 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49770
06:07:51 INFO - 1500556071983 Marionette DEBUG Closed connection 359
06:07:51 INFO - 1500556071983 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49771
06:07:51 INFO - 1500556071985 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:51 INFO - 1500556071985 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:51 INFO - 1500556071988 Marionette DEBUG Register listener.js for window 6442450945
06:07:51 INFO - 1500556071992 Marionette TRACE 360 <- [1,1,null,{"sessionId":"85beb13a-1de3-45fa-b937-fee6e7b21097","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:51 INFO - 1500556071994 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
06:07:51 INFO - 1500556071994 Marionette TRACE 360 <- [1,2,null,{}]
06:07:52 INFO - 1500556071995 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:52 INFO - 1500556071996 Marionette TRACE 360 <- [1,3,null,{}]
06:07:52 INFO - 1500556071997 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:52 INFO - 1500556071998 Marionette TRACE 360 <- [1,4,null,{}]
06:07:52 INFO - 1500556071999 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}]
06:07:52 INFO - TEST-START: test_click.py TestClick.test_container_element1500556072002 Marionette TRACE 360 <- [1,5,null,{"value":null}]
06:07:52 INFO - 1500556072003 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
06:07:52 INFO - 1500556072004 Marionette TRACE 360 <- [1,6,null,{}]
06:07:52 INFO - 1500556072006 Marionette DEBUG Closed connection 360
06:07:52 INFO - 1500556072007 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49772
06:07:52 INFO - 1500556072007 Marionette DEBUG Closed connection 361
06:07:52 INFO - 1500556072008 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49773
06:07:52 INFO - 1500556072009 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:52 INFO - 1500556072010 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072013 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072016 Marionette TRACE 362 <- [1,1,null,{"sessionId":"999268e6-b5e9-41c6-a391-686e45e81d58","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072017 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
06:07:52 INFO - 1500556072019 Marionette TRACE 362 <- [1,2,null,{}]
06:07:52 INFO - 1500556072020 Marionette DEBUG Closed connection 362
06:07:52 INFO - 1500556072021 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49774
06:07:52 INFO - 1500556072022 Marionette DEBUG Closed connection 363
06:07:52 INFO - 1500556072022 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49775
06:07:52 INFO - 1500556072024 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:52 INFO - 1500556072024 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072027 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072031 Marionette TRACE 364 <- [1,1,null,{"sessionId":"bec6fa63-dff3-4455-ad10-c7c5796bf51a","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072032 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"}]
06:07:52 INFO - 1500556072034 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49326/test.html"
06:07:52 INFO - 1500556072038 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49326/test.html"
06:07:52 INFO - 1500556072038 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49326/test.html"
06:07:52 INFO - 1500556072046 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"
06:07:52 INFO - 1500556072052 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"
06:07:52 INFO - 1500556072053 Marionette TRACE 364 <- [1,2,null,{}]
06:07:52 INFO - 1500556072055 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
06:07:52 INFO - 1500556072063 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"59fd6c77-1b4b-4245-b4f9-6975f4f643a2","ELEMENT":"59fd6c77-1b4b-4245-b4f9-6975f4f643a2"}}]
06:07:52 INFO - 1500556072064 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"59fd6c77-1b4b-4245-b4f9-6975f4f643a2"}]
06:07:52 INFO - 1500556072309 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:07:52 INFO - 1500556072310 Marionette TRACE 364 <- [1,4,null,{}]
06:07:52 INFO - 1500556072311 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"59fd6c77-1b4b-4245-b4f9-6975f4f643a2","name":"selected"}]
06:07:52 INFO - 1500556072316 Marionette TRACE 364 <- [1,5,null,{"value":true}]
06:07:52 INFO - 1500556072318 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}]
06:07:52 INFO - TEST-END: test_click.py TestClick.test_container_element1500556072321 Marionette TRACE 364 <- [1,6,null,{"value":null}]
06:07:52 INFO - 1500556072322 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
06:07:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 343ms
06:07:52 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
06:07:52 INFO - 1500556072323 Marionette TRACE 364 <- [1,7,null,{}]
06:07:52 INFO - 1500556072325 Marionette DEBUG Closed connection 364
06:07:52 INFO - 1500556072325 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49776
06:07:52 INFO - 1500556072326 Marionette DEBUG Closed connection 365
06:07:52 INFO - 1500556072327 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49777
06:07:52 INFO - 1500556072328 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:52 INFO - 1500556072329 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072332 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072335 Marionette TRACE 366 <- [1,1,null,{"sessionId":"b915638b-7c09-41e8-a41b-307314abff85","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072336 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
06:07:52 INFO - 1500556072337 Marionette TRACE 366 <- [1,2,null,{}]
06:07:52 INFO - 1500556072338 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:52 INFO - 1500556072338 Marionette TRACE 366 <- [1,3,null,{}]
06:07:52 INFO - 1500556072339 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:52 INFO - 1500556072340 Marionette TRACE 366 <- [1,4,null,{}]
06:07:52 INFO - 1500556072341 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}]
06:07:52 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500556072344 Marionette TRACE 366 <- [1,5,null,{"value":null}]
06:07:52 INFO - 1500556072345 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
06:07:52 INFO - 1500556072347 Marionette TRACE 366 <- [1,6,null,{}]
06:07:52 INFO - 1500556072349 Marionette DEBUG Closed connection 366
06:07:52 INFO - 1500556072349 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49778
06:07:52 INFO - 1500556072350 Marionette DEBUG Closed connection 367
06:07:52 INFO - 1500556072351 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49779
06:07:52 INFO - 1500556072351 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:52 INFO - 1500556072352 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072360 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072364 Marionette TRACE 368 <- [1,1,null,{"sessionId":"07eaf344-3f3e-4dce-bfbb-e2ab11839a20","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072365 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
06:07:52 INFO - 1500556072367 Marionette TRACE 368 <- [1,2,null,{}]
06:07:52 INFO - 1500556072369 Marionette DEBUG Closed connection 368
06:07:52 INFO - 1500556072369 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49780
06:07:52 INFO - 1500556072370 Marionette DEBUG Closed connection 369
06:07:52 INFO - 1500556072371 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49781
06:07:52 INFO - 1500556072372 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:52 INFO - 1500556072373 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072376 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072379 Marionette TRACE 370 <- [1,1,null,{"sessionId":"08443738-beb7-4ced-aa36-a78c3f47df2d","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072380 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"}]
06:07:52 INFO - 1500556072382 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"
06:07:52 INFO - 1500556072384 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"
06:07:52 INFO - 1500556072384 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"
06:07:52 INFO - 1500556072396 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"
06:07:52 INFO - 1500556072398 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"
06:07:52 INFO - 1500556072406 Marionette TRACE 370 <- [1,2,null,{}]
06:07:52 INFO - 1500556072413 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
06:07:52 INFO - 1500556072418 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"13b1ea96-6c44-49eb-9894-99ffd48760b1","ELEMENT":"13b1ea96-6c44-49eb-9894-99ffd48760b1"}}]
06:07:52 INFO - 1500556072420 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"13b1ea96-6c44-49eb-9894-99ffd48760b1"}]
06:07:52 INFO - 1500556072663 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:07:52 INFO - 1500556072664 Marionette TRACE 370 <- [1,4,null,{}]
06:07:52 INFO - 1500556072665 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"13b1ea96-6c44-49eb-9894-99ffd48760b1","name":"selected"}]
06:07:52 INFO - 1500556072670 Marionette TRACE 370 <- [1,5,null,{"value":true}]
06:07:52 INFO - 1500556072672 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}]
06:07:52 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500556072675 Marionette TRACE 370 <- [1,6,null,{"value":null}]
06:07:52 INFO - 1500556072676 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
06:07:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 353ms
06:07:52 INFO - TEST-START | test_click.py TestClick.test_css_transforms
06:07:52 INFO - 1500556072677 Marionette TRACE 370 <- [1,7,null,{}]
06:07:52 INFO - 1500556072679 Marionette DEBUG Closed connection 370
06:07:52 INFO - 1500556072679 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49782
06:07:52 INFO - 1500556072680 Marionette DEBUG Closed connection 371
06:07:52 INFO - 1500556072681 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49783
06:07:52 INFO - 1500556072682 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:52 INFO - 1500556072682 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072685 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072689 Marionette TRACE 372 <- [1,1,null,{"sessionId":"60cc3e67-e3e2-468f-a52b-64f61e5203ae","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072690 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
06:07:52 INFO - 1500556072690 Marionette TRACE 372 <- [1,2,null,{}]
06:07:52 INFO - 1500556072691 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:52 INFO - 1500556072692 Marionette TRACE 372 <- [1,3,null,{}]
06:07:52 INFO - 1500556072693 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:52 INFO - 1500556072694 Marionette TRACE 372 <- [1,4,null,{}]
06:07:52 INFO - 1500556072696 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}]
06:07:52 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500556072698 Marionette TRACE 372 <- [1,5,null,{"value":null}]
06:07:52 INFO - 1500556072699 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
06:07:52 INFO - 1500556072701 Marionette TRACE 372 <- [1,6,null,{}]
06:07:52 INFO - 1500556072702 Marionette DEBUG Closed connection 372
06:07:52 INFO - 1500556072703 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49784
06:07:52 INFO - 1500556072703 Marionette DEBUG Closed connection 373
06:07:52 INFO - 1500556072704 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49785
06:07:52 INFO - 1500556072705 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:52 INFO - 1500556072706 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072714 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072718 Marionette TRACE 374 <- [1,1,null,{"sessionId":"1cf9a034-fd9f-4626-84ed-247bc7a2a9e9","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072719 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
06:07:52 INFO - 1500556072721 Marionette TRACE 374 <- [1,2,null,{}]
06:07:52 INFO - 1500556072722 Marionette DEBUG Closed connection 374
06:07:52 INFO - 1500556072723 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49786
06:07:52 INFO - 1500556072724 Marionette DEBUG Closed connection 375
06:07:52 INFO - 1500556072725 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49787
06:07:52 INFO - 1500556072726 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:52 INFO - 1500556072727 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:52 INFO - 1500556072729 Marionette DEBUG Register listener.js for window 6442450945
06:07:52 INFO - 1500556072733 Marionette TRACE 376 <- [1,1,null,{"sessionId":"df862acb-6408-402d-bc17-d80aaf8c1e9c","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:52 INFO - 1500556072734 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"}]
06:07:52 INFO - 1500556072736 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"
06:07:52 INFO - 1500556072738 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"
06:07:52 INFO - 1500556072739 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"
06:07:52 INFO - 1500556072745 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"
06:07:52 INFO - 1500556072748 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"
06:07:52 INFO - 1500556072753 Marionette TRACE 376 <- [1,2,null,{}]
06:07:52 INFO - 1500556072757 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
06:07:52 INFO - 1500556072764 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5f535447-8ef1-4893-a79f-1deb81f61eb5","ELEMENT":"5f535447-8ef1-4893-a79f-1deb81f61eb5"}}]
06:07:52 INFO - 1500556072765 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"5f535447-8ef1-4893-a79f-1deb81f61eb5"}]
06:07:53 INFO - 1500556073005 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:07:53 INFO - 1500556073007 Marionette TRACE 376 <- [1,4,null,{}]
06:07:53 INFO - 1500556073008 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}]
06:07:53 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500556073011 Marionette TRACE 376 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073012 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
06:07:53 INFO - 1500556073014 Marionette TRACE 376 <- [1,6,null,{}]
06:07:53 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 336ms
06:07:53 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
06:07:53 INFO - 1500556073016 Marionette DEBUG Closed connection 376
06:07:53 INFO - 1500556073017 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49788
06:07:53 INFO - 1500556073018 Marionette DEBUG Closed connection 377
06:07:53 INFO - 1500556073018 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49789
06:07:53 INFO - 1500556073019 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073020 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073023 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073033 Marionette TRACE 378 <- [1,1,null,{"sessionId":"c6749b0d-c315-4194-9b98-fd3fcd6e772e","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073035 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
06:07:53 INFO - 1500556073035 Marionette TRACE 378 <- [1,2,null,{}]
06:07:53 INFO - 1500556073036 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:53 INFO - 1500556073037 Marionette TRACE 378 <- [1,3,null,{}]
06:07:53 INFO - 1500556073038 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:53 INFO - 1500556073038 Marionette TRACE 378 <- [1,4,null,{}]
06:07:53 INFO - 1500556073039 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}]
06:07:53 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500556073042 Marionette TRACE 378 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073043 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
06:07:53 INFO - 1500556073045 Marionette TRACE 378 <- [1,6,null,{}]
06:07:53 INFO - 1500556073046 Marionette DEBUG Closed connection 378
06:07:53 INFO - 1500556073047 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49790
06:07:53 INFO - 1500556073048 Marionette DEBUG Closed connection 379
06:07:53 INFO - 1500556073049 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49791
06:07:53 INFO - 1500556073050 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073051 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073054 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073057 Marionette TRACE 380 <- [1,1,null,{"sessionId":"53a664a6-212a-44fe-9611-308123f150b4","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073058 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
06:07:53 INFO - 1500556073060 Marionette TRACE 380 <- [1,2,null,{}]
06:07:53 INFO - 1500556073061 Marionette DEBUG Closed connection 380
06:07:53 INFO - 1500556073062 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49792
06:07:53 INFO - 1500556073063 Marionette DEBUG Closed connection 381
06:07:53 INFO - 1500556073064 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49793
06:07:53 INFO - 1500556073065 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:53 INFO - 1500556073066 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073068 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073072 Marionette TRACE 382 <- [1,1,null,{"sessionId":"1677cd45-56c5-4637-a372-9c88ee41ab3d","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073074 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"}]
06:07:53 INFO - 1500556073076 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"
06:07:53 INFO - 1500556073077 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"
06:07:53 INFO - 1500556073077 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"
06:07:53 INFO - 1500556073085 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"
06:07:53 INFO - 1500556073088 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"
06:07:53 INFO - 1500556073090 Marionette TRACE 382 <- [1,2,null,{}]
06:07:53 INFO - 1500556073098 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
06:07:53 INFO - 1500556073100 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fe0d8e81-18df-42d6-88ca-0dc3c2a1c7d8","ELEMENT":"fe0d8e81-18df-42d6-88ca-0dc3c2a1c7d8"}}]
06:07:53 INFO - 1500556073101 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"fe0d8e81-18df-42d6-88ca-0dc3c2a1c7d8"}]
06:07:53 INFO - 1500556073350 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:07:53 INFO - 1500556073351 Marionette TRACE 382 <- [1,4,null,{}]
06:07:53 INFO - 1500556073352 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}]
06:07:53 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500556073402 Marionette TRACE 382 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073403 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
06:07:53 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 389ms
06:07:53 INFO - 1500556073404 Marionette TRACE 382 <- [1,6,null,{}]
06:07:53 INFO - TEST-START | test_click.py TestClick.test_input_file
06:07:53 INFO - 1500556073406 Marionette DEBUG Closed connection 382
06:07:53 INFO - 1500556073407 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49794
06:07:53 INFO - 1500556073408 Marionette DEBUG Closed connection 383
06:07:53 INFO - 1500556073408 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49795
06:07:53 INFO - 1500556073409 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073410 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073452 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073456 Marionette TRACE 384 <- [1,1,null,{"sessionId":"6d473e40-6188-4970-a535-fca3f490b920","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073457 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
06:07:53 INFO - 1500556073458 Marionette TRACE 384 <- [1,2,null,{}]
06:07:53 INFO - 1500556073459 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:53 INFO - 1500556073460 Marionette TRACE 384 <- [1,3,null,{}]
06:07:53 INFO - 1500556073461 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:53 INFO - 1500556073461 Marionette TRACE 384 <- [1,4,null,{}]
06:07:53 INFO - 1500556073463 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}]
06:07:53 INFO - TEST-START: test_click.py TestClick.test_input_file1500556073465 Marionette TRACE 384 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073466 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
06:07:53 INFO - 1500556073468 Marionette TRACE 384 <- [1,6,null,{}]
06:07:53 INFO - 1500556073470 Marionette DEBUG Closed connection 384
06:07:53 INFO - 1500556073470 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49796
06:07:53 INFO - 1500556073471 Marionette DEBUG Closed connection 385
06:07:53 INFO - 1500556073472 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49797
06:07:53 INFO - 1500556073473 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073473 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073477 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073480 Marionette TRACE 386 <- [1,1,null,{"sessionId":"942a70bf-1b59-47b6-80f4-0e611cc6299c","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073481 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
06:07:53 INFO - 1500556073483 Marionette TRACE 386 <- [1,2,null,{}]
06:07:53 INFO - 1500556073484 Marionette DEBUG Closed connection 386
06:07:53 INFO - 1500556073485 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49798
06:07:53 INFO - 1500556073486 Marionette DEBUG Closed connection 387
06:07:53 INFO - 1500556073487 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49799
06:07:53 INFO - 1500556073488 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:53 INFO - 1500556073488 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073492 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073496 Marionette TRACE 388 <- [1,1,null,{"sessionId":"f5fc414b-6151-47ef-b945-85257741e275","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073497 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
06:07:53 INFO - 1500556073499 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"
06:07:53 INFO - 1500556073501 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"
06:07:53 INFO - 1500556073502 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"
06:07:53 INFO - 1500556073511 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:07:53 INFO - 1500556073513 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:07:53 INFO - 1500556073518 Marionette TRACE 388 <- [1,2,null,{}]
06:07:53 INFO - 1500556073521 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
06:07:53 INFO - 1500556073524 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d814ab16-19eb-43fb-80f3-ff518f3f34d3","ELEMENT":"d814ab16-19eb-43fb-80f3-ff518f3f34d3"}}]
06:07:53 INFO - 1500556073528 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"d814ab16-19eb-43fb-80f3-ff518f3f34d3"}]
06:07:53 INFO - 1500556073557 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]
06:07:53 INFO - 1500556073559 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}]
06:07:53 INFO - TEST-END: test_click.py TestClick.test_input_file1500556073562 Marionette TRACE 388 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073563 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
06:07:53 INFO - 1500556073564 Marionette TRACE 388 <- [1,6,null,{}]
06:07:53 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 159ms
06:07:53 INFO - TEST-START | test_click.py TestClick.test_obscured_element
06:07:53 INFO - 1500556073566 Marionette DEBUG Closed connection 388
06:07:53 INFO - 1500556073567 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49800
06:07:53 INFO - 1500556073568 Marionette DEBUG Closed connection 389
06:07:53 INFO - 1500556073568 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49801
06:07:53 INFO - 1500556073569 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073570 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073573 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073576 Marionette TRACE 390 <- [1,1,null,{"sessionId":"ae328258-99f5-4831-8207-143fccc3d85a","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073577 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
06:07:53 INFO - 1500556073578 Marionette TRACE 390 <- [1,2,null,{}]
06:07:53 INFO - 1500556073579 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:53 INFO - 1500556073579 Marionette TRACE 390 <- [1,3,null,{}]
06:07:53 INFO - 1500556073580 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:53 INFO - 1500556073580 Marionette TRACE 390 <- [1,4,null,{}]
06:07:53 INFO - 1500556073582 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}]
06:07:53 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500556073584 Marionette TRACE 390 <- [1,5,null,{"value":null}]
06:07:53 INFO - 1500556073585 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
06:07:53 INFO - 1500556073587 Marionette TRACE 390 <- [1,6,null,{}]
06:07:53 INFO - 1500556073588 Marionette DEBUG Closed connection 390
06:07:53 INFO - 1500556073589 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49802
06:07:53 INFO - 1500556073589 Marionette DEBUG Closed connection 391
06:07:53 INFO - 1500556073590 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49803
06:07:53 INFO - 1500556073591 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073592 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073595 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073598 Marionette TRACE 392 <- [1,1,null,{"sessionId":"002529e5-4b8b-4391-9766-454a6d4c882f","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073599 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
06:07:53 INFO - 1500556073601 Marionette TRACE 392 <- [1,2,null,{}]
06:07:53 INFO - 1500556073603 Marionette DEBUG Closed connection 392
06:07:53 INFO - 1500556073603 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49804
06:07:53 INFO - 1500556073604 Marionette DEBUG Closed connection 393
06:07:53 INFO - 1500556073605 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49805
06:07:53 INFO - 1500556073606 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:53 INFO - 1500556073606 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073609 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073612 Marionette TRACE 394 <- [1,1,null,{"sessionId":"1a096b89-2436-4ffb-bef5-bb9d9d9a0c7e","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:53 INFO - 1500556073614 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"}]
06:07:53 INFO - 1500556073615 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:07:53 INFO - 1500556073617 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:07:53 INFO - 1500556073617 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
06:07:53 INFO - 1500556073624 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"
06:07:53 INFO - 1500556073627 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"
06:07:53 INFO - 1500556073634 Marionette TRACE 394 <- [1,2,null,{}]
06:07:53 INFO - 1500556073638 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
06:07:53 INFO - 1500556073640 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"53f3b2f2-aef1-4c88-8a64-8221370d48b7","ELEMENT":"53f3b2f2-aef1-4c88-8a64-8221370d48b7"}}]
06:07:53 INFO - 1500556073645 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
06:07:53 INFO - 1500556073647 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"546dcc58-ef4d-4bd9-97cf-95bf41dfa1c4","ELEMENT":"546dcc58-ef4d-4bd9-97cf-95bf41dfa1c4"}}]
06:07:53 INFO - 1500556073648 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"53f3b2f2-aef1-4c88-8a64-8221370d48b7"}]
06:07:53 INFO - 1500556073895 Marionette DEBUG Canceled page load listener because no navigation has been detected
06:07:53 INFO - 1500556073896 Marionette TRACE 394 <- [1,5,null,{}]
06:07:53 INFO - 1500556073897 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"546dcc58-ef4d-4bd9-97cf-95bf41dfa1c4"}]
06:07:53 INFO - 1500556073913 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]
06:07:53 INFO - 1500556073915 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
06:07:53 INFO - 1500556073918 Marionette TRACE 394 <- [1,7,null,{"value":false}]
06:07:53 INFO - 1500556073920 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}]
06:07:53 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500556073922 Marionette TRACE 394 <- [1,8,null,{"value":null}]
06:07:53 INFO - 1500556073923 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
06:07:53 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 359ms
06:07:53 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
06:07:53 INFO - 1500556073925 Marionette TRACE 394 <- [1,9,null,{}]
06:07:53 INFO - 1500556073926 Marionette DEBUG Closed connection 394
06:07:53 INFO - 1500556073927 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49806
06:07:53 INFO - 1500556073928 Marionette DEBUG Closed connection 395
06:07:53 INFO - 1500556073928 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49807
06:07:53 INFO - 1500556073929 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:53 INFO - 1500556073930 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:53 INFO - 1500556073933 Marionette DEBUG Register listener.js for window 6442450945
06:07:53 INFO - 1500556073936 Marionette TRACE 396 <- [1,1,null,{"sessionId":"a93d238c-6316-4e60-a3b0-dd6f21451034","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:54 INFO - 1500556073937 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
06:07:54 INFO - 1500556073938 Marionette TRACE 396 <- [1,2,null,{}]
06:07:54 INFO - 1500556073939 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
06:07:54 INFO - 1500556073939 Marionette TRACE 396 <- [1,3,null,{}]
06:07:54 INFO - 1500556073940 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
06:07:54 INFO - 1500556073941 Marionette TRACE 396 <- [1,4,null,{}]
06:07:54 INFO - 1500556073942 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}]
06:07:54 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500556073945 Marionette TRACE 396 <- [1,5,null,{"value":null}]
06:07:54 INFO - 1500556073946 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
06:07:54 INFO - 1500556073948 Marionette TRACE 396 <- [1,6,null,{}]
06:07:54 INFO - 1500556073949 Marionette DEBUG Closed connection 396
06:07:54 INFO - 1500556073950 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49808
06:07:54 INFO - 1500556073951 Marionette DEBUG Closed connection 397
06:07:54 INFO - 1500556073952 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49809
06:07:54 INFO - 1500556073953 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
06:07:54 INFO - 1500556073953 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:54 INFO - 1500556073956 Marionette DEBUG Register listener.js for window 6442450945
06:07:54 INFO - 1500556073960 Marionette TRACE 398 <- [1,1,null,{"sessionId":"6baff6b0-d460-4309-97de-da31b6ed72fa","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:54 INFO - 1500556073961 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
06:07:54 INFO - 1500556073962 Marionette TRACE 398 <- [1,2,null,{}]
06:07:54 INFO - 1500556073964 Marionette DEBUG Closed connection 398
06:07:54 INFO - 1500556073965 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49810
06:07:54 INFO - 1500556073965 Marionette DEBUG Closed connection 399
06:07:54 INFO - 1500556073966 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49811
06:07:54 INFO - 1500556073967 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
06:07:54 INFO - 1500556073968 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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}
06:07:54 INFO - 1500556073970 Marionette DEBUG Register listener.js for window 6442450945
06:07:54 INFO - 1500556073973 Marionette TRACE 400 <- [1,1,null,{"sessionId":"67c2d4c7-d776-404f-bdb3-007736c8aec3","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":796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-263.000\\AppData\\Local\\Temp\\tmppovn3v.mozrunner","moz:accessibilityChecks":false}}]
06:07:54 INFO - 1500556073975 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"}]
06:07:54 INFO - 1500556073977 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"
06:07:54 INFO - 1500556073979 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"
06:07:54 INFO - 1500556073979 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"
06:07:54 INFO - 1500556073987 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"
06:07:54 INFO - 1500556073989 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"
06:07:54 INFO - 1500556073997 Marionette TRACE 400 <- [1,2,null,{}]
06:07:54 INFO - 1500556074001 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
06:07:54 INFO - 1500556074003 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7c4058aa-7967-4a7d-9084-4d00615d61e2","ELEMENT":"7c4058aa-7967-4a7d-9084-4d00615d61e2"}}]
06:07:54 INFO - 1500556074004 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"7c4058aa-7967-4a7d-9084-4d00615d61e2"}]
06:07:54 INFO - 1500556074033 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
06:07:54 INFO - 1500556074035 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"7c4058aa-7967-4a7d-9084-4d00615d61e2"}]
06:07:54 INFO - 1500556074051 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element