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]
13:26:53 INFO - 1499718413975 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}]
13:26:53 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499718413978 Marionette TRACE 352 <- [1,5,null,{"value":null}]
13:26:53 INFO - 1499718413979 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
13:26:53 INFO - 1499718413980 Marionette TRACE 352 <- [1,6,null,{}]
13:26:53 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 174ms
13:26:53 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
13:26:53 INFO - 1499718413982 Marionette DEBUG Closed connection 352
13:26:53 INFO - 1499718413983 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49751
13:26:53 INFO - 1499718413983 Marionette DEBUG Closed connection 353
13:26:53 INFO - 1499718413984 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49752
13:26:53 INFO - 1499718413985 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:53 INFO - 1499718413986 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:53 INFO - 1499718413989 Marionette DEBUG Register listener.js for window 12
13:26:53 INFO - 1499718413992 Marionette TRACE 354 <- [1,1,null,{"sessionId":"38fa3ad4-c543-4d89-b2ad-acbcaad54da2","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:53 INFO - 1499718413995 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
13:26:53 INFO - 1499718413995 Marionette TRACE 354 <- [1,2,null,{}]
13:26:53 INFO - 1499718413996 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:53 INFO - 1499718413996 Marionette TRACE 354 <- [1,3,null,{}]
13:26:53 INFO - 1499718413997 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:53 INFO - 1499718413998 Marionette TRACE 354 <- [1,4,null,{}]
13:26:54 INFO - 1499718413999 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}]
13:26:54 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499718414002 Marionette TRACE 354 <- [1,5,null,{"value":null}]
13:26:54 INFO - 1499718414003 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
13:26:54 INFO - 1499718414004 Marionette TRACE 354 <- [1,6,null,{}]
13:26:54 INFO - 1499718414007 Marionette DEBUG Closed connection 354
13:26:54 INFO - 1499718414008 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49753
13:26:54 INFO - 1499718414008 Marionette DEBUG Closed connection 355
13:26:54 INFO - 1499718414009 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49754
13:26:54 INFO - 1499718414011 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414011 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414014 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414019 Marionette TRACE 356 <- [1,1,null,{"sessionId":"d9b7fdcc-36ad-4dcf-b325-66ecbfa33f2f","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414021 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
13:26:54 INFO - 1499718414023 Marionette TRACE 356 <- [1,2,null,{}]
13:26:54 INFO - 1499718414025 Marionette DEBUG Closed connection 356
13:26:54 INFO - 1499718414025 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49755
13:26:54 INFO - 1499718414026 Marionette DEBUG Closed connection 357
13:26:54 INFO - 1499718414026 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49756
13:26:54 INFO - 1499718414027 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:54 INFO - 1499718414028 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414031 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414034 Marionette TRACE 358 <- [1,1,null,{"sessionId":"fcf50a4c-64c7-42b4-b4a1-1334e74a32ec","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414036 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49327/clicks.html"}]
13:26:54 INFO - 1499718414037 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/hidden.html"
13:26:54 INFO - 1499718414043 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/hidden.html"
13:26:54 INFO - 1499718414043 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/hidden.html"
13:26:54 INFO - 1499718414065 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/clicks.html"
13:26:54 INFO - 1499718414066 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/clicks.html"
13:26:54 INFO - 1499718414070 Marionette TRACE 358 <- [1,2,null,{}]
13:26:54 INFO - 1499718414077 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
13:26:54 INFO - 1499718414080 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dd6e8d50-674d-48e6-893e-3a1b899953b0","ELEMENT":"dd6e8d50-674d-48e6-893e-3a1b899953b0"}}]
13:26:54 INFO - 1499718414081 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"dd6e8d50-674d-48e6-893e-3a1b899953b0"}]
13:26:54 INFO - 1499718414130 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/clicks.html"
13:26:54 INFO - 1499718414135 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/clicks.html"
13:26:54 INFO - 1499718414135 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/clicks.html"
13:26:54 INFO - 1499718414154 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/test.html"
13:26:54 INFO - 1499718414161 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/test.html"
13:26:54 INFO - 1499718414164 Marionette TRACE 358 <- [1,4,null,{}]
13:26:54 INFO - 1499718414165 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
13:26:54 INFO - 1499718414167 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"48835c05-3bc3-401c-8d25-11c8cf0d6bc0","ELEMENT":"48835c05-3bc3-401c-8d25-11c8cf0d6bc0"}}]
13:26:54 INFO - 1499718414168 Marionette TRACE 358 -> [0,6,"getTitle",{}]
13:26:54 INFO - 1499718414169 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
13:26:54 INFO - 1499718414170 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}]
13:26:54 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499718414180 Marionette TRACE 358 <- [1,7,null,{"value":null}]
13:26:54 INFO - 1499718414181 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
13:26:54 INFO - 1499718414182 Marionette TRACE 358 <- [1,8,null,{}]
13:26:54 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 202ms
13:26:54 INFO - TEST-START | test_click.py TestClick.test_container_element
13:26:54 INFO - 1499718414184 Marionette DEBUG Closed connection 358
13:26:54 INFO - 1499718414185 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49759
13:26:54 INFO - 1499718414186 Marionette DEBUG Closed connection 359
13:26:54 INFO - 1499718414186 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49760
13:26:54 INFO - 1499718414187 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414188 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414191 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414195 Marionette TRACE 360 <- [1,1,null,{"sessionId":"26c98a6c-9c3b-4770-8b39-c396c2064d83","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414197 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
13:26:54 INFO - 1499718414197 Marionette TRACE 360 <- [1,2,null,{}]
13:26:54 INFO - 1499718414198 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:54 INFO - 1499718414199 Marionette TRACE 360 <- [1,3,null,{}]
13:26:54 INFO - 1499718414200 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:54 INFO - 1499718414200 Marionette TRACE 360 <- [1,4,null,{}]
13:26:54 INFO - 1499718414202 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}]
13:26:54 INFO - TEST-START: test_click.py TestClick.test_container_element1499718414206 Marionette TRACE 360 <- [1,5,null,{"value":null}]
13:26:54 INFO - 1499718414207 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
13:26:54 INFO - 1499718414208 Marionette TRACE 360 <- [1,6,null,{}]
13:26:54 INFO - 1499718414211 Marionette DEBUG Closed connection 360
13:26:54 INFO - 1499718414211 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49761
13:26:54 INFO - 1499718414212 Marionette DEBUG Closed connection 361
13:26:54 INFO - 1499718414213 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49762
13:26:54 INFO - 1499718414214 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414214 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414217 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414220 Marionette TRACE 362 <- [1,1,null,{"sessionId":"9a01fb3d-220d-4208-8243-7280f93082d2","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414223 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
13:26:54 INFO - 1499718414225 Marionette TRACE 362 <- [1,2,null,{}]
13:26:54 INFO - 1499718414227 Marionette DEBUG Closed connection 362
13:26:54 INFO - 1499718414228 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49763
13:26:54 INFO - 1499718414229 Marionette DEBUG Closed connection 363
13:26:54 INFO - 1499718414229 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49764
13:26:54 INFO - 1499718414230 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:54 INFO - 1499718414231 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414234 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414237 Marionette TRACE 364 <- [1,1,null,{"sessionId":"fb8e179f-a07a-406d-a8f1-5b29b5849a3b","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414240 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"}]
13:26:54 INFO - 1499718414242 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/test.html"
13:26:54 INFO - 1499718414244 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/test.html"
13:26:54 INFO - 1499718414244 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/test.html"
13:26:54 INFO - 1499718414269 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"
13:26:54 INFO - 1499718414274 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"
13:26:54 INFO - 1499718414283 Marionette TRACE 364 <- [1,2,null,{}]
13:26:54 INFO - 1499718414284 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
13:26:54 INFO - 1499718414286 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"527c6685-0808-4cb5-9ec0-427eba40bcea","ELEMENT":"527c6685-0808-4cb5-9ec0-427eba40bcea"}}]
13:26:54 INFO - 1499718414287 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"527c6685-0808-4cb5-9ec0-427eba40bcea"}]
13:26:54 INFO - 1499718414532 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:26:54 INFO - 1499718414533 Marionette TRACE 364 <- [1,4,null,{}]
13:26:54 INFO - 1499718414534 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"527c6685-0808-4cb5-9ec0-427eba40bcea","name":"selected"}]
13:26:54 INFO - 1499718414539 Marionette TRACE 364 <- [1,5,null,{"value":true}]
13:26:54 INFO - 1499718414540 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}]
13:26:54 INFO - TEST-END: test_click.py TestClick.test_container_element1499718414543 Marionette TRACE 364 <- [1,6,null,{"value":null}]
13:26:54 INFO - 1499718414544 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
13:26:54 INFO - 1499718414545 Marionette TRACE 364 <- [1,7,null,{}]
13:26:54 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 362ms
13:26:54 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
13:26:54 INFO - 1499718414547 Marionette DEBUG Closed connection 364
13:26:54 INFO - 1499718414548 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49765
13:26:54 INFO - 1499718414549 Marionette DEBUG Closed connection 365
13:26:54 INFO - 1499718414549 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49766
13:26:54 INFO - 1499718414550 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414551 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414554 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414556 Marionette TRACE 366 <- [1,1,null,{"sessionId":"ebe604ed-6fa9-492e-87a0-39ec0ca8d43d","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414560 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
13:26:54 INFO - 1499718414560 Marionette TRACE 366 <- [1,2,null,{}]
13:26:54 INFO - 1499718414561 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:54 INFO - 1499718414562 Marionette TRACE 366 <- [1,3,null,{}]
13:26:54 INFO - 1499718414563 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:54 INFO - 1499718414564 Marionette TRACE 366 <- [1,4,null,{}]
13:26:54 INFO - 1499718414565 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}]
13:26:54 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499718414568 Marionette TRACE 366 <- [1,5,null,{"value":null}]
13:26:54 INFO - 1499718414569 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
13:26:54 INFO - 1499718414570 Marionette TRACE 366 <- [1,6,null,{}]
13:26:54 INFO - 1499718414572 Marionette DEBUG Closed connection 366
13:26:54 INFO - 1499718414573 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49767
13:26:54 INFO - 1499718414574 Marionette DEBUG Closed connection 367
13:26:54 INFO - 1499718414574 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49768
13:26:54 INFO - 1499718414576 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414577 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414579 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414582 Marionette TRACE 368 <- [1,1,null,{"sessionId":"9f8f2387-8a08-4838-8d4a-d35dcb63cc69","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414584 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
13:26:54 INFO - 1499718414585 Marionette TRACE 368 <- [1,2,null,{}]
13:26:54 INFO - 1499718414587 Marionette DEBUG Closed connection 368
13:26:54 INFO - 1499718414588 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49769
13:26:54 INFO - 1499718414589 Marionette DEBUG Closed connection 369
13:26:54 INFO - 1499718414589 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49770
13:26:54 INFO - 1499718414590 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:54 INFO - 1499718414591 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414600 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414604 Marionette TRACE 370 <- [1,1,null,{"sessionId":"fe35afbf-6ac4-4593-888d-896c62803151","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414606 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"}]
13:26:54 INFO - 1499718414608 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"
13:26:54 INFO - 1499718414610 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"
13:26:54 INFO - 1499718414610 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"
13:26:54 INFO - 1499718414630 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"
13:26:54 INFO - 1499718414632 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"
13:26:54 INFO - 1499718414635 Marionette TRACE 370 <- [1,2,null,{}]
13:26:54 INFO - 1499718414644 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
13:26:54 INFO - 1499718414652 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a44406da-8a04-422a-bf6d-f277daa484c8","ELEMENT":"a44406da-8a04-422a-bf6d-f277daa484c8"}}]
13:26:54 INFO - 1499718414654 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"a44406da-8a04-422a-bf6d-f277daa484c8"}]
13:26:54 INFO - 1499718414897 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:26:54 INFO - 1499718414898 Marionette TRACE 370 <- [1,4,null,{}]
13:26:54 INFO - 1499718414899 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"a44406da-8a04-422a-bf6d-f277daa484c8","name":"selected"}]
13:26:54 INFO - 1499718414903 Marionette TRACE 370 <- [1,5,null,{"value":true}]
13:26:54 INFO - 1499718414905 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}]
13:26:54 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499718414908 Marionette TRACE 370 <- [1,6,null,{"value":null}]
13:26:54 INFO - 1499718414909 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
13:26:54 INFO - 1499718414910 Marionette TRACE 370 <- [1,7,null,{}]
13:26:54 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 365ms
13:26:54 INFO - TEST-START | test_click.py TestClick.test_css_transforms
13:26:54 INFO - 1499718414913 Marionette DEBUG Closed connection 370
13:26:54 INFO - 1499718414913 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49771
13:26:54 INFO - 1499718414914 Marionette DEBUG Closed connection 371
13:26:54 INFO - 1499718414915 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49772
13:26:54 INFO - 1499718414916 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414916 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414919 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414922 Marionette TRACE 372 <- [1,1,null,{"sessionId":"a8f0d06d-be00-42e7-b543-b08961b7bd33","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414924 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
13:26:54 INFO - 1499718414924 Marionette TRACE 372 <- [1,2,null,{}]
13:26:54 INFO - 1499718414925 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:54 INFO - 1499718414926 Marionette TRACE 372 <- [1,3,null,{}]
13:26:54 INFO - 1499718414927 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:54 INFO - 1499718414927 Marionette TRACE 372 <- [1,4,null,{}]
13:26:54 INFO - 1499718414929 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}]
13:26:54 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499718414932 Marionette TRACE 372 <- [1,5,null,{"value":null}]
13:26:54 INFO - 1499718414933 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
13:26:54 INFO - 1499718414934 Marionette TRACE 372 <- [1,6,null,{}]
13:26:54 INFO - 1499718414936 Marionette DEBUG Closed connection 372
13:26:54 INFO - 1499718414936 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49773
13:26:54 INFO - 1499718414937 Marionette DEBUG Closed connection 373
13:26:54 INFO - 1499718414938 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49774
13:26:54 INFO - 1499718414939 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:54 INFO - 1499718414939 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414942 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414945 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c5ce00c1-1f0f-4222-9a9b-f850ccc47a8d","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414947 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
13:26:54 INFO - 1499718414948 Marionette TRACE 374 <- [1,2,null,{}]
13:26:54 INFO - 1499718414950 Marionette DEBUG Closed connection 374
13:26:54 INFO - 1499718414951 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49775
13:26:54 INFO - 1499718414952 Marionette DEBUG Closed connection 375
13:26:54 INFO - 1499718414952 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49776
13:26:54 INFO - 1499718414955 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:54 INFO - 1499718414955 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:54 INFO - 1499718414958 Marionette DEBUG Register listener.js for window 12
13:26:54 INFO - 1499718414961 Marionette TRACE 376 <- [1,1,null,{"sessionId":"18348143-f7d8-4359-9fae-5056c4ef241f","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:54 INFO - 1499718414963 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"}]
13:26:54 INFO - 1499718414965 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"
13:26:54 INFO - 1499718414967 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"
13:26:54 INFO - 1499718414967 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"
13:26:54 INFO - 1499718414987 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"
13:26:54 INFO - 1499718414991 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"
13:26:55 INFO - 1499718414999 Marionette TRACE 376 <- [1,2,null,{}]
13:26:55 INFO - 1499718415001 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
13:26:55 INFO - 1499718415004 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"84a0b9b7-7103-43e6-8d3f-f1ba4bccfd86","ELEMENT":"84a0b9b7-7103-43e6-8d3f-f1ba4bccfd86"}}]
13:26:55 INFO - 1499718415005 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"84a0b9b7-7103-43e6-8d3f-f1ba4bccfd86"}]
13:26:55 INFO - 1499718415252 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:26:55 INFO - 1499718415253 Marionette TRACE 376 <- [1,4,null,{}]
13:26:55 INFO - 1499718415255 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}]
13:26:55 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499718415257 Marionette TRACE 376 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415258 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
13:26:55 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 348ms
13:26:55 INFO - 1499718415259 Marionette TRACE 376 <- [1,6,null,{}]
13:26:55 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
13:26:55 INFO - 1499718415261 Marionette DEBUG Closed connection 376
13:26:55 INFO - 1499718415262 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49777
13:26:55 INFO - 1499718415263 Marionette DEBUG Closed connection 377
13:26:55 INFO - 1499718415264 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49778
13:26:55 INFO - 1499718415265 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415266 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415268 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415271 Marionette TRACE 378 <- [1,1,null,{"sessionId":"3ab4fc56-c1c7-474e-abeb-18a271eb5450","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415273 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
13:26:55 INFO - 1499718415274 Marionette TRACE 378 <- [1,2,null,{}]
13:26:55 INFO - 1499718415275 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:55 INFO - 1499718415275 Marionette TRACE 378 <- [1,3,null,{}]
13:26:55 INFO - 1499718415277 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:55 INFO - 1499718415277 Marionette TRACE 378 <- [1,4,null,{}]
13:26:55 INFO - 1499718415279 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}]
13:26:55 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499718415281 Marionette TRACE 378 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415282 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
13:26:55 INFO - 1499718415283 Marionette TRACE 378 <- [1,6,null,{}]
13:26:55 INFO - 1499718415285 Marionette DEBUG Closed connection 378
13:26:55 INFO - 1499718415286 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49779
13:26:55 INFO - 1499718415287 Marionette DEBUG Closed connection 379
13:26:55 INFO - 1499718415287 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49780
13:26:55 INFO - 1499718415288 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415289 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415292 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415294 Marionette TRACE 380 <- [1,1,null,{"sessionId":"6b58147a-bff4-415f-9092-2c5cd1dc7ae9","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415297 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
13:26:55 INFO - 1499718415298 Marionette TRACE 380 <- [1,2,null,{}]
13:26:55 INFO - 1499718415300 Marionette DEBUG Closed connection 380
13:26:55 INFO - 1499718415300 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49781
13:26:55 INFO - 1499718415301 Marionette DEBUG Closed connection 381
13:26:55 INFO - 1499718415302 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49782
13:26:55 INFO - 1499718415303 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:55 INFO - 1499718415304 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415307 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415310 Marionette TRACE 382 <- [1,1,null,{"sessionId":"7a438cdf-2735-4b84-8ca7-08ba94f0a8cd","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415312 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"}]
13:26:55 INFO - 1499718415314 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"
13:26:55 INFO - 1499718415316 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"
13:26:55 INFO - 1499718415316 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"
13:26:55 INFO - 1499718415335 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"
13:26:55 INFO - 1499718415340 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"
13:26:55 INFO - 1499718415349 Marionette TRACE 382 <- [1,2,null,{}]
13:26:55 INFO - 1499718415351 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
13:26:55 INFO - 1499718415353 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"45cbe090-002a-478c-a221-b9f2ffae84dc","ELEMENT":"45cbe090-002a-478c-a221-b9f2ffae84dc"}}]
13:26:55 INFO - 1499718415355 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"45cbe090-002a-478c-a221-b9f2ffae84dc"}]
13:26:55 INFO - 1499718415598 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:26:55 INFO - 1499718415599 Marionette TRACE 382 <- [1,4,null,{}]
13:26:55 INFO - 1499718415601 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}]
13:26:55 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499718415603 Marionette TRACE 382 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415604 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
13:26:55 INFO - 1499718415606 Marionette TRACE 382 <- [1,6,null,{}]
13:26:55 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 345ms
13:26:55 INFO - TEST-START | test_click.py TestClick.test_input_file
13:26:55 INFO - 1499718415608 Marionette DEBUG Closed connection 382
13:26:55 INFO - 1499718415608 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49783
13:26:55 INFO - 1499718415609 Marionette DEBUG Closed connection 383
13:26:55 INFO - 1499718415610 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49784
13:26:55 INFO - 1499718415611 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415611 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415614 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415617 Marionette TRACE 384 <- [1,1,null,{"sessionId":"622f454b-f73a-4e92-8aba-2dc084266939","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415619 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
13:26:55 INFO - 1499718415619 Marionette TRACE 384 <- [1,2,null,{}]
13:26:55 INFO - 1499718415620 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:55 INFO - 1499718415621 Marionette TRACE 384 <- [1,3,null,{}]
13:26:55 INFO - 1499718415621 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:55 INFO - 1499718415622 Marionette TRACE 384 <- [1,4,null,{}]
13:26:55 INFO - 1499718415623 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}]
13:26:55 INFO - TEST-START: test_click.py TestClick.test_input_file1499718415626 Marionette TRACE 384 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415627 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
13:26:55 INFO - 1499718415628 Marionette TRACE 384 <- [1,6,null,{}]
13:26:55 INFO - 1499718415630 Marionette DEBUG Closed connection 384
13:26:55 INFO - 1499718415631 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49785
13:26:55 INFO - 1499718415631 Marionette DEBUG Closed connection 385
13:26:55 INFO - 1499718415632 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49786
13:26:55 INFO - 1499718415633 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415634 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415636 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415639 Marionette TRACE 386 <- [1,1,null,{"sessionId":"0b62b82a-1204-41dd-a0b0-bf1e53e99d32","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415691 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
13:26:55 INFO - 1499718415693 Marionette TRACE 386 <- [1,2,null,{}]
13:26:55 INFO - 1499718415704 Marionette DEBUG Closed connection 386
13:26:55 INFO - 1499718415705 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49787
13:26:55 INFO - 1499718415709 Marionette DEBUG Closed connection 387
13:26:55 INFO - 1499718415710 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49788
13:26:55 INFO - 1499718415720 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:55 INFO - 1499718415723 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415726 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415731 Marionette TRACE 388 <- [1,1,null,{"sessionId":"b9adc1f8-004a-46da-8080-40e3d7414e5f","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415736 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
13:26:55 INFO - 1499718415739 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"
13:26:55 INFO - 1499718415742 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"
13:26:55 INFO - 1499718415743 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"
13:26:55 INFO - 1499718415765 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:26:55 INFO - 1499718415770 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:26:55 INFO - 1499718415780 Marionette TRACE 388 <- [1,2,null,{}]
13:26:55 INFO - 1499718415783 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
13:26:55 INFO - 1499718415787 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3a9d9d4e-cdb4-407d-998b-296581fba7ad","ELEMENT":"3a9d9d4e-cdb4-407d-998b-296581fba7ad"}}]
13:26:55 INFO - 1499718415789 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"3a9d9d4e-cdb4-407d-998b-296581fba7ad"}]
13:26:55 INFO - 1499718415833 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]
13:26:55 INFO - 1499718415836 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}]
13:26:55 INFO - TEST-END: test_click.py TestClick.test_input_file1499718415840 Marionette TRACE 388 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415841 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
13:26:55 INFO - 1499718415843 Marionette TRACE 388 <- [1,6,null,{}]
13:26:55 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 237ms
13:26:55 INFO - TEST-START | test_click.py TestClick.test_obscured_element
13:26:55 INFO - 1499718415846 Marionette DEBUG Closed connection 388
13:26:55 INFO - 1499718415847 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49789
13:26:55 INFO - 1499718415848 Marionette DEBUG Closed connection 389
13:26:55 INFO - 1499718415849 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49790
13:26:55 INFO - 1499718415850 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415851 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415854 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415859 Marionette TRACE 390 <- [1,1,null,{"sessionId":"a8bff79c-1325-4c24-8c5a-ecd63a75e85d","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415861 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
13:26:55 INFO - 1499718415862 Marionette TRACE 390 <- [1,2,null,{}]
13:26:55 INFO - 1499718415863 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:55 INFO - 1499718415864 Marionette TRACE 390 <- [1,3,null,{}]
13:26:55 INFO - 1499718415866 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:55 INFO - 1499718415868 Marionette TRACE 390 <- [1,4,null,{}]
13:26:55 INFO - 1499718415870 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}]
13:26:55 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499718415873 Marionette TRACE 390 <- [1,5,null,{"value":null}]
13:26:55 INFO - 1499718415875 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
13:26:55 INFO - 1499718415877 Marionette TRACE 390 <- [1,6,null,{}]
13:26:55 INFO - 1499718415879 Marionette DEBUG Closed connection 390
13:26:55 INFO - 1499718415880 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49791
13:26:55 INFO - 1499718415881 Marionette DEBUG Closed connection 391
13:26:55 INFO - 1499718415882 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49792
13:26:55 INFO - 1499718415883 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:55 INFO - 1499718415884 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415887 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415892 Marionette TRACE 392 <- [1,1,null,{"sessionId":"cb2b1863-2cf4-4826-9e71-7c8c9e049799","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415894 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
13:26:55 INFO - 1499718415896 Marionette TRACE 392 <- [1,2,null,{}]
13:26:55 INFO - 1499718415898 Marionette DEBUG Closed connection 392
13:26:55 INFO - 1499718415899 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49793
13:26:55 INFO - 1499718415900 Marionette DEBUG Closed connection 393
13:26:55 INFO - 1499718415901 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49794
13:26:55 INFO - 1499718415902 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:55 INFO - 1499718415903 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:55 INFO - 1499718415906 Marionette DEBUG Register listener.js for window 12
13:26:55 INFO - 1499718415910 Marionette TRACE 394 <- [1,1,null,{"sessionId":"ab57ba1a-4fd5-481d-af85-d406b2aa8359","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:55 INFO - 1499718415913 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"}]
13:26:55 INFO - 1499718415915 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:26:55 INFO - 1499718415918 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:26:55 INFO - 1499718415918 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
13:26:55 INFO - 1499718415945 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"
13:26:55 INFO - 1499718415948 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"
13:26:55 INFO - 1499718415952 Marionette TRACE 394 <- [1,2,null,{}]
13:26:56 INFO - 1499718416032 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
13:26:56 INFO - 1499718416036 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f60a36c7-28bb-43d7-808c-66f82bb41dcc","ELEMENT":"f60a36c7-28bb-43d7-808c-66f82bb41dcc"}}]
13:26:56 INFO - 1499718416037 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
13:26:56 INFO - 1499718416042 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4d36aed9-0cf9-49e1-a424-12e86b510c12","ELEMENT":"4d36aed9-0cf9-49e1-a424-12e86b510c12"}}]
13:26:56 INFO - 1499718416043 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"f60a36c7-28bb-43d7-808c-66f82bb41dcc"}]
13:26:56 INFO - 1499718416290 Marionette DEBUG Canceled page load listener because no navigation has been detected
13:26:56 INFO - 1499718416291 Marionette TRACE 394 <- [1,5,null,{}]
13:26:56 INFO - 1499718416292 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"4d36aed9-0cf9-49e1-a424-12e86b510c12"}]
13:26:56 INFO - 1499718416310 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]
13:26:56 INFO - 1499718416312 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
13:26:56 INFO - 1499718416316 Marionette TRACE 394 <- [1,7,null,{"value":false}]
13:26:56 INFO - 1499718416319 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}]
13:26:56 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499718416323 Marionette TRACE 394 <- [1,8,null,{"value":null}]
13:26:56 INFO - 1499718416324 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
13:26:56 INFO - 1499718416326 Marionette TRACE 394 <- [1,9,null,{}]
13:26:56 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 482ms
13:26:56 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
13:26:56 INFO - 1499718416329 Marionette DEBUG Closed connection 394
13:26:56 INFO - 1499718416330 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49795
13:26:56 INFO - 1499718416331 Marionette DEBUG Closed connection 395
13:26:56 INFO - 1499718416332 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49796
13:26:56 INFO - 1499718416333 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:56 INFO - 1499718416336 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:56 INFO - 1499718416339 Marionette DEBUG Register listener.js for window 12
13:26:56 INFO - 1499718416344 Marionette TRACE 396 <- [1,1,null,{"sessionId":"e3978250-d52a-4776-bbd1-426ab7bebb82","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:56 INFO - 1499718416348 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
13:26:56 INFO - 1499718416348 Marionette TRACE 396 <- [1,2,null,{}]
13:26:56 INFO - 1499718416350 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
13:26:56 INFO - 1499718416350 Marionette TRACE 396 <- [1,3,null,{}]
13:26:56 INFO - 1499718416353 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
13:26:56 INFO - 1499718416355 Marionette TRACE 396 <- [1,4,null,{}]
13:26:56 INFO - 1499718416357 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}]
13:26:56 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499718416361 Marionette TRACE 396 <- [1,5,null,{"value":null}]
13:26:56 INFO - 1499718416362 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
13:26:56 INFO - 1499718416364 Marionette TRACE 396 <- [1,6,null,{}]
13:26:56 INFO - 1499718416367 Marionette DEBUG Closed connection 396
13:26:56 INFO - 1499718416368 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49797
13:26:56 INFO - 1499718416369 Marionette DEBUG Closed connection 397
13:26:56 INFO - 1499718416370 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49798
13:26:56 INFO - 1499718416371 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
13:26:56 INFO - 1499718416372 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:56 INFO - 1499718416375 Marionette DEBUG Register listener.js for window 12
13:26:56 INFO - 1499718416380 Marionette TRACE 398 <- [1,1,null,{"sessionId":"4b1e5344-e94a-4ed7-8a8a-15012099782d","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:56 INFO - 1499718416383 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
13:26:56 INFO - 1499718416385 Marionette TRACE 398 <- [1,2,null,{}]
13:26:56 INFO - 1499718416387 Marionette DEBUG Closed connection 398
13:26:56 INFO - 1499718416388 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49799
13:26:56 INFO - 1499718416389 Marionette DEBUG Closed connection 399
13:26:56 INFO - 1499718416390 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49800
13:26:56 INFO - 1499718416391 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
13:26:56 INFO - 1499718416392 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}
13:26:56 INFO - 1499718416395 Marionette DEBUG Register listener.js for window 12
13:26:56 INFO - 1499718416399 Marionette TRACE 400 <- [1,1,null,{"sessionId":"4a0da074-800d-4aa4-99c0-2826a8095fcb","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-113.001\\AppData\\Local\\Temp\\tmparsmq_.mozrunner","moz:accessibilityChecks":false}}]
13:26:56 INFO - 1499718416401 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"}]
13:26:56 INFO - 1499718416403 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"
13:26:56 INFO - 1499718416407 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"
13:26:56 INFO - 1499718416407 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"
13:26:56 INFO - 1499718416430 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"
13:26:56 INFO - 1499718416433 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"
13:26:56 INFO - 1499718416437 Marionette TRACE 400 <- [1,2,null,{}]
13:26:56 INFO - 1499718416445 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
13:26:56 INFO - 1499718416448 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4f42d0bf-529a-4a22-9932-c46290b32944","ELEMENT":"4f42d0bf-529a-4a22-9932-c46290b32944"}}]
13:26:56 INFO - 1499718416449 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"4f42d0bf-529a-4a22-9932-c46290b32944"}]
13:26:56 INFO - 1499718416477 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
13:26:56 INFO - 1499718416478 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"4f42d0bf-529a-4a22-9932-c46290b32944"}]
13:26:56 INFO - 1499718416499 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element