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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:46:57 INFO - 1499716017785 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}]
12:46:57 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499716017787 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:46:57 INFO - 1499716017788 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:46:57 INFO - 1499716017789 Marionette TRACE 352 <- [1,6,null,{}]
12:46:57 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 154ms
12:46:57 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:46:57 INFO - 1499716017792 Marionette DEBUG Closed connection 352
12:46:57 INFO - 1499716017792 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49759
12:46:57 INFO - 1499716017793 Marionette DEBUG Closed connection 353
12:46:57 INFO - 1499716017794 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49760
12:46:57 INFO - 1499716017795 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:57 INFO - 1499716017795 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:57 INFO - 1499716017798 Marionette DEBUG Register listener.js for window 12
12:46:57 INFO - 1499716017801 Marionette TRACE 354 <- [1,1,null,{"sessionId":"ea77a15c-a2a0-4f7b-ba9b-c9aa8640d0e4","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:57 INFO - 1499716017804 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:46:57 INFO - 1499716017804 Marionette TRACE 354 <- [1,2,null,{}]
12:46:57 INFO - 1499716017805 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:57 INFO - 1499716017805 Marionette TRACE 354 <- [1,3,null,{}]
12:46:57 INFO - 1499716017806 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:57 INFO - 1499716017807 Marionette TRACE 354 <- [1,4,null,{}]
12:46:57 INFO - 1499716017808 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}]
12:46:57 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499716017811 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:46:57 INFO - 1499716017812 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:46:57 INFO - 1499716017813 Marionette TRACE 354 <- [1,6,null,{}]
12:46:57 INFO - 1499716017816 Marionette DEBUG Closed connection 354
12:46:57 INFO - 1499716017816 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49761
12:46:57 INFO - 1499716017817 Marionette DEBUG Closed connection 355
12:46:57 INFO - 1499716017818 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49762
12:46:57 INFO - 1499716017819 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:57 INFO - 1499716017819 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:57 INFO - 1499716017822 Marionette DEBUG Register listener.js for window 12
12:46:57 INFO - 1499716017825 Marionette TRACE 356 <- [1,1,null,{"sessionId":"bffe5fc5-4c30-4bf0-8c05-76963d83a51c","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:57 INFO - 1499716017827 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:46:57 INFO - 1499716017829 Marionette TRACE 356 <- [1,2,null,{}]
12:46:57 INFO - 1499716017831 Marionette DEBUG Closed connection 356
12:46:57 INFO - 1499716017831 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49763
12:46:57 INFO - 1499716017832 Marionette DEBUG Closed connection 357
12:46:57 INFO - 1499716017833 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49764
12:46:57 INFO - 1499716017834 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:57 INFO - 1499716017834 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:57 INFO - 1499716017837 Marionette DEBUG Register listener.js for window 12
12:46:57 INFO - 1499716017841 Marionette TRACE 358 <- [1,1,null,{"sessionId":"f5b99e66-956f-44ce-b72a-8d8f7f89469b","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:57 INFO - 1499716017843 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49330/clicks.html"}]
12:46:57 INFO - 1499716017844 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/hidden.html"
12:46:57 INFO - 1499716017850 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/hidden.html"
12:46:57 INFO - 1499716017850 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/hidden.html"
12:46:57 INFO - 1499716017877 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/clicks.html"
12:46:57 INFO - 1499716017879 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/clicks.html"
12:46:57 INFO - 1499716017882 Marionette TRACE 358 <- [1,2,null,{}]
12:46:57 INFO - 1499716017889 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:46:57 INFO - 1499716017891 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f182723c-a076-4794-a0ec-aa30c4f314ee","ELEMENT":"f182723c-a076-4794-a0ec-aa30c4f314ee"}}]
12:46:57 INFO - 1499716017892 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"f182723c-a076-4794-a0ec-aa30c4f314ee"}]
12:46:57 INFO - 1499716017943 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/clicks.html"
12:46:57 INFO - 1499716017948 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/clicks.html"
12:46:57 INFO - 1499716017948 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/clicks.html"
12:46:57 INFO - 1499716017972 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/test.html"
12:46:57 INFO - 1499716017974 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/test.html"
12:46:57 INFO - 1499716017977 Marionette TRACE 358 <- [1,4,null,{}]
12:46:57 INFO - 1499716017978 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:46:57 INFO - 1499716017980 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c3f444b2-d15c-45cb-aa65-2445de7cd1ef","ELEMENT":"c3f444b2-d15c-45cb-aa65-2445de7cd1ef"}}]
12:46:57 INFO - 1499716017981 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:46:57 INFO - 1499716017982 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:46:57 INFO - 1499716017989 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}]
12:46:57 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499716017992 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:46:57 INFO - 1499716017993 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:46:57 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 204ms
12:46:57 INFO - 1499716017995 Marionette TRACE 358 <- [1,8,null,{}]
12:46:57 INFO - TEST-START | test_click.py TestClick.test_container_element
12:46:57 INFO - 1499716017997 Marionette DEBUG Closed connection 358
12:46:57 INFO - 1499716017997 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49767
12:46:58 INFO - 1499716017998 Marionette DEBUG Closed connection 359
12:46:58 INFO - 1499716017999 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49768
12:46:58 INFO - 1499716018001 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018001 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018004 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018008 Marionette TRACE 360 <- [1,1,null,{"sessionId":"acbb4628-9d5a-47c1-a494-097d62881afc","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018010 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:46:58 INFO - 1499716018010 Marionette TRACE 360 <- [1,2,null,{}]
12:46:58 INFO - 1499716018011 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:58 INFO - 1499716018012 Marionette TRACE 360 <- [1,3,null,{}]
12:46:58 INFO - 1499716018013 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:58 INFO - 1499716018013 Marionette TRACE 360 <- [1,4,null,{}]
12:46:58 INFO - 1499716018015 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}]
12:46:58 INFO - TEST-START: test_click.py TestClick.test_container_element1499716018020 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:46:58 INFO - 1499716018021 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:46:58 INFO - 1499716018022 Marionette TRACE 360 <- [1,6,null,{}]
12:46:58 INFO - 1499716018025 Marionette DEBUG Closed connection 360
12:46:58 INFO - 1499716018025 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49769
12:46:58 INFO - 1499716018026 Marionette DEBUG Closed connection 361
12:46:58 INFO - 1499716018027 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49770
12:46:58 INFO - 1499716018028 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018029 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018031 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018036 Marionette TRACE 362 <- [1,1,null,{"sessionId":"b37ba319-c056-475a-8412-a1dfa95f13e5","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018038 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:46:58 INFO - 1499716018040 Marionette TRACE 362 <- [1,2,null,{}]
12:46:58 INFO - 1499716018042 Marionette DEBUG Closed connection 362
12:46:58 INFO - 1499716018043 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49771
12:46:58 INFO - 1499716018043 Marionette DEBUG Closed connection 363
12:46:58 INFO - 1499716018044 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49772
12:46:58 INFO - 1499716018045 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:58 INFO - 1499716018046 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018048 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018053 Marionette TRACE 364 <- [1,1,null,{"sessionId":"35d0ab85-60f4-4bcc-9f11-2111f93d70ad","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018055 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"}]
12:46:58 INFO - 1499716018057 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/test.html"
12:46:58 INFO - 1499716018059 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/test.html"
12:46:58 INFO - 1499716018059 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/test.html"
12:46:58 INFO - 1499716018081 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"
12:46:58 INFO - 1499716018089 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"
12:46:58 INFO - 1499716018093 Marionette TRACE 364 <- [1,2,null,{}]
12:46:58 INFO - 1499716018094 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:46:58 INFO - 1499716018096 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6a321e74-dee1-4ae4-96e9-68f2f4455937","ELEMENT":"6a321e74-dee1-4ae4-96e9-68f2f4455937"}}]
12:46:58 INFO - 1499716018098 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"6a321e74-dee1-4ae4-96e9-68f2f4455937"}]
12:46:58 INFO - 1499716018349 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:46:58 INFO - 1499716018350 Marionette TRACE 364 <- [1,4,null,{}]
12:46:58 INFO - 1499716018351 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"6a321e74-dee1-4ae4-96e9-68f2f4455937","name":"selected"}]
12:46:58 INFO - 1499716018356 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:46:58 INFO - 1499716018358 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}]
12:46:58 INFO - TEST-END: test_click.py TestClick.test_container_element1499716018360 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:46:58 INFO - 1499716018361 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:46:58 INFO - 1499716018362 Marionette TRACE 364 <- [1,7,null,{}]
12:46:58 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 367ms
12:46:58 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:46:58 INFO - 1499716018365 Marionette DEBUG Closed connection 364
12:46:58 INFO - 1499716018365 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49773
12:46:58 INFO - 1499716018366 Marionette DEBUG Closed connection 365
12:46:58 INFO - 1499716018367 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49774
12:46:58 INFO - 1499716018368 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018368 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018371 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018374 Marionette TRACE 366 <- [1,1,null,{"sessionId":"92bcde0f-6179-4e9f-9b5f-55028dddeb90","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018376 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:46:58 INFO - 1499716018377 Marionette TRACE 366 <- [1,2,null,{}]
12:46:58 INFO - 1499716018377 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:58 INFO - 1499716018378 Marionette TRACE 366 <- [1,3,null,{}]
12:46:58 INFO - 1499716018379 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:58 INFO - 1499716018380 Marionette TRACE 366 <- [1,4,null,{}]
12:46:58 INFO - 1499716018382 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}]
12:46:58 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499716018385 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:46:58 INFO - 1499716018385 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:46:58 INFO - 1499716018387 Marionette TRACE 366 <- [1,6,null,{}]
12:46:58 INFO - 1499716018389 Marionette DEBUG Closed connection 366
12:46:58 INFO - 1499716018390 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49775
12:46:58 INFO - 1499716018391 Marionette DEBUG Closed connection 367
12:46:58 INFO - 1499716018391 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49776
12:46:58 INFO - 1499716018393 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018393 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018396 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018407 Marionette TRACE 368 <- [1,1,null,{"sessionId":"57dcdff5-f879-4bcc-940f-2084db8c80d1","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018409 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:46:58 INFO - 1499716018410 Marionette TRACE 368 <- [1,2,null,{}]
12:46:58 INFO - 1499716018412 Marionette DEBUG Closed connection 368
12:46:58 INFO - 1499716018413 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49777
12:46:58 INFO - 1499716018414 Marionette DEBUG Closed connection 369
12:46:58 INFO - 1499716018414 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49778
12:46:58 INFO - 1499716018415 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:58 INFO - 1499716018416 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018419 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018422 Marionette TRACE 370 <- [1,1,null,{"sessionId":"62a4008d-087a-4285-9992-78439e1a609d","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018424 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"}]
12:46:58 INFO - 1499716018425 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"
12:46:58 INFO - 1499716018427 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"
12:46:58 INFO - 1499716018428 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"
12:46:58 INFO - 1499716018447 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"
12:46:58 INFO - 1499716018452 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"
12:46:58 INFO - 1499716018461 Marionette TRACE 370 <- [1,2,null,{}]
12:46:58 INFO - 1499716018463 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:46:58 INFO - 1499716018465 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ac758fbc-1272-4091-a802-3a2ef2c395fc","ELEMENT":"ac758fbc-1272-4091-a802-3a2ef2c395fc"}}]
12:46:58 INFO - 1499716018466 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"ac758fbc-1272-4091-a802-3a2ef2c395fc"}]
12:46:58 INFO - 1499716018719 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:46:58 INFO - 1499716018720 Marionette TRACE 370 <- [1,4,null,{}]
12:46:58 INFO - 1499716018721 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"ac758fbc-1272-4091-a802-3a2ef2c395fc","name":"selected"}]
12:46:58 INFO - 1499716018726 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:46:58 INFO - 1499716018727 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}]
12:46:58 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499716018730 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:46:58 INFO - 1499716018731 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:46:58 INFO - 1499716018732 Marionette TRACE 370 <- [1,7,null,{}]
12:46:58 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 369ms
12:46:58 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:46:58 INFO - 1499716018734 Marionette DEBUG Closed connection 370
12:46:58 INFO - 1499716018735 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49779
12:46:58 INFO - 1499716018736 Marionette DEBUG Closed connection 371
12:46:58 INFO - 1499716018736 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49780
12:46:58 INFO - 1499716018737 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018738 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018740 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018743 Marionette TRACE 372 <- [1,1,null,{"sessionId":"8a3357dc-6710-499f-83a0-7458c20d6107","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018745 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:46:58 INFO - 1499716018746 Marionette TRACE 372 <- [1,2,null,{}]
12:46:58 INFO - 1499716018747 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:58 INFO - 1499716018747 Marionette TRACE 372 <- [1,3,null,{}]
12:46:58 INFO - 1499716018748 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:58 INFO - 1499716018748 Marionette TRACE 372 <- [1,4,null,{}]
12:46:58 INFO - 1499716018750 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}]
12:46:58 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499716018752 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:46:58 INFO - 1499716018753 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:46:58 INFO - 1499716018754 Marionette TRACE 372 <- [1,6,null,{}]
12:46:58 INFO - 1499716018756 Marionette DEBUG Closed connection 372
12:46:58 INFO - 1499716018757 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49781
12:46:58 INFO - 1499716018758 Marionette DEBUG Closed connection 373
12:46:58 INFO - 1499716018758 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49782
12:46:58 INFO - 1499716018759 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:58 INFO - 1499716018760 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018762 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018765 Marionette TRACE 374 <- [1,1,null,{"sessionId":"8866f3bd-a640-4b03-8be1-64908409b6db","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018767 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:46:58 INFO - 1499716018769 Marionette TRACE 374 <- [1,2,null,{}]
12:46:58 INFO - 1499716018771 Marionette DEBUG Closed connection 374
12:46:58 INFO - 1499716018771 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49783
12:46:58 INFO - 1499716018772 Marionette DEBUG Closed connection 375
12:46:58 INFO - 1499716018772 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49784
12:46:58 INFO - 1499716018773 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:58 INFO - 1499716018774 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:58 INFO - 1499716018777 Marionette DEBUG Register listener.js for window 12
12:46:58 INFO - 1499716018779 Marionette TRACE 376 <- [1,1,null,{"sessionId":"e4defda2-8361-4362-9db1-29ef5692b719","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:58 INFO - 1499716018781 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"}]
12:46:58 INFO - 1499716018783 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"
12:46:58 INFO - 1499716018785 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"
12:46:58 INFO - 1499716018785 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"
12:46:58 INFO - 1499716018798 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"
12:46:58 INFO - 1499716018802 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"
12:46:58 INFO - 1499716018811 Marionette TRACE 376 <- [1,2,null,{}]
12:46:58 INFO - 1499716018813 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:46:58 INFO - 1499716018816 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"882a6374-35df-4da5-abf2-baa02f115060","ELEMENT":"882a6374-35df-4da5-abf2-baa02f115060"}}]
12:46:58 INFO - 1499716018818 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"882a6374-35df-4da5-abf2-baa02f115060"}]
12:46:59 INFO - 1499716019066 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:46:59 INFO - 1499716019067 Marionette TRACE 376 <- [1,4,null,{}]
12:46:59 INFO - 1499716019068 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}]
12:46:59 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499716019071 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019072 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:46:59 INFO - 1499716019073 Marionette TRACE 376 <- [1,6,null,{}]
12:46:59 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 341ms
12:46:59 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:46:59 INFO - 1499716019075 Marionette DEBUG Closed connection 376
12:46:59 INFO - 1499716019076 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49785
12:46:59 INFO - 1499716019076 Marionette DEBUG Closed connection 377
12:46:59 INFO - 1499716019077 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49786
12:46:59 INFO - 1499716019078 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019079 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019081 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019084 Marionette TRACE 378 <- [1,1,null,{"sessionId":"4b6dc2d3-c74a-47eb-95af-3e262ef890ef","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019086 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:46:59 INFO - 1499716019087 Marionette TRACE 378 <- [1,2,null,{}]
12:46:59 INFO - 1499716019088 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:59 INFO - 1499716019088 Marionette TRACE 378 <- [1,3,null,{}]
12:46:59 INFO - 1499716019089 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:59 INFO - 1499716019090 Marionette TRACE 378 <- [1,4,null,{}]
12:46:59 INFO - 1499716019091 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}]
12:46:59 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499716019093 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019094 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:46:59 INFO - 1499716019096 Marionette TRACE 378 <- [1,6,null,{}]
12:46:59 INFO - 1499716019098 Marionette DEBUG Closed connection 378
12:46:59 INFO - 1499716019098 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49787
12:46:59 INFO - 1499716019099 Marionette DEBUG Closed connection 379
12:46:59 INFO - 1499716019100 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49788
12:46:59 INFO - 1499716019101 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019101 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019104 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019107 Marionette TRACE 380 <- [1,1,null,{"sessionId":"01c9a8d9-3e2e-4165-8e04-820cbf91af71","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019109 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:46:59 INFO - 1499716019110 Marionette TRACE 380 <- [1,2,null,{}]
12:46:59 INFO - 1499716019112 Marionette DEBUG Closed connection 380
12:46:59 INFO - 1499716019113 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49789
12:46:59 INFO - 1499716019114 Marionette DEBUG Closed connection 381
12:46:59 INFO - 1499716019114 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49790
12:46:59 INFO - 1499716019115 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:59 INFO - 1499716019116 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019119 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019122 Marionette TRACE 382 <- [1,1,null,{"sessionId":"e009cb0d-75a2-4545-9e9e-b24b89a1ec4d","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019124 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"}]
12:46:59 INFO - 1499716019125 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"
12:46:59 INFO - 1499716019127 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"
12:46:59 INFO - 1499716019128 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"
12:46:59 INFO - 1499716019146 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"
12:46:59 INFO - 1499716019150 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"
12:46:59 INFO - 1499716019159 Marionette TRACE 382 <- [1,2,null,{}]
12:46:59 INFO - 1499716019160 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:46:59 INFO - 1499716019163 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f11219be-82c4-40f0-b163-3a6bdbf3cae0","ELEMENT":"f11219be-82c4-40f0-b163-3a6bdbf3cae0"}}]
12:46:59 INFO - 1499716019164 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"f11219be-82c4-40f0-b163-3a6bdbf3cae0"}]
12:46:59 INFO - 1499716019409 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:46:59 INFO - 1499716019409 Marionette TRACE 382 <- [1,4,null,{}]
12:46:59 INFO - 1499716019411 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}]
12:46:59 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499716019414 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019415 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:46:59 INFO - 1499716019416 Marionette TRACE 382 <- [1,6,null,{}]
12:46:59 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 342ms
12:46:59 INFO - TEST-START | test_click.py TestClick.test_input_file
12:46:59 INFO - 1499716019418 Marionette DEBUG Closed connection 382
12:46:59 INFO - 1499716019419 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49791
12:46:59 INFO - 1499716019420 Marionette DEBUG Closed connection 383
12:46:59 INFO - 1499716019421 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49792
12:46:59 INFO - 1499716019422 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019422 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019425 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019428 Marionette TRACE 384 <- [1,1,null,{"sessionId":"8c7a6d43-a502-4fce-8607-b16fa52d618d","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019430 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:46:59 INFO - 1499716019430 Marionette TRACE 384 <- [1,2,null,{}]
12:46:59 INFO - 1499716019431 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:59 INFO - 1499716019432 Marionette TRACE 384 <- [1,3,null,{}]
12:46:59 INFO - 1499716019433 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:59 INFO - 1499716019433 Marionette TRACE 384 <- [1,4,null,{}]
12:46:59 INFO - 1499716019434 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}]
12:46:59 INFO - TEST-START: test_click.py TestClick.test_input_file1499716019437 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019438 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:46:59 INFO - 1499716019439 Marionette TRACE 384 <- [1,6,null,{}]
12:46:59 INFO - 1499716019441 Marionette DEBUG Closed connection 384
12:46:59 INFO - 1499716019442 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49793
12:46:59 INFO - 1499716019442 Marionette DEBUG Closed connection 385
12:46:59 INFO - 1499716019443 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49794
12:46:59 INFO - 1499716019444 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019445 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019447 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019450 Marionette TRACE 386 <- [1,1,null,{"sessionId":"98732863-361e-4839-8e39-cf2146b5bd0a","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019452 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:46:59 INFO - 1499716019454 Marionette TRACE 386 <- [1,2,null,{}]
12:46:59 INFO - 1499716019456 Marionette DEBUG Closed connection 386
12:46:59 INFO - 1499716019456 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49795
12:46:59 INFO - 1499716019457 Marionette DEBUG Closed connection 387
12:46:59 INFO - 1499716019458 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49796
12:46:59 INFO - 1499716019459 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:59 INFO - 1499716019459 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019468 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019472 Marionette TRACE 388 <- [1,1,null,{"sessionId":"49b3fda7-7ca0-40de-9641-86f9f6412740","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019474 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:46:59 INFO - 1499716019475 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"
12:46:59 INFO - 1499716019478 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"
12:46:59 INFO - 1499716019478 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"
12:46:59 INFO - 1499716019497 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:46:59 INFO - 1499716019505 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:46:59 INFO - 1499716019509 Marionette TRACE 388 <- [1,2,null,{}]
12:46:59 INFO - 1499716019510 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:46:59 INFO - 1499716019512 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a08ed509-d80f-46f9-9416-a1e7812b1ba0","ELEMENT":"a08ed509-d80f-46f9-9416-a1e7812b1ba0"}}]
12:46:59 INFO - 1499716019513 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"a08ed509-d80f-46f9-9416-a1e7812b1ba0"}]
12:46:59 INFO - 1499716019550 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:46:59 INFO - 1499716019552 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}]
12:46:59 INFO - TEST-END: test_click.py TestClick.test_input_file1499716019555 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019556 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:46:59 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 141ms
12:46:59 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:46:59 INFO - 1499716019558 Marionette TRACE 388 <- [1,6,null,{}]
12:46:59 INFO - 1499716019560 Marionette DEBUG Closed connection 388
12:46:59 INFO - 1499716019560 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49797
12:46:59 INFO - 1499716019561 Marionette DEBUG Closed connection 389
12:46:59 INFO - 1499716019561 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49798
12:46:59 INFO - 1499716019562 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019563 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019566 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019570 Marionette TRACE 390 <- [1,1,null,{"sessionId":"25ec7bb8-b867-438f-8031-3d4b160d6ed9","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019572 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:46:59 INFO - 1499716019572 Marionette TRACE 390 <- [1,2,null,{}]
12:46:59 INFO - 1499716019573 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:46:59 INFO - 1499716019573 Marionette TRACE 390 <- [1,3,null,{}]
12:46:59 INFO - 1499716019574 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:46:59 INFO - 1499716019575 Marionette TRACE 390 <- [1,4,null,{}]
12:46:59 INFO - 1499716019576 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}]
12:46:59 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499716019579 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:46:59 INFO - 1499716019580 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:46:59 INFO - 1499716019581 Marionette TRACE 390 <- [1,6,null,{}]
12:46:59 INFO - 1499716019583 Marionette DEBUG Closed connection 390
12:46:59 INFO - 1499716019584 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49799
12:46:59 INFO - 1499716019585 Marionette DEBUG Closed connection 391
12:46:59 INFO - 1499716019585 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49800
12:46:59 INFO - 1499716019587 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:46:59 INFO - 1499716019587 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019590 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019594 Marionette TRACE 392 <- [1,1,null,{"sessionId":"08e65d8a-8353-4b81-9ba1-a411abb1ec87","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019596 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:46:59 INFO - 1499716019597 Marionette TRACE 392 <- [1,2,null,{}]
12:46:59 INFO - 1499716019599 Marionette DEBUG Closed connection 392
12:46:59 INFO - 1499716019600 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49801
12:46:59 INFO - 1499716019600 Marionette DEBUG Closed connection 393
12:46:59 INFO - 1499716019601 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49802
12:46:59 INFO - 1499716019602 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:46:59 INFO - 1499716019603 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:46:59 INFO - 1499716019605 Marionette DEBUG Register listener.js for window 12
12:46:59 INFO - 1499716019608 Marionette TRACE 394 <- [1,1,null,{"sessionId":"c283e599-1d50-4549-8f7f-3482e63fa0ca","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:46:59 INFO - 1499716019610 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"}]
12:46:59 INFO - 1499716019612 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:46:59 INFO - 1499716019614 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:46:59 INFO - 1499716019614 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:46:59 INFO - 1499716019636 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"
12:46:59 INFO - 1499716019638 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"
12:46:59 INFO - 1499716019642 Marionette TRACE 394 <- [1,2,null,{}]
12:46:59 INFO - 1499716019643 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:46:59 INFO - 1499716019645 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6fa43ee1-5a3f-40ed-a307-c684587dc9f7","ELEMENT":"6fa43ee1-5a3f-40ed-a307-c684587dc9f7"}}]
12:46:59 INFO - 1499716019646 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:46:59 INFO - 1499716019654 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"24102dcf-32b2-40a1-a663-87b48e579864","ELEMENT":"24102dcf-32b2-40a1-a663-87b48e579864"}}]
12:46:59 INFO - 1499716019668 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"6fa43ee1-5a3f-40ed-a307-c684587dc9f7"}]
12:46:59 INFO - 1499716019977 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:46:59 INFO - 1499716019978 Marionette TRACE 394 <- [1,5,null,{}]
12:46:59 INFO - 1499716019980 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"24102dcf-32b2-40a1-a663-87b48e579864"}]
12:47:00 INFO - 1499716020000 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
12:47:00 INFO - 1499716020003 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
12:47:00 INFO - 1499716020007 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:47:00 INFO - 1499716020010 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}]
12:47:00 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499716020014 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:47:00 INFO - 1499716020015 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:47:00 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 460ms
12:47:00 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:47:00 INFO - 1499716020018 Marionette TRACE 394 <- [1,9,null,{}]
12:47:00 INFO - 1499716020022 Marionette DEBUG Closed connection 394
12:47:00 INFO - 1499716020023 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49803
12:47:00 INFO - 1499716020030 Marionette DEBUG Closed connection 395
12:47:00 INFO - 1499716020031 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49804
12:47:00 INFO - 1499716020033 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:47:00 INFO - 1499716020036 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:47:00 INFO - 1499716020039 Marionette DEBUG Register listener.js for window 12
12:47:00 INFO - 1499716020045 Marionette TRACE 396 <- [1,1,null,{"sessionId":"1d97d201-cb62-4e0d-9933-00f1c4ddfd44","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:47:00 INFO - 1499716020049 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:47:00 INFO - 1499716020050 Marionette TRACE 396 <- [1,2,null,{}]
12:47:00 INFO - 1499716020051 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:47:00 INFO - 1499716020052 Marionette TRACE 396 <- [1,3,null,{}]
12:47:00 INFO - 1499716020053 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:47:00 INFO - 1499716020054 Marionette TRACE 396 <- [1,4,null,{}]
12:47:00 INFO - 1499716020056 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}]
12:47:00 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499716020059 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:47:00 INFO - 1499716020060 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:47:00 INFO - 1499716020063 Marionette TRACE 396 <- [1,6,null,{}]
12:47:00 INFO - 1499716020066 Marionette DEBUG Closed connection 396
12:47:00 INFO - 1499716020067 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49805
12:47:00 INFO - 1499716020069 Marionette DEBUG Closed connection 397
12:47:00 INFO - 1499716020070 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49806
12:47:00 INFO - 1499716020073 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:47:00 INFO - 1499716020075 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:47:00 INFO - 1499716020078 Marionette DEBUG Register listener.js for window 12
12:47:00 INFO - 1499716020083 Marionette TRACE 398 <- [1,1,null,{"sessionId":"230ab51f-755f-4531-b9a2-8e6d72a59049","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:47:00 INFO - 1499716020086 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:47:00 INFO - 1499716020088 Marionette TRACE 398 <- [1,2,null,{}]
12:47:00 INFO - 1499716020090 Marionette DEBUG Closed connection 398
12:47:00 INFO - 1499716020091 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49807
12:47:00 INFO - 1499716020092 Marionette DEBUG Closed connection 399
12:47:00 INFO - 1499716020093 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49808
12:47:00 INFO - 1499716020094 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:47:00 INFO - 1499716020095 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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}
12:47:00 INFO - 1499716020098 Marionette DEBUG Register listener.js for window 12
12:47:00 INFO - 1499716020103 Marionette TRACE 400 <- [1,1,null,{"sessionId":"29873cdb-63a7-4d24-82b7-599057e738f9","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":3708,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-130.001\\AppData\\Local\\Temp\\tmpd5sunu.mozrunner","moz:accessibilityChecks":false}}]
12:47:00 INFO - 1499716020106 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"}]
12:47:00 INFO - 1499716020108 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"
12:47:00 INFO - 1499716020113 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"
12:47:00 INFO - 1499716020113 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"
12:47:00 INFO - 1499716020137 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"
12:47:00 INFO - 1499716020140 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"
12:47:00 INFO - 1499716020146 Marionette TRACE 400 <- [1,2,null,{}]
12:47:00 INFO - 1499716020147 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:47:00 INFO - 1499716020166 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"df87f86b-ff13-4677-adad-360662d0a790","ELEMENT":"df87f86b-ff13-4677-adad-360662d0a790"}}]
12:47:00 INFO - 1499716020168 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"df87f86b-ff13-4677-adad-360662d0a790"}]
12:47:00 INFO - 1499716020194 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:47:00 INFO - 1499716020195 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"df87f86b-ff13-4677-adad-360662d0a790"}]
12:47:00 INFO - 1499716020214 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element