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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
00:17:17 INFO - 1499411837609 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}]
00:17:17 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499411837612 Marionette TRACE 352 <- [1,5,null,{"value":null}]
00:17:17 INFO - 1499411837613 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
00:17:17 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 146ms
00:17:17 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
00:17:17 INFO - 1499411837614 Marionette TRACE 352 <- [1,6,null,{}]
00:17:17 INFO - 1499411837616 Marionette DEBUG Closed connection 352
00:17:17 INFO - 1499411837617 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49748
00:17:17 INFO - 1499411837619 Marionette DEBUG Closed connection 353
00:17:17 INFO - 1499411837619 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49749
00:17:17 INFO - 1499411837628 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:17 INFO - 1499411837628 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837631 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837634 Marionette TRACE 354 <- [1,1,null,{"sessionId":"8dd9e649-18a5-4624-9b45-59e51b5680e0","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837636 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
00:17:17 INFO - 1499411837636 Marionette TRACE 354 <- [1,2,null,{}]
00:17:17 INFO - 1499411837637 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:17 INFO - 1499411837638 Marionette TRACE 354 <- [1,3,null,{}]
00:17:17 INFO - 1499411837639 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:17 INFO - 1499411837639 Marionette TRACE 354 <- [1,4,null,{}]
00:17:17 INFO - 1499411837641 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}]
00:17:17 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499411837644 Marionette TRACE 354 <- [1,5,null,{"value":null}]
00:17:17 INFO - 1499411837644 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
00:17:17 INFO - 1499411837646 Marionette TRACE 354 <- [1,6,null,{}]
00:17:17 INFO - 1499411837648 Marionette DEBUG Closed connection 354
00:17:17 INFO - 1499411837649 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49750
00:17:17 INFO - 1499411837650 Marionette DEBUG Closed connection 355
00:17:17 INFO - 1499411837650 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49751
00:17:17 INFO - 1499411837651 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:17 INFO - 1499411837652 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837655 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837658 Marionette TRACE 356 <- [1,1,null,{"sessionId":"d4d04618-435e-4e50-948c-31095247b122","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837659 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
00:17:17 INFO - 1499411837660 Marionette TRACE 356 <- [1,2,null,{}]
00:17:17 INFO - 1499411837662 Marionette DEBUG Closed connection 356
00:17:17 INFO - 1499411837662 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49752
00:17:17 INFO - 1499411837663 Marionette DEBUG Closed connection 357
00:17:17 INFO - 1499411837664 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49753
00:17:17 INFO - 1499411837665 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:17 INFO - 1499411837665 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837668 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837672 Marionette TRACE 358 <- [1,1,null,{"sessionId":"a2a06d50-0ab4-4adb-9d5a-5a90cadc4efa","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837674 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49323/clicks.html"}]
00:17:17 INFO - 1499411837675 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/hidden.html"
00:17:17 INFO - 1499411837685 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/hidden.html"
00:17:17 INFO - 1499411837685 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/hidden.html"
00:17:17 INFO - 1499411837708 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/clicks.html"
00:17:17 INFO - 1499411837709 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/clicks.html"
00:17:17 INFO - 1499411837718 Marionette TRACE 358 <- [1,2,null,{}]
00:17:17 INFO - 1499411837730 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
00:17:17 INFO - 1499411837733 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9ab59f0f-8b4e-47fd-9106-6ba3e4941f24","ELEMENT":"9ab59f0f-8b4e-47fd-9106-6ba3e4941f24"}}]
00:17:17 INFO - 1499411837734 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"9ab59f0f-8b4e-47fd-9106-6ba3e4941f24"}]
00:17:17 INFO - 1499411837776 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/clicks.html"
00:17:17 INFO - 1499411837787 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/clicks.html"
00:17:17 INFO - 1499411837788 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/clicks.html"
00:17:17 INFO - 1499411837819 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49323/test.html"
00:17:17 INFO - 1499411837821 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49323/test.html"
00:17:17 INFO - 1499411837823 Marionette TRACE 358 <- [1,4,null,{}]
00:17:17 INFO - 1499411837827 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
00:17:17 INFO - 1499411837829 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"69196e0b-ab76-44c0-9a28-7c5923178688","ELEMENT":"69196e0b-ab76-44c0-9a28-7c5923178688"}}]
00:17:17 INFO - 1499411837836 Marionette TRACE 358 -> [0,6,"getTitle",{}]
00:17:17 INFO - 1499411837836 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
00:17:17 INFO - 1499411837838 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}]
00:17:17 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499411837840 Marionette TRACE 358 <- [1,7,null,{"value":null}]
00:17:17 INFO - 1499411837841 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
00:17:17 INFO - 1499411837843 Marionette TRACE 358 <- [1,8,null,{}]
00:17:17 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 228ms
00:17:17 INFO - TEST-START | test_click.py TestClick.test_container_element
00:17:17 INFO - 1499411837845 Marionette DEBUG Closed connection 358
00:17:17 INFO - 1499411837846 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49756
00:17:17 INFO - 1499411837847 Marionette DEBUG Closed connection 359
00:17:17 INFO - 1499411837848 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49757
00:17:17 INFO - 1499411837849 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:17 INFO - 1499411837849 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837852 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837856 Marionette TRACE 360 <- [1,1,null,{"sessionId":"5429bb3a-0d85-4404-8d8d-5facebf8ae03","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837857 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
00:17:17 INFO - 1499411837858 Marionette TRACE 360 <- [1,2,null,{}]
00:17:17 INFO - 1499411837859 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:17 INFO - 1499411837859 Marionette TRACE 360 <- [1,3,null,{}]
00:17:17 INFO - 1499411837860 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:17 INFO - 1499411837861 Marionette TRACE 360 <- [1,4,null,{}]
00:17:17 INFO - 1499411837862 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}]
00:17:17 INFO - TEST-START: test_click.py TestClick.test_container_element1499411837865 Marionette TRACE 360 <- [1,5,null,{"value":null}]
00:17:17 INFO - 1499411837866 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
00:17:17 INFO - 1499411837867 Marionette TRACE 360 <- [1,6,null,{}]
00:17:17 INFO - 1499411837869 Marionette DEBUG Closed connection 360
00:17:17 INFO - 1499411837870 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49758
00:17:17 INFO - 1499411837871 Marionette DEBUG Closed connection 361
00:17:17 INFO - 1499411837871 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49759
00:17:17 INFO - 1499411837872 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:17 INFO - 1499411837873 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837876 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837879 Marionette TRACE 362 <- [1,1,null,{"sessionId":"4eef1723-76c6-48e2-9772-18361fc15a77","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837880 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
00:17:17 INFO - 1499411837881 Marionette TRACE 362 <- [1,2,null,{}]
00:17:17 INFO - 1499411837883 Marionette DEBUG Closed connection 362
00:17:17 INFO - 1499411837884 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49760
00:17:17 INFO - 1499411837885 Marionette DEBUG Closed connection 363
00:17:17 INFO - 1499411837885 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49761
00:17:17 INFO - 1499411837886 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:17 INFO - 1499411837887 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:17 INFO - 1499411837890 Marionette DEBUG Register listener.js for window 12
00:17:17 INFO - 1499411837893 Marionette TRACE 364 <- [1,1,null,{"sessionId":"5c7d1555-c8a6-4169-b60b-1db820e85cb7","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:17 INFO - 1499411837894 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"}]
00:17:17 INFO - 1499411837895 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49323/test.html"
00:17:17 INFO - 1499411837897 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49323/test.html"
00:17:17 INFO - 1499411837898 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49323/test.html"
00:17:17 INFO - 1499411837928 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"
00:17:17 INFO - 1499411837930 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"
00:17:17 INFO - 1499411837939 Marionette TRACE 364 <- [1,2,null,{}]
00:17:17 INFO - 1499411837940 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
00:17:17 INFO - 1499411837943 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"67b34bb7-dd1c-4529-bd48-1985cf0e96cb","ELEMENT":"67b34bb7-dd1c-4529-bd48-1985cf0e96cb"}}]
00:17:17 INFO - 1499411837944 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"67b34bb7-dd1c-4529-bd48-1985cf0e96cb"}]
00:17:18 INFO - 1499411838189 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:17:18 INFO - 1499411838190 Marionette TRACE 364 <- [1,4,null,{}]
00:17:18 INFO - 1499411838191 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"67b34bb7-dd1c-4529-bd48-1985cf0e96cb","name":"selected"}]
00:17:18 INFO - 1499411838197 Marionette TRACE 364 <- [1,5,null,{"value":true}]
00:17:18 INFO - 1499411838199 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}]
00:17:18 INFO - TEST-END: test_click.py TestClick.test_container_element1499411838201 Marionette TRACE 364 <- [1,6,null,{"value":null}]
00:17:18 INFO - 1499411838202 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
00:17:18 INFO - 1499411838203 Marionette TRACE 364 <- [1,7,null,{}]
00:17:18 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 360ms
00:17:18 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
00:17:18 INFO - 1499411838205 Marionette DEBUG Closed connection 364
00:17:18 INFO - 1499411838206 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49762
00:17:18 INFO - 1499411838207 Marionette DEBUG Closed connection 365
00:17:18 INFO - 1499411838208 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49763
00:17:18 INFO - 1499411838209 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838209 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838212 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838215 Marionette TRACE 366 <- [1,1,null,{"sessionId":"8a5801d4-68ab-4eaa-922c-2062ba2c509e","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838216 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
00:17:18 INFO - 1499411838217 Marionette TRACE 366 <- [1,2,null,{}]
00:17:18 INFO - 1499411838218 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:18 INFO - 1499411838218 Marionette TRACE 366 <- [1,3,null,{}]
00:17:18 INFO - 1499411838219 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:18 INFO - 1499411838220 Marionette TRACE 366 <- [1,4,null,{}]
00:17:18 INFO - 1499411838221 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}]
00:17:18 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499411838224 Marionette TRACE 366 <- [1,5,null,{"value":null}]
00:17:18 INFO - 1499411838225 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
00:17:18 INFO - 1499411838226 Marionette TRACE 366 <- [1,6,null,{}]
00:17:18 INFO - 1499411838228 Marionette DEBUG Closed connection 366
00:17:18 INFO - 1499411838229 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49764
00:17:18 INFO - 1499411838230 Marionette DEBUG Closed connection 367
00:17:18 INFO - 1499411838230 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49765
00:17:18 INFO - 1499411838231 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838232 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838235 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838238 Marionette TRACE 368 <- [1,1,null,{"sessionId":"0136ba14-7e30-4f37-a4e7-50f6b3d24dae","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838239 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
00:17:18 INFO - 1499411838241 Marionette TRACE 368 <- [1,2,null,{}]
00:17:18 INFO - 1499411838243 Marionette DEBUG Closed connection 368
00:17:18 INFO - 1499411838243 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49766
00:17:18 INFO - 1499411838244 Marionette DEBUG Closed connection 369
00:17:18 INFO - 1499411838245 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49767
00:17:18 INFO - 1499411838246 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:18 INFO - 1499411838247 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838249 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838252 Marionette TRACE 370 <- [1,1,null,{"sessionId":"f93a4b08-e4d8-4680-97fd-d08cfe935388","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838254 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"}]
00:17:18 INFO - 1499411838255 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"
00:17:18 INFO - 1499411838257 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"
00:17:18 INFO - 1499411838257 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"
00:17:18 INFO - 1499411838275 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"
00:17:18 INFO - 1499411838280 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"
00:17:18 INFO - 1499411838290 Marionette TRACE 370 <- [1,2,null,{}]
00:17:18 INFO - 1499411838291 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
00:17:18 INFO - 1499411838293 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e7372a0b-845b-4210-b05d-ffce93101f05","ELEMENT":"e7372a0b-845b-4210-b05d-ffce93101f05"}}]
00:17:18 INFO - 1499411838294 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"e7372a0b-845b-4210-b05d-ffce93101f05"}]
00:17:18 INFO - 1499411838547 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:17:18 INFO - 1499411838548 Marionette TRACE 370 <- [1,4,null,{}]
00:17:18 INFO - 1499411838549 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"e7372a0b-845b-4210-b05d-ffce93101f05","name":"selected"}]
00:17:18 INFO - 1499411838554 Marionette TRACE 370 <- [1,5,null,{"value":true}]
00:17:18 INFO - 1499411838556 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}]
00:17:18 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499411838558 Marionette TRACE 370 <- [1,6,null,{"value":null}]
00:17:18 INFO - 1499411838559 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
00:17:18 INFO - 1499411838561 Marionette TRACE 370 <- [1,7,null,{}]
00:17:18 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 358ms
00:17:18 INFO - TEST-START | test_click.py TestClick.test_css_transforms
00:17:18 INFO - 1499411838563 Marionette DEBUG Closed connection 370
00:17:18 INFO - 1499411838563 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49768
00:17:18 INFO - 1499411838564 Marionette DEBUG Closed connection 371
00:17:18 INFO - 1499411838565 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49769
00:17:18 INFO - 1499411838566 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838567 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838569 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838572 Marionette TRACE 372 <- [1,1,null,{"sessionId":"f32a7f5f-413f-41e5-b7a7-dc208b400b81","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838573 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
00:17:18 INFO - 1499411838574 Marionette TRACE 372 <- [1,2,null,{}]
00:17:18 INFO - 1499411838575 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:18 INFO - 1499411838576 Marionette TRACE 372 <- [1,3,null,{}]
00:17:18 INFO - 1499411838577 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:18 INFO - 1499411838577 Marionette TRACE 372 <- [1,4,null,{}]
00:17:18 INFO - 1499411838579 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}]
00:17:18 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499411838581 Marionette TRACE 372 <- [1,5,null,{"value":null}]
00:17:18 INFO - 1499411838582 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
00:17:18 INFO - 1499411838584 Marionette TRACE 372 <- [1,6,null,{}]
00:17:18 INFO - 1499411838586 Marionette DEBUG Closed connection 372
00:17:18 INFO - 1499411838586 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49770
00:17:18 INFO - 1499411838587 Marionette DEBUG Closed connection 373
00:17:18 INFO - 1499411838588 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49771
00:17:18 INFO - 1499411838589 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838589 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838592 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838595 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c9a60926-b003-411f-a48d-81f093c411ac","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838597 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
00:17:18 INFO - 1499411838599 Marionette TRACE 374 <- [1,2,null,{}]
00:17:18 INFO - 1499411838601 Marionette DEBUG Closed connection 374
00:17:18 INFO - 1499411838601 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49772
00:17:18 INFO - 1499411838602 Marionette DEBUG Closed connection 375
00:17:18 INFO - 1499411838603 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49773
00:17:18 INFO - 1499411838604 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:18 INFO - 1499411838604 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838607 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838610 Marionette TRACE 376 <- [1,1,null,{"sessionId":"5a608390-9a7a-4733-b78a-184ea0d3df39","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838611 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"}]
00:17:18 INFO - 1499411838613 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"
00:17:18 INFO - 1499411838615 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"
00:17:18 INFO - 1499411838615 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"
00:17:18 INFO - 1499411838628 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"
00:17:18 INFO - 1499411838632 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"
00:17:18 INFO - 1499411838641 Marionette TRACE 376 <- [1,2,null,{}]
00:17:18 INFO - 1499411838643 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
00:17:18 INFO - 1499411838645 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e6ac5582-90e3-4514-a915-45105e0a2ef0","ELEMENT":"e6ac5582-90e3-4514-a915-45105e0a2ef0"}}]
00:17:18 INFO - 1499411838647 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"e6ac5582-90e3-4514-a915-45105e0a2ef0"}]
00:17:18 INFO - 1499411838888 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:17:18 INFO - 1499411838889 Marionette TRACE 376 <- [1,4,null,{}]
00:17:18 INFO - 1499411838891 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}]
00:17:18 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499411838893 Marionette TRACE 376 <- [1,5,null,{"value":null}]
00:17:18 INFO - 1499411838894 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
00:17:18 INFO - 1499411838896 Marionette TRACE 376 <- [1,6,null,{}]
00:17:18 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 335ms
00:17:18 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
00:17:18 INFO - 1499411838898 Marionette DEBUG Closed connection 376
00:17:18 INFO - 1499411838898 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49774
00:17:18 INFO - 1499411838899 Marionette DEBUG Closed connection 377
00:17:18 INFO - 1499411838900 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49775
00:17:18 INFO - 1499411838901 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838901 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838904 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838907 Marionette TRACE 378 <- [1,1,null,{"sessionId":"bb32ca55-72d4-4360-9127-348748119623","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838908 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
00:17:18 INFO - 1499411838909 Marionette TRACE 378 <- [1,2,null,{}]
00:17:18 INFO - 1499411838910 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:18 INFO - 1499411838910 Marionette TRACE 378 <- [1,3,null,{}]
00:17:18 INFO - 1499411838911 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:18 INFO - 1499411838912 Marionette TRACE 378 <- [1,4,null,{}]
00:17:18 INFO - 1499411838913 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}]
00:17:18 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499411838916 Marionette TRACE 378 <- [1,5,null,{"value":null}]
00:17:18 INFO - 1499411838917 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
00:17:18 INFO - 1499411838918 Marionette TRACE 378 <- [1,6,null,{}]
00:17:18 INFO - 1499411838920 Marionette DEBUG Closed connection 378
00:17:18 INFO - 1499411838921 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49776
00:17:18 INFO - 1499411838922 Marionette DEBUG Closed connection 379
00:17:18 INFO - 1499411838922 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49777
00:17:18 INFO - 1499411838923 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:18 INFO - 1499411838924 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838926 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838930 Marionette TRACE 380 <- [1,1,null,{"sessionId":"b3ef3b6d-1c09-40b4-b8bb-a79f91cab496","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838931 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
00:17:18 INFO - 1499411838932 Marionette TRACE 380 <- [1,2,null,{}]
00:17:18 INFO - 1499411838934 Marionette DEBUG Closed connection 380
00:17:18 INFO - 1499411838934 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49778
00:17:18 INFO - 1499411838935 Marionette DEBUG Closed connection 381
00:17:18 INFO - 1499411838936 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49779
00:17:18 INFO - 1499411838937 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:18 INFO - 1499411838937 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:18 INFO - 1499411838940 Marionette DEBUG Register listener.js for window 12
00:17:18 INFO - 1499411838943 Marionette TRACE 382 <- [1,1,null,{"sessionId":"b5ca9987-c4ea-45d6-bfa8-64dda04cceca","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:18 INFO - 1499411838944 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"}]
00:17:18 INFO - 1499411838946 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"
00:17:18 INFO - 1499411838948 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"
00:17:18 INFO - 1499411838948 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"
00:17:18 INFO - 1499411838959 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"
00:17:18 INFO - 1499411838964 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"
00:17:18 INFO - 1499411838973 Marionette TRACE 382 <- [1,2,null,{}]
00:17:18 INFO - 1499411838976 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
00:17:18 INFO - 1499411838978 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a0844ea2-4042-40d5-981a-903383f29885","ELEMENT":"a0844ea2-4042-40d5-981a-903383f29885"}}]
00:17:18 INFO - 1499411838979 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"a0844ea2-4042-40d5-981a-903383f29885"}]
00:17:19 INFO - 1499411839231 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:17:19 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 343ms
00:17:19 INFO - 1499411839232 Marionette TRACE 382 <- [1,4,null,{}]
00:17:19 INFO - 1499411839233 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}]
00:17:19 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499411839236 Marionette TRACE 382 <- [1,5,null,{"value":null}]
00:17:19 INFO - 1499411839237 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
00:17:19 INFO - TEST-START | test_click.py TestClick.test_input_file
00:17:19 INFO - 1499411839239 Marionette TRACE 382 <- [1,6,null,{}]
00:17:19 INFO - 1499411839241 Marionette DEBUG Closed connection 382
00:17:19 INFO - 1499411839243 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49780
00:17:19 INFO - 1499411839244 Marionette DEBUG Closed connection 383
00:17:19 INFO - 1499411839244 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49781
00:17:19 INFO - 1499411839245 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839246 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839249 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839252 Marionette TRACE 384 <- [1,1,null,{"sessionId":"d0397003-404c-4bce-a53e-b6a9bc972296","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839253 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
00:17:19 INFO - 1499411839254 Marionette TRACE 384 <- [1,2,null,{}]
00:17:19 INFO - 1499411839255 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:19 INFO - 1499411839255 Marionette TRACE 384 <- [1,3,null,{}]
00:17:19 INFO - 1499411839256 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:19 INFO - 1499411839256 Marionette TRACE 384 <- [1,4,null,{}]
00:17:19 INFO - 1499411839258 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}]
00:17:19 INFO - TEST-START: test_click.py TestClick.test_input_file1499411839260 Marionette TRACE 384 <- [1,5,null,{"value":null}]
00:17:19 INFO - 1499411839261 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
00:17:19 INFO - 1499411839263 Marionette TRACE 384 <- [1,6,null,{}]
00:17:19 INFO - 1499411839265 Marionette DEBUG Closed connection 384
00:17:19 INFO - 1499411839265 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49782
00:17:19 INFO - 1499411839266 Marionette DEBUG Closed connection 385
00:17:19 INFO - 1499411839267 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49783
00:17:19 INFO - 1499411839268 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839268 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839271 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839280 Marionette TRACE 386 <- [1,1,null,{"sessionId":"6a6f17b5-d1a3-4ca0-b584-c6c324bc739e","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839281 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
00:17:19 INFO - 1499411839283 Marionette TRACE 386 <- [1,2,null,{}]
00:17:19 INFO - 1499411839285 Marionette DEBUG Closed connection 386
00:17:19 INFO - 1499411839286 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49784
00:17:19 INFO - 1499411839287 Marionette DEBUG Closed connection 387
00:17:19 INFO - 1499411839287 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49785
00:17:19 INFO - 1499411839288 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:19 INFO - 1499411839289 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839292 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839295 Marionette TRACE 388 <- [1,1,null,{"sessionId":"6dc50d5f-3f7a-4813-ac54-f60422de2fe1","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839296 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
00:17:19 INFO - 1499411839297 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"
00:17:19 INFO - 1499411839300 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"
00:17:19 INFO - 1499411839300 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"
00:17:19 INFO - 1499411839312 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:17:19 INFO - 1499411839324 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:17:19 INFO - 1499411839327 Marionette TRACE 388 <- [1,2,null,{}]
00:17:19 INFO - 1499411839328 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
00:17:19 INFO - 1499411839336 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dedf53be-9c19-4236-8a80-0f63b0e4f1b3","ELEMENT":"dedf53be-9c19-4236-8a80-0f63b0e4f1b3"}}]
00:17:19 INFO - 1499411839337 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"dedf53be-9c19-4236-8a80-0f63b0e4f1b3"}]
00:17:19 INFO - 1499411839366 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
00:17:19 INFO - 1499411839368 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}]
00:17:19 INFO - TEST-END: test_click.py TestClick.test_input_file1499411839371 Marionette TRACE 388 <- [1,5,null,{"value":null}]
00:17:19 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 146ms
00:17:19 INFO - TEST-START | test_click.py TestClick.test_obscured_element
00:17:19 INFO - 1499411839383 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
00:17:19 INFO - 1499411839386 Marionette TRACE 388 <- [1,6,null,{}]
00:17:19 INFO - 1499411839389 Marionette DEBUG Closed connection 388
00:17:19 INFO - 1499411839390 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49786
00:17:19 INFO - 1499411839391 Marionette DEBUG Closed connection 389
00:17:19 INFO - 1499411839392 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49787
00:17:19 INFO - 1499411839394 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839396 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839399 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839406 Marionette TRACE 390 <- [1,1,null,{"sessionId":"491c6285-f17f-41a0-bfbb-eb264a6d58af","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839408 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
00:17:19 INFO - 1499411839409 Marionette TRACE 390 <- [1,2,null,{}]
00:17:19 INFO - 1499411839411 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:19 INFO - 1499411839412 Marionette TRACE 390 <- [1,3,null,{}]
00:17:19 INFO - 1499411839414 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:19 INFO - 1499411839415 Marionette TRACE 390 <- [1,4,null,{}]
00:17:19 INFO - 1499411839416 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}]
00:17:19 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499411839421 Marionette TRACE 390 <- [1,5,null,{"value":null}]
00:17:19 INFO - 1499411839422 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
00:17:19 INFO - 1499411839424 Marionette TRACE 390 <- [1,6,null,{}]
00:17:19 INFO - 1499411839427 Marionette DEBUG Closed connection 390
00:17:19 INFO - 1499411839428 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49788
00:17:19 INFO - 1499411839429 Marionette DEBUG Closed connection 391
00:17:19 INFO - 1499411839430 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49789
00:17:19 INFO - 1499411839432 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839433 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839436 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839441 Marionette TRACE 392 <- [1,1,null,{"sessionId":"2d92ad2d-3585-4feb-8d7d-9f4fd13107dd","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839443 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
00:17:19 INFO - 1499411839445 Marionette TRACE 392 <- [1,2,null,{}]
00:17:19 INFO - 1499411839447 Marionette DEBUG Closed connection 392
00:17:19 INFO - 1499411839448 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49790
00:17:19 INFO - 1499411839449 Marionette DEBUG Closed connection 393
00:17:19 INFO - 1499411839450 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49791
00:17:19 INFO - 1499411839451 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:19 INFO - 1499411839452 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839455 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839460 Marionette TRACE 394 <- [1,1,null,{"sessionId":"890ad7be-457d-44d5-a238-1d6d01233be4","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839463 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"}]
00:17:19 INFO - 1499411839466 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:17:19 INFO - 1499411839469 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:17:19 INFO - 1499411839469 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
00:17:19 INFO - 1499411839506 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"
00:17:19 INFO - 1499411839509 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"
00:17:19 INFO - 1499411839513 Marionette TRACE 394 <- [1,2,null,{}]
00:17:19 INFO - 1499411839519 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
00:17:19 INFO - 1499411839523 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"281122a9-d176-4333-b0e3-29d1a88cb195","ELEMENT":"281122a9-d176-4333-b0e3-29d1a88cb195"}}]
00:17:19 INFO - 1499411839524 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
00:17:19 INFO - 1499411839527 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5980f05b-b0ea-4056-be5f-0b3759940ea1","ELEMENT":"5980f05b-b0ea-4056-be5f-0b3759940ea1"}}]
00:17:19 INFO - 1499411839528 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"281122a9-d176-4333-b0e3-29d1a88cb195"}]
00:17:19 INFO - 1499411839781 Marionette DEBUG Canceled page load listener because no navigation has been detected
00:17:19 INFO - 1499411839782 Marionette TRACE 394 <- [1,5,null,{}]
00:17:19 INFO - 1499411839783 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"5980f05b-b0ea-4056-be5f-0b3759940ea1"}]
00:17:19 INFO - 1499411839803 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
00:17:19 INFO - 1499411839805 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
00:17:19 INFO - 1499411839808 Marionette TRACE 394 <- [1,7,null,{"value":false}]
00:17:19 INFO - 1499411839810 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}]
00:17:19 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499411839814 Marionette TRACE 394 <- [1,8,null,{"value":null}]
00:17:19 INFO - 1499411839815 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
00:17:19 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 429ms
00:17:19 INFO - 1499411839816 Marionette TRACE 394 <- [1,9,null,{}]
00:17:19 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
00:17:19 INFO - 1499411839819 Marionette DEBUG Closed connection 394
00:17:19 INFO - 1499411839819 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49792
00:17:19 INFO - 1499411839820 Marionette DEBUG Closed connection 395
00:17:19 INFO - 1499411839821 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49793
00:17:19 INFO - 1499411839823 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839824 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839827 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839832 Marionette TRACE 396 <- [1,1,null,{"sessionId":"55d61374-405e-4a7e-a1b3-9104e192e9f9","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839833 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
00:17:19 INFO - 1499411839834 Marionette TRACE 396 <- [1,2,null,{}]
00:17:19 INFO - 1499411839835 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
00:17:19 INFO - 1499411839836 Marionette TRACE 396 <- [1,3,null,{}]
00:17:19 INFO - 1499411839837 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
00:17:19 INFO - 1499411839838 Marionette TRACE 396 <- [1,4,null,{}]
00:17:19 INFO - 1499411839839 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}]
00:17:19 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499411839842 Marionette TRACE 396 <- [1,5,null,{"value":null}]
00:17:19 INFO - 1499411839843 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
00:17:19 INFO - 1499411839845 Marionette TRACE 396 <- [1,6,null,{}]
00:17:19 INFO - 1499411839847 Marionette DEBUG Closed connection 396
00:17:19 INFO - 1499411839848 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49794
00:17:19 INFO - 1499411839849 Marionette DEBUG Closed connection 397
00:17:19 INFO - 1499411839850 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49795
00:17:19 INFO - 1499411839851 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
00:17:19 INFO - 1499411839852 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839855 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839860 Marionette TRACE 398 <- [1,1,null,{"sessionId":"56d9496b-27aa-4f37-9936-0898c05a209e","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839862 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
00:17:19 INFO - 1499411839864 Marionette TRACE 398 <- [1,2,null,{}]
00:17:19 INFO - 1499411839938 Marionette DEBUG Closed connection 398
00:17:19 INFO - 1499411839939 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49796
00:17:19 INFO - 1499411839941 Marionette DEBUG Closed connection 399
00:17:19 INFO - 1499411839942 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49797
00:17:19 INFO - 1499411839943 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
00:17:19 INFO - 1499411839947 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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}
00:17:19 INFO - 1499411839949 Marionette DEBUG Register listener.js for window 12
00:17:19 INFO - 1499411839957 Marionette TRACE 400 <- [1,1,null,{"sessionId":"f591c93d-7644-4093-94b2-ea74849ae746","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":888,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-083.001\\AppData\\Local\\Temp\\tmp25ejgt.mozrunner","moz:accessibilityChecks":false}}]
00:17:19 INFO - 1499411839959 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"}]
00:17:19 INFO - 1499411839961 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"
00:17:19 INFO - 1499411839971 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"
00:17:19 INFO - 1499411839972 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"
00:17:20 INFO - 1499411839993 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"
00:17:20 INFO - 1499411839997 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"
00:17:20 INFO - 1499411840008 Marionette TRACE 400 <- [1,2,null,{}]
00:17:20 INFO - 1499411840011 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
00:17:20 INFO - 1499411840015 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7d043e15-eb3d-41ae-b3d0-42a746754d34","ELEMENT":"7d043e15-eb3d-41ae-b3d0-42a746754d34"}}]
00:17:20 INFO - 1499411840027 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"7d043e15-eb3d-41ae-b3d0-42a746754d34"}]
00:17:20 INFO - 1499411840056 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
00:17:20 INFO - 1499411840057 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"7d043e15-eb3d-41ae-b3d0-42a746754d34"}]
00:17:20 INFO - 1499411840076 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element