could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:37:49 INFO - 1500406669661 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
12:37:49 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500406669664 Marionette TRACE 352 <- [1,5,null,{"value":null}]
12:37:49 INFO - 1500406669665 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
12:37:49 INFO - 1500406669666 Marionette TRACE 352 <- [1,6,null,{}]
12:37:49 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 122ms
12:37:49 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
12:37:49 INFO - 1500406669668 Marionette DEBUG Closed connection 352
12:37:49 INFO - 1500406669669 Marionette DEBUG Accepted connection 353 from 127.0.0.1:50015
12:37:49 INFO - 1500406669669 Marionette DEBUG Closed connection 353
12:37:49 INFO - 1500406669670 Marionette DEBUG Accepted connection 354 from 127.0.0.1:50016
12:37:49 INFO - 1500406669671 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:49 INFO - 1500406669672 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669674 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669678 Marionette TRACE 354 <- [1,1,null,{"sessionId":"16349f34-6c85-4d8d-943d-0a65772f2aab","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669679 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
12:37:49 INFO - 1500406669679 Marionette TRACE 354 <- [1,2,null,{}]
12:37:49 INFO - 1500406669680 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:49 INFO - 1500406669681 Marionette TRACE 354 <- [1,3,null,{}]
12:37:49 INFO - 1500406669682 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:49 INFO - 1500406669682 Marionette TRACE 354 <- [1,4,null,{}]
12:37:49 INFO - 1500406669684 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
12:37:49 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500406669686 Marionette TRACE 354 <- [1,5,null,{"value":null}]
12:37:49 INFO - 1500406669687 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
12:37:49 INFO - 1500406669688 Marionette TRACE 354 <- [1,6,null,{}]
12:37:49 INFO - 1500406669690 Marionette DEBUG Closed connection 354
12:37:49 INFO - 1500406669690 Marionette DEBUG Accepted connection 355 from 127.0.0.1:50017
12:37:49 INFO - 1500406669691 Marionette DEBUG Closed connection 355
12:37:49 INFO - 1500406669692 Marionette DEBUG Accepted connection 356 from 127.0.0.1:50018
12:37:49 INFO - 1500406669693 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:49 INFO - 1500406669693 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669695 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669698 Marionette TRACE 356 <- [1,1,null,{"sessionId":"f344af67-4bad-44c0-a4d7-2af5c7e76031","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669699 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
12:37:49 INFO - 1500406669700 Marionette TRACE 356 <- [1,2,null,{}]
12:37:49 INFO - 1500406669701 Marionette DEBUG Closed connection 356
12:37:49 INFO - 1500406669702 Marionette DEBUG Accepted connection 357 from 127.0.0.1:50019
12:37:49 INFO - 1500406669702 Marionette DEBUG Closed connection 357
12:37:49 INFO - 1500406669703 Marionette DEBUG Accepted connection 358 from 127.0.0.1:50020
12:37:49 INFO - 1500406669704 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:49 INFO - 1500406669705 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669707 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669709 Marionette TRACE 358 <- [1,1,null,{"sessionId":"f3a28f33-eadf-40dc-9a5d-d68cb4e66242","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669710 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49567/clicks.html"}]
12:37:49 INFO - 1500406669712 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49567/hidden.html"
12:37:49 INFO - 1500406669722 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49567/hidden.html"
12:37:49 INFO - 1500406669722 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49567/hidden.html"
12:37:49 INFO - 1500406669728 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49567/clicks.html"
12:37:49 INFO - 1500406669732 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49567/clicks.html"
12:37:49 INFO - 1500406669736 Marionette TRACE 358 <- [1,2,null,{}]
12:37:49 INFO - 1500406669739 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
12:37:49 INFO - 1500406669742 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"244ddd61-1b91-4587-9f09-8a677c4aaa59","ELEMENT":"244ddd61-1b91-4587-9f09-8a677c4aaa59"}}]
12:37:49 INFO - 1500406669742 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"244ddd61-1b91-4587-9f09-8a677c4aaa59"}]
12:37:49 INFO - 1500406669779 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49567/clicks.html"
12:37:49 INFO - 1500406669785 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49567/clicks.html"
12:37:49 INFO - 1500406669785 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49567/clicks.html"
12:37:49 INFO - 1500406669792 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49567/test.html"
12:37:49 INFO - 1500406669794 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49567/test.html"
12:37:49 INFO - 1500406669797 Marionette TRACE 358 <- [1,4,null,{}]
12:37:49 INFO - 1500406669805 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
12:37:49 INFO - 1500406669809 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7013e9ee-e005-4c12-af7d-c23a58978d65","ELEMENT":"7013e9ee-e005-4c12-af7d-c23a58978d65"}}]
12:37:49 INFO - 1500406669810 Marionette TRACE 358 -> [0,6,"getTitle",{}]
12:37:49 INFO - 1500406669810 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
12:37:49 INFO - 1500406669812 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
12:37:49 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500406669815 Marionette TRACE 358 <- [1,7,null,{"value":null}]
12:37:49 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 151ms
12:37:49 INFO - TEST-START | test_click.py TestClick.test_container_element
12:37:49 INFO - 1500406669816 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
12:37:49 INFO - 1500406669817 Marionette TRACE 358 <- [1,8,null,{}]
12:37:49 INFO - 1500406669820 Marionette DEBUG Closed connection 358
12:37:49 INFO - 1500406669820 Marionette DEBUG Accepted connection 359 from 127.0.0.1:50023
12:37:49 INFO - 1500406669821 Marionette DEBUG Closed connection 359
12:37:49 INFO - 1500406669822 Marionette DEBUG Accepted connection 360 from 127.0.0.1:50024
12:37:49 INFO - 1500406669823 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:49 INFO - 1500406669823 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669826 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669828 Marionette TRACE 360 <- [1,1,null,{"sessionId":"fd9f9e81-e984-468e-acb9-73c1ca5586b1","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669829 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
12:37:49 INFO - 1500406669830 Marionette TRACE 360 <- [1,2,null,{}]
12:37:49 INFO - 1500406669831 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:49 INFO - 1500406669831 Marionette TRACE 360 <- [1,3,null,{}]
12:37:49 INFO - 1500406669832 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:49 INFO - 1500406669832 Marionette TRACE 360 <- [1,4,null,{}]
12:37:49 INFO - 1500406669834 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
12:37:49 INFO - TEST-START: test_click.py TestClick.test_container_element1500406669836 Marionette TRACE 360 <- [1,5,null,{"value":null}]
12:37:49 INFO - 1500406669837 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
12:37:49 INFO - 1500406669838 Marionette TRACE 360 <- [1,6,null,{}]
12:37:49 INFO - 1500406669840 Marionette DEBUG Closed connection 360
12:37:49 INFO - 1500406669840 Marionette DEBUG Accepted connection 361 from 127.0.0.1:50025
12:37:49 INFO - 1500406669841 Marionette DEBUG Closed connection 361
12:37:49 INFO - 1500406669842 Marionette DEBUG Accepted connection 362 from 127.0.0.1:50026
12:37:49 INFO - 1500406669843 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:49 INFO - 1500406669843 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669845 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669848 Marionette TRACE 362 <- [1,1,null,{"sessionId":"bfd551fe-a5cb-461b-9a60-ab688c564888","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669849 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
12:37:49 INFO - 1500406669850 Marionette TRACE 362 <- [1,2,null,{}]
12:37:49 INFO - 1500406669851 Marionette DEBUG Closed connection 362
12:37:49 INFO - 1500406669852 Marionette DEBUG Accepted connection 363 from 127.0.0.1:50027
12:37:49 INFO - 1500406669852 Marionette DEBUG Closed connection 363
12:37:49 INFO - 1500406669853 Marionette DEBUG Accepted connection 364 from 127.0.0.1:50028
12:37:49 INFO - 1500406669854 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:49 INFO - 1500406669855 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:49 INFO - 1500406669857 Marionette DEBUG Register listener.js for window 2147483652
12:37:49 INFO - 1500406669859 Marionette TRACE 364 <- [1,1,null,{"sessionId":"f1839f93-c43c-4bc3-8754-7cfc60d4b81f","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:49 INFO - 1500406669860 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:37:49 INFO - 1500406669862 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49567/test.html"
12:37:49 INFO - 1500406669864 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49567/test.html"
12:37:49 INFO - 1500406669864 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49567/test.html"
12:37:49 INFO - 1500406669870 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:49 INFO - 1500406669872 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:49 INFO - 1500406669876 Marionette TRACE 364 <- [1,2,null,{}]
12:37:49 INFO - 1500406669880 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:37:49 INFO - 1500406669882 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"af8d87f4-a5d0-4541-abbb-0f95ebc75c23","ELEMENT":"af8d87f4-a5d0-4541-abbb-0f95ebc75c23"}}]
12:37:49 INFO - 1500406669890 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"af8d87f4-a5d0-4541-abbb-0f95ebc75c23"}]
12:37:50 INFO - 1500406670134 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:37:50 INFO - 1500406670135 Marionette TRACE 364 <- [1,4,null,{}]
12:37:50 INFO - 1500406670136 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"af8d87f4-a5d0-4541-abbb-0f95ebc75c23","name":"selected"}]
12:37:50 INFO - 1500406670142 Marionette TRACE 364 <- [1,5,null,{"value":true}]
12:37:50 INFO - 1500406670144 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
12:37:50 INFO - TEST-END: test_click.py TestClick.test_container_element1500406670147 Marionette TRACE 364 <- [1,6,null,{"value":null}]
12:37:50 INFO - 1500406670148 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
12:37:50 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 332ms
12:37:50 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
12:37:50 INFO - 1500406670149 Marionette TRACE 364 <- [1,7,null,{}]
12:37:50 INFO - 1500406670150 Marionette DEBUG Closed connection 364
12:37:50 INFO - 1500406670151 Marionette DEBUG Accepted connection 365 from 127.0.0.1:50029
12:37:50 INFO - 1500406670152 Marionette DEBUG Closed connection 365
12:37:50 INFO - 1500406670153 Marionette DEBUG Accepted connection 366 from 127.0.0.1:50030
12:37:50 INFO - 1500406670154 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670155 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670176 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670185 Marionette TRACE 366 <- [1,1,null,{"sessionId":"22276852-defa-4f5b-b447-622833ad153b","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670186 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
12:37:50 INFO - 1500406670186 Marionette TRACE 366 <- [1,2,null,{}]
12:37:50 INFO - 1500406670187 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:50 INFO - 1500406670188 Marionette TRACE 366 <- [1,3,null,{}]
12:37:50 INFO - 1500406670188 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:50 INFO - 1500406670189 Marionette TRACE 366 <- [1,4,null,{}]
12:37:50 INFO - 1500406670190 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
12:37:50 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500406670204 Marionette TRACE 366 <- [1,5,null,{"value":null}]
12:37:50 INFO - 1500406670205 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
12:37:50 INFO - 1500406670206 Marionette TRACE 366 <- [1,6,null,{}]
12:37:50 INFO - 1500406670208 Marionette DEBUG Closed connection 366
12:37:50 INFO - 1500406670208 Marionette DEBUG Accepted connection 367 from 127.0.0.1:50031
12:37:50 INFO - 1500406670209 Marionette DEBUG Closed connection 367
12:37:50 INFO - 1500406670210 Marionette DEBUG Accepted connection 368 from 127.0.0.1:50032
12:37:50 INFO - 1500406670211 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670211 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670215 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670226 Marionette TRACE 368 <- [1,1,null,{"sessionId":"e9369e1b-22d9-4453-98cb-b7f3d65edc73","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670228 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
12:37:50 INFO - 1500406670229 Marionette TRACE 368 <- [1,2,null,{}]
12:37:50 INFO - 1500406670231 Marionette DEBUG Closed connection 368
12:37:50 INFO - 1500406670231 Marionette DEBUG Accepted connection 369 from 127.0.0.1:50033
12:37:50 INFO - 1500406670232 Marionette DEBUG Closed connection 369
12:37:50 INFO - 1500406670233 Marionette DEBUG Accepted connection 370 from 127.0.0.1:50034
12:37:50 INFO - 1500406670234 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:50 INFO - 1500406670234 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670237 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670240 Marionette TRACE 370 <- [1,1,null,{"sessionId":"5395307f-6a25-4f14-abbb-4ade81a851af","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670241 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:37:50 INFO - 1500406670292 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670295 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670296 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670313 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670315 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670316 Marionette TRACE 370 <- [1,2,null,{}]
12:37:50 INFO - 1500406670321 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
12:37:50 INFO - 1500406670329 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"404227ef-d270-4aa1-b2c1-15b29b0fa792","ELEMENT":"404227ef-d270-4aa1-b2c1-15b29b0fa792"}}]
12:37:50 INFO - 1500406670330 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"404227ef-d270-4aa1-b2c1-15b29b0fa792"}]
12:37:50 INFO - 1500406670574 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:37:50 INFO - 1500406670575 Marionette TRACE 370 <- [1,4,null,{}]
12:37:50 INFO - 1500406670576 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"404227ef-d270-4aa1-b2c1-15b29b0fa792","name":"selected"}]
12:37:50 INFO - 1500406670580 Marionette TRACE 370 <- [1,5,null,{"value":true}]
12:37:50 INFO - 1500406670582 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
12:37:50 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500406670584 Marionette TRACE 370 <- [1,6,null,{"value":null}]
12:37:50 INFO - 1500406670585 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
12:37:50 INFO - 1500406670586 Marionette TRACE 370 <- [1,7,null,{}]
12:37:50 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 437ms
12:37:50 INFO - TEST-START | test_click.py TestClick.test_css_transforms
12:37:50 INFO - 1500406670588 Marionette DEBUG Closed connection 370
12:37:50 INFO - 1500406670589 Marionette DEBUG Accepted connection 371 from 127.0.0.1:50035
12:37:50 INFO - 1500406670590 Marionette DEBUG Closed connection 371
12:37:50 INFO - 1500406670590 Marionette DEBUG Accepted connection 372 from 127.0.0.1:50036
12:37:50 INFO - 1500406670591 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670592 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670594 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670597 Marionette TRACE 372 <- [1,1,null,{"sessionId":"6e03f1be-a911-4db2-a761-88643044d2a7","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670598 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
12:37:50 INFO - 1500406670599 Marionette TRACE 372 <- [1,2,null,{}]
12:37:50 INFO - 1500406670600 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:50 INFO - 1500406670600 Marionette TRACE 372 <- [1,3,null,{}]
12:37:50 INFO - 1500406670601 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:50 INFO - 1500406670601 Marionette TRACE 372 <- [1,4,null,{}]
12:37:50 INFO - 1500406670603 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
12:37:50 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500406670605 Marionette TRACE 372 <- [1,5,null,{"value":null}]
12:37:50 INFO - 1500406670606 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
12:37:50 INFO - 1500406670607 Marionette TRACE 372 <- [1,6,null,{}]
12:37:50 INFO - 1500406670609 Marionette DEBUG Closed connection 372
12:37:50 INFO - 1500406670609 Marionette DEBUG Accepted connection 373 from 127.0.0.1:50037
12:37:50 INFO - 1500406670610 Marionette DEBUG Closed connection 373
12:37:50 INFO - 1500406670611 Marionette DEBUG Accepted connection 374 from 127.0.0.1:50038
12:37:50 INFO - 1500406670612 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670612 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670614 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670617 Marionette TRACE 374 <- [1,1,null,{"sessionId":"47a6d3d5-2adf-454c-89fc-2fd538e62c29","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670618 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
12:37:50 INFO - 1500406670619 Marionette TRACE 374 <- [1,2,null,{}]
12:37:50 INFO - 1500406670620 Marionette DEBUG Closed connection 374
12:37:50 INFO - 1500406670621 Marionette DEBUG Accepted connection 375 from 127.0.0.1:50039
12:37:50 INFO - 1500406670622 Marionette DEBUG Closed connection 375
12:37:50 INFO - 1500406670622 Marionette DEBUG Accepted connection 376 from 127.0.0.1:50040
12:37:50 INFO - 1500406670623 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:50 INFO - 1500406670624 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670626 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670629 Marionette TRACE 376 <- [1,1,null,{"sessionId":"f9618d27-46f4-4e6d-b894-4a7aaa531e6a","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670630 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
12:37:50 INFO - 1500406670632 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670634 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670634 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670640 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:37:50 INFO - 1500406670642 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:37:50 INFO - 1500406670644 Marionette TRACE 376 <- [1,2,null,{}]
12:37:50 INFO - 1500406670647 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
12:37:50 INFO - 1500406670649 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"425f0add-0f55-4eb0-9237-ce512a931bc9","ELEMENT":"425f0add-0f55-4eb0-9237-ce512a931bc9"}}]
12:37:50 INFO - 1500406670656 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"425f0add-0f55-4eb0-9237-ce512a931bc9"}]
12:37:50 INFO - 1500406670896 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:37:50 INFO - 1500406670896 Marionette TRACE 376 <- [1,4,null,{}]
12:37:50 INFO - 1500406670898 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
12:37:50 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500406670901 Marionette TRACE 376 <- [1,5,null,{"value":null}]
12:37:50 INFO - 1500406670902 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
12:37:50 INFO - 1500406670903 Marionette TRACE 376 <- [1,6,null,{}]
12:37:50 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 316ms
12:37:50 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
12:37:50 INFO - 1500406670905 Marionette DEBUG Closed connection 376
12:37:50 INFO - 1500406670906 Marionette DEBUG Accepted connection 377 from 127.0.0.1:50041
12:37:50 INFO - 1500406670907 Marionette DEBUG Closed connection 377
12:37:50 INFO - 1500406670907 Marionette DEBUG Accepted connection 378 from 127.0.0.1:50042
12:37:50 INFO - 1500406670908 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670909 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670911 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670914 Marionette TRACE 378 <- [1,1,null,{"sessionId":"ca6d21db-c338-410a-bdad-0f3ff8532acd","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670915 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
12:37:50 INFO - 1500406670916 Marionette TRACE 378 <- [1,2,null,{}]
12:37:50 INFO - 1500406670916 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:50 INFO - 1500406670917 Marionette TRACE 378 <- [1,3,null,{}]
12:37:50 INFO - 1500406670918 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:50 INFO - 1500406670918 Marionette TRACE 378 <- [1,4,null,{}]
12:37:50 INFO - 1500406670920 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
12:37:50 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500406670923 Marionette TRACE 378 <- [1,5,null,{"value":null}]
12:37:50 INFO - 1500406670924 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
12:37:50 INFO - 1500406670925 Marionette TRACE 378 <- [1,6,null,{}]
12:37:50 INFO - 1500406670926 Marionette DEBUG Closed connection 378
12:37:50 INFO - 1500406670926 Marionette DEBUG Accepted connection 379 from 127.0.0.1:50043
12:37:50 INFO - 1500406670927 Marionette DEBUG Closed connection 379
12:37:50 INFO - 1500406670928 Marionette DEBUG Accepted connection 380 from 127.0.0.1:50044
12:37:50 INFO - 1500406670929 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:50 INFO - 1500406670929 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670931 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670934 Marionette TRACE 380 <- [1,1,null,{"sessionId":"2eed7f22-f0b3-41d6-87c5-529b5e247931","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670935 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
12:37:50 INFO - 1500406670936 Marionette TRACE 380 <- [1,2,null,{}]
12:37:50 INFO - 1500406670938 Marionette DEBUG Closed connection 380
12:37:50 INFO - 1500406670938 Marionette DEBUG Accepted connection 381 from 127.0.0.1:50045
12:37:50 INFO - 1500406670939 Marionette DEBUG Closed connection 381
12:37:50 INFO - 1500406670940 Marionette DEBUG Accepted connection 382 from 127.0.0.1:50046
12:37:50 INFO - 1500406670941 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:50 INFO - 1500406670942 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:50 INFO - 1500406670944 Marionette DEBUG Register listener.js for window 2147483652
12:37:50 INFO - 1500406670946 Marionette TRACE 382 <- [1,1,null,{"sessionId":"0095850a-51f7-4841-8570-4a575a47c9fc","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:50 INFO - 1500406670947 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
12:37:50 INFO - 1500406670949 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:37:50 INFO - 1500406670951 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:37:50 INFO - 1500406670951 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
12:37:50 INFO - 1500406670957 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670960 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:50 INFO - 1500406670962 Marionette TRACE 382 <- [1,2,null,{}]
12:37:50 INFO - 1500406670964 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
12:37:50 INFO - 1500406670971 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c7891ae5-a44c-4380-84b2-46a42c1e53f2","ELEMENT":"c7891ae5-a44c-4380-84b2-46a42c1e53f2"}}]
12:37:50 INFO - 1500406670973 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"c7891ae5-a44c-4380-84b2-46a42c1e53f2"}]
12:37:51 INFO - 1500406671213 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:37:51 INFO - 1500406671213 Marionette TRACE 382 <- [1,4,null,{}]
12:37:51 INFO - 1500406671215 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
12:37:51 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500406671218 Marionette TRACE 382 <- [1,5,null,{"value":null}]
12:37:51 INFO - 1500406671219 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
12:37:51 INFO - 1500406671220 Marionette TRACE 382 <- [1,6,null,{}]
12:37:51 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 316ms
12:37:51 INFO - TEST-START | test_click.py TestClick.test_input_file
12:37:51 INFO - 1500406671221 Marionette DEBUG Closed connection 382
12:37:51 INFO - 1500406671222 Marionette DEBUG Accepted connection 383 from 127.0.0.1:50047
12:37:51 INFO - 1500406671223 Marionette DEBUG Closed connection 383
12:37:51 INFO - 1500406671224 Marionette DEBUG Accepted connection 384 from 127.0.0.1:50048
12:37:51 INFO - 1500406671225 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671225 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671227 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671230 Marionette TRACE 384 <- [1,1,null,{"sessionId":"44f8ce84-d518-4c35-85f9-d6e70aab3ca8","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671231 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
12:37:51 INFO - 1500406671232 Marionette TRACE 384 <- [1,2,null,{}]
12:37:51 INFO - 1500406671233 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:51 INFO - 1500406671233 Marionette TRACE 384 <- [1,3,null,{}]
12:37:51 INFO - 1500406671234 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:51 INFO - 1500406671234 Marionette TRACE 384 <- [1,4,null,{}]
12:37:51 INFO - 1500406671236 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
12:37:51 INFO - TEST-START: test_click.py TestClick.test_input_file1500406671238 Marionette TRACE 384 <- [1,5,null,{"value":null}]
12:37:51 INFO - 1500406671239 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
12:37:51 INFO - 1500406671240 Marionette TRACE 384 <- [1,6,null,{}]
12:37:51 INFO - 1500406671241 Marionette DEBUG Closed connection 384
12:37:51 INFO - 1500406671242 Marionette DEBUG Accepted connection 385 from 127.0.0.1:50049
12:37:51 INFO - 1500406671243 Marionette DEBUG Closed connection 385
12:37:51 INFO - 1500406671244 Marionette DEBUG Accepted connection 386 from 127.0.0.1:50050
12:37:51 INFO - 1500406671244 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671245 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671247 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671250 Marionette TRACE 386 <- [1,1,null,{"sessionId":"7555c2ff-4041-455e-b5cb-7569f08d57e0","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671251 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
12:37:51 INFO - 1500406671252 Marionette TRACE 386 <- [1,2,null,{}]
12:37:51 INFO - 1500406671254 Marionette DEBUG Closed connection 386
12:37:51 INFO - 1500406671255 Marionette DEBUG Accepted connection 387 from 127.0.0.1:50051
12:37:51 INFO - 1500406671255 Marionette DEBUG Closed connection 387
12:37:51 INFO - 1500406671256 Marionette DEBUG Accepted connection 388 from 127.0.0.1:50052
12:37:51 INFO - 1500406671257 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:51 INFO - 1500406671257 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671259 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671262 Marionette TRACE 388 <- [1,1,null,{"sessionId":"2486d90a-c02e-405e-aaf2-10a096454f4a","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671263 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
12:37:51 INFO - 1500406671265 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:51 INFO - 1500406671266 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:51 INFO - 1500406671267 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
12:37:51 INFO - 1500406671279 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:37:51 INFO - 1500406671282 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:37:51 INFO - 1500406671289 Marionette TRACE 388 <- [1,2,null,{}]
12:37:51 INFO - 1500406671293 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
12:37:51 INFO - 1500406671296 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a0429b95-e356-4194-881c-6159b57a59df","ELEMENT":"a0429b95-e356-4194-881c-6159b57a59df"}}]
12:37:51 INFO - 1500406671297 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"a0429b95-e356-4194-881c-6159b57a59df"}]
12:37:51 INFO - 1500406671320 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:37:51 INFO - 1500406671322 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
12:37:51 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 115ms
12:37:51 INFO - TEST-START | test_click.py TestClick.test_obscured_element
12:37:51 INFO - TEST-END: test_click.py TestClick.test_input_file1500406671334 Marionette TRACE 388 <- [1,5,null,{"value":null}]
12:37:51 INFO - 1500406671335 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
12:37:51 INFO - 1500406671336 Marionette TRACE 388 <- [1,6,null,{}]
12:37:51 INFO - 1500406671337 Marionette DEBUG Closed connection 388
12:37:51 INFO - 1500406671338 Marionette DEBUG Accepted connection 389 from 127.0.0.1:50053
12:37:51 INFO - 1500406671339 Marionette DEBUG Closed connection 389
12:37:51 INFO - 1500406671340 Marionette DEBUG Accepted connection 390 from 127.0.0.1:50054
12:37:51 INFO - 1500406671340 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671341 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671343 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671346 Marionette TRACE 390 <- [1,1,null,{"sessionId":"8eaeee04-81d3-4f12-b05f-f57823769758","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671347 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
12:37:51 INFO - 1500406671347 Marionette TRACE 390 <- [1,2,null,{}]
12:37:51 INFO - 1500406671348 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:51 INFO - 1500406671349 Marionette TRACE 390 <- [1,3,null,{}]
12:37:51 INFO - 1500406671349 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:51 INFO - 1500406671350 Marionette TRACE 390 <- [1,4,null,{}]
12:37:51 INFO - 1500406671352 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
12:37:51 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500406671354 Marionette TRACE 390 <- [1,5,null,{"value":null}]
12:37:51 INFO - 1500406671355 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
12:37:51 INFO - 1500406671356 Marionette TRACE 390 <- [1,6,null,{}]
12:37:51 INFO - 1500406671357 Marionette DEBUG Closed connection 390
12:37:51 INFO - 1500406671358 Marionette DEBUG Accepted connection 391 from 127.0.0.1:50055
12:37:51 INFO - 1500406671358 Marionette DEBUG Closed connection 391
12:37:51 INFO - 1500406671359 Marionette DEBUG Accepted connection 392 from 127.0.0.1:50056
12:37:51 INFO - 1500406671360 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671361 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671363 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671365 Marionette TRACE 392 <- [1,1,null,{"sessionId":"9aa60944-7625-4766-b6ee-a241b52789e1","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671366 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
12:37:51 INFO - 1500406671368 Marionette TRACE 392 <- [1,2,null,{}]
12:37:51 INFO - 1500406671369 Marionette DEBUG Closed connection 392
12:37:51 INFO - 1500406671369 Marionette DEBUG Accepted connection 393 from 127.0.0.1:50057
12:37:51 INFO - 1500406671370 Marionette DEBUG Closed connection 393
12:37:51 INFO - 1500406671371 Marionette DEBUG Accepted connection 394 from 127.0.0.1:50058
12:37:51 INFO - 1500406671372 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:51 INFO - 1500406671372 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671374 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671377 Marionette TRACE 394 <- [1,1,null,{"sessionId":"66644d16-423e-4ada-a729-2cc8c0b163ce","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671378 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
12:37:51 INFO - 1500406671380 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:37:51 INFO - 1500406671381 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:37:51 INFO - 1500406671382 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
12:37:51 INFO - 1500406671388 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:37:51 INFO - 1500406671390 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:37:51 INFO - 1500406671393 Marionette TRACE 394 <- [1,2,null,{}]
12:37:51 INFO - 1500406671396 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
12:37:51 INFO - 1500406671399 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7c8736f7-c175-4392-aedb-104f5de538f2","ELEMENT":"7c8736f7-c175-4392-aedb-104f5de538f2"}}]
12:37:51 INFO - 1500406671399 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
12:37:51 INFO - 1500406671407 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e9346e6b-c8fd-42e0-b421-f6b4ecee9e9b","ELEMENT":"e9346e6b-c8fd-42e0-b421-f6b4ecee9e9b"}}]
12:37:51 INFO - 1500406671408 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"7c8736f7-c175-4392-aedb-104f5de538f2"}]
12:37:51 INFO - 1500406671646 Marionette DEBUG Canceled page load listener because no navigation has been detected
12:37:51 INFO - 1500406671647 Marionette TRACE 394 <- [1,5,null,{}]
12:37:51 INFO - 1500406671648 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"e9346e6b-c8fd-42e0-b421-f6b4ecee9e9b"}]
12:37:51 INFO - 1500406671661 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
12:37:51 INFO - 1500406671663 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
12:37:51 INFO - 1500406671666 Marionette TRACE 394 <- [1,7,null,{"value":false}]
12:37:51 INFO - 1500406671668 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
12:37:51 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500406671671 Marionette TRACE 394 <- [1,8,null,{"value":null}]
12:37:51 INFO - 1500406671672 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
12:37:51 INFO - 1500406671673 Marionette TRACE 394 <- [1,9,null,{}]
12:37:51 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 337ms
12:37:51 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
12:37:51 INFO - 1500406671674 Marionette DEBUG Closed connection 394
12:37:51 INFO - 1500406671676 Marionette DEBUG Accepted connection 395 from 127.0.0.1:50059
12:37:51 INFO - 1500406671677 Marionette DEBUG Closed connection 395
12:37:51 INFO - 1500406671678 Marionette DEBUG Accepted connection 396 from 127.0.0.1:50060
12:37:51 INFO - 1500406671678 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671679 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671681 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671684 Marionette TRACE 396 <- [1,1,null,{"sessionId":"f971298b-e749-45d2-b5bf-4993d22d064c","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671685 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
12:37:51 INFO - 1500406671685 Marionette TRACE 396 <- [1,2,null,{}]
12:37:51 INFO - 1500406671686 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
12:37:51 INFO - 1500406671687 Marionette TRACE 396 <- [1,3,null,{}]
12:37:51 INFO - 1500406671687 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
12:37:51 INFO - 1500406671688 Marionette TRACE 396 <- [1,4,null,{}]
12:37:51 INFO - 1500406671689 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
12:37:51 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500406671692 Marionette TRACE 396 <- [1,5,null,{"value":null}]
12:37:51 INFO - 1500406671692 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
12:37:51 INFO - 1500406671694 Marionette TRACE 396 <- [1,6,null,{}]
12:37:51 INFO - 1500406671695 Marionette DEBUG Closed connection 396
12:37:51 INFO - 1500406671695 Marionette DEBUG Accepted connection 397 from 127.0.0.1:50061
12:37:51 INFO - 1500406671696 Marionette DEBUG Closed connection 397
12:37:51 INFO - 1500406671697 Marionette DEBUG Accepted connection 398 from 127.0.0.1:50062
12:37:51 INFO - 1500406671698 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
12:37:51 INFO - 1500406671698 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671700 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671703 Marionette TRACE 398 <- [1,1,null,{"sessionId":"3594b820-2c31-4dcf-ade0-5be7812d5cc5","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671704 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
12:37:51 INFO - 1500406671705 Marionette TRACE 398 <- [1,2,null,{}]
12:37:51 INFO - 1500406671706 Marionette DEBUG Closed connection 398
12:37:51 INFO - 1500406671706 Marionette DEBUG Accepted connection 399 from 127.0.0.1:50063
12:37:51 INFO - 1500406671707 Marionette DEBUG Closed connection 399
12:37:51 INFO - 1500406671708 Marionette DEBUG Accepted connection 400 from 127.0.0.1:50064
12:37:51 INFO - 1500406671709 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
12:37:51 INFO - 1500406671710 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}
12:37:51 INFO - 1500406671711 Marionette DEBUG Register listener.js for window 2147483652
12:37:51 INFO - 1500406671714 Marionette TRACE 400 <- [1,1,null,{"sessionId":"83da36fb-f6d4-4aec-9360-38b98fe2224b","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.1","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":5908,"moz:profile":"C:\\Users\\cltbld\\AppData\\Local\\Temp\\tmp4jc8ss.mozrunner","moz:accessibilityChecks":false}}]
12:37:51 INFO - 1500406671715 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
12:37:51 INFO - 1500406671718 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:37:51 INFO - 1500406671720 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:37:51 INFO - 1500406671721 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
12:37:51 INFO - 1500406671727 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:37:51 INFO - 1500406671729 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
12:37:51 INFO - 1500406671731 Marionette TRACE 400 <- [1,2,null,{}]
12:37:51 INFO - 1500406671740 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
12:37:51 INFO - 1500406671742 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"55d82824-efe6-461a-92b3-b773050758b3","ELEMENT":"55d82824-efe6-461a-92b3-b773050758b3"}}]
12:37:51 INFO - 1500406671743 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"55d82824-efe6-461a-92b3-b773050758b3"}]
12:37:51 INFO - 1500406671764 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
12:37:51 INFO - 1500406671765 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"55d82824-efe6-461a-92b3-b773050758b3"}]
12:37:51 INFO - 1500406671780 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element