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]
04:58:34 INFO - 1499169514690 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}]
04:58:34 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499169514693 Marionette TRACE 352 <- [1,5,null,{"value":null}]
04:58:34 INFO - 1499169514694 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
04:58:34 INFO - 1499169514695 Marionette TRACE 352 <- [1,6,null,{}]
04:58:34 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 147ms
04:58:34 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
04:58:34 INFO - 1499169514698 Marionette DEBUG Closed connection 352
04:58:34 INFO - 1499169514699 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49752
04:58:34 INFO - 1499169514700 Marionette DEBUG Closed connection 353
04:58:34 INFO - 1499169514700 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49753
04:58:34 INFO - 1499169514701 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:34 INFO - 1499169514702 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514705 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514708 Marionette TRACE 354 <- [1,1,null,{"sessionId":"66f3bcde-b220-489e-9090-7fa6b1de3a26","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514709 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
04:58:34 INFO - 1499169514709 Marionette TRACE 354 <- [1,2,null,{}]
04:58:34 INFO - 1499169514710 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:34 INFO - 1499169514711 Marionette TRACE 354 <- [1,3,null,{}]
04:58:34 INFO - 1499169514712 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:34 INFO - 1499169514712 Marionette TRACE 354 <- [1,4,null,{}]
04:58:34 INFO - 1499169514714 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}]
04:58:34 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499169514717 Marionette TRACE 354 <- [1,5,null,{"value":null}]
04:58:34 INFO - 1499169514718 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
04:58:34 INFO - 1499169514719 Marionette TRACE 354 <- [1,6,null,{}]
04:58:34 INFO - 1499169514721 Marionette DEBUG Closed connection 354
04:58:34 INFO - 1499169514722 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49754
04:58:34 INFO - 1499169514723 Marionette DEBUG Closed connection 355
04:58:34 INFO - 1499169514723 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49755
04:58:34 INFO - 1499169514724 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:34 INFO - 1499169514725 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514728 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514731 Marionette TRACE 356 <- [1,1,null,{"sessionId":"89d2f04b-e2cf-4980-8dab-644a3d2d0af8","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514732 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
04:58:34 INFO - 1499169514733 Marionette TRACE 356 <- [1,2,null,{}]
04:58:34 INFO - 1499169514735 Marionette DEBUG Closed connection 356
04:58:34 INFO - 1499169514736 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49756
04:58:34 INFO - 1499169514737 Marionette DEBUG Closed connection 357
04:58:34 INFO - 1499169514737 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49757
04:58:34 INFO - 1499169514738 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:34 INFO - 1499169514739 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514741 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514746 Marionette TRACE 358 <- [1,1,null,{"sessionId":"fbc70dce-783c-42db-ad49-4314a7e405a0","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514748 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49328/clicks.html"}]
04:58:34 INFO - 1499169514749 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/hidden.html"
04:58:34 INFO - 1499169514755 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/hidden.html"
04:58:34 INFO - 1499169514755 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/hidden.html"
04:58:34 INFO - 1499169514773 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/clicks.html"
04:58:34 INFO - 1499169514778 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/clicks.html"
04:58:34 INFO - 1499169514788 Marionette TRACE 358 <- [1,2,null,{}]
04:58:34 INFO - 1499169514792 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
04:58:34 INFO - 1499169514794 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1e29c7cb-415a-4b3c-ad2f-65ab190bdd37","ELEMENT":"1e29c7cb-415a-4b3c-ad2f-65ab190bdd37"}}]
04:58:34 INFO - 1499169514795 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"1e29c7cb-415a-4b3c-ad2f-65ab190bdd37"}]
04:58:34 INFO - 1499169514838 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/clicks.html"
04:58:34 INFO - 1499169514843 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/clicks.html"
04:58:34 INFO - 1499169514844 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/clicks.html"
04:58:34 INFO - 1499169514870 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49328/test.html"
04:58:34 INFO - 1499169514872 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49328/test.html"
04:58:34 INFO - 1499169514874 Marionette TRACE 358 <- [1,4,null,{}]
04:58:34 INFO - 1499169514875 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
04:58:34 INFO - 1499169514877 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"24f03136-6ae5-4516-abc0-796d33aae891","ELEMENT":"24f03136-6ae5-4516-abc0-796d33aae891"}}]
04:58:34 INFO - 1499169514884 Marionette TRACE 358 -> [0,6,"getTitle",{}]
04:58:34 INFO - 1499169514884 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
04:58:34 INFO - 1499169514887 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}]
04:58:34 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499169514890 Marionette TRACE 358 <- [1,7,null,{"value":null}]
04:58:34 INFO - 1499169514891 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
04:58:34 INFO - 1499169514892 Marionette TRACE 358 <- [1,8,null,{}]
04:58:34 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 195ms
04:58:34 INFO - TEST-START | test_click.py TestClick.test_container_element
04:58:34 INFO - 1499169514894 Marionette DEBUG Closed connection 358
04:58:34 INFO - 1499169514895 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49760
04:58:34 INFO - 1499169514896 Marionette DEBUG Closed connection 359
04:58:34 INFO - 1499169514897 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49761
04:58:34 INFO - 1499169514898 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:34 INFO - 1499169514899 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514902 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514905 Marionette TRACE 360 <- [1,1,null,{"sessionId":"bb63fdf3-564b-4f0d-b25d-ef58c8ab3a50","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514906 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
04:58:34 INFO - 1499169514907 Marionette TRACE 360 <- [1,2,null,{}]
04:58:34 INFO - 1499169514908 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:34 INFO - 1499169514908 Marionette TRACE 360 <- [1,3,null,{}]
04:58:34 INFO - 1499169514909 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:34 INFO - 1499169514909 Marionette TRACE 360 <- [1,4,null,{}]
04:58:34 INFO - 1499169514911 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}]
04:58:34 INFO - TEST-START: test_click.py TestClick.test_container_element1499169514915 Marionette TRACE 360 <- [1,5,null,{"value":null}]
04:58:34 INFO - 1499169514916 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
04:58:34 INFO - 1499169514917 Marionette TRACE 360 <- [1,6,null,{}]
04:58:34 INFO - 1499169514920 Marionette DEBUG Closed connection 360
04:58:34 INFO - 1499169514920 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49762
04:58:34 INFO - 1499169514921 Marionette DEBUG Closed connection 361
04:58:34 INFO - 1499169514922 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49763
04:58:34 INFO - 1499169514923 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:34 INFO - 1499169514923 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514926 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514931 Marionette TRACE 362 <- [1,1,null,{"sessionId":"ad3b7669-a625-441d-be03-205b0f78822f","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514932 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
04:58:34 INFO - 1499169514933 Marionette TRACE 362 <- [1,2,null,{}]
04:58:34 INFO - 1499169514935 Marionette DEBUG Closed connection 362
04:58:34 INFO - 1499169514936 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49764
04:58:34 INFO - 1499169514937 Marionette DEBUG Closed connection 363
04:58:34 INFO - 1499169514937 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49765
04:58:34 INFO - 1499169514938 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:34 INFO - 1499169514939 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:34 INFO - 1499169514942 Marionette DEBUG Register listener.js for window 12
04:58:34 INFO - 1499169514954 Marionette TRACE 364 <- [1,1,null,{"sessionId":"784e1e2e-fe3d-412e-b8e5-d06dc85580dc","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:34 INFO - 1499169514956 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"}]
04:58:34 INFO - 1499169514958 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49328/test.html"
04:58:34 INFO - 1499169514960 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49328/test.html"
04:58:34 INFO - 1499169514960 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49328/test.html"
04:58:34 INFO - 1499169514984 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"
04:58:34 INFO - 1499169514989 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"
04:58:34 INFO - 1499169514992 Marionette TRACE 364 <- [1,2,null,{}]
04:58:34 INFO - 1499169514993 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:58:35 INFO - 1499169515001 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"069f2adc-ab7e-4c54-b386-2b73ebc4afda","ELEMENT":"069f2adc-ab7e-4c54-b386-2b73ebc4afda"}}]
04:58:35 INFO - 1499169515003 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"069f2adc-ab7e-4c54-b386-2b73ebc4afda"}]
04:58:35 INFO - 1499169515246 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:58:35 INFO - 1499169515246 Marionette TRACE 364 <- [1,4,null,{}]
04:58:35 INFO - 1499169515248 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"069f2adc-ab7e-4c54-b386-2b73ebc4afda","name":"selected"}]
04:58:35 INFO - 1499169515253 Marionette TRACE 364 <- [1,5,null,{"value":true}]
04:58:35 INFO - 1499169515255 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}]
04:58:35 INFO - TEST-END: test_click.py TestClick.test_container_element1499169515258 Marionette TRACE 364 <- [1,6,null,{"value":null}]
04:58:35 INFO - 1499169515259 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
04:58:35 INFO - 1499169515260 Marionette TRACE 364 <- [1,7,null,{}]
04:58:35 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 368ms
04:58:35 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
04:58:35 INFO - 1499169515263 Marionette DEBUG Closed connection 364
04:58:35 INFO - 1499169515264 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49766
04:58:35 INFO - 1499169515265 Marionette DEBUG Closed connection 365
04:58:35 INFO - 1499169515266 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49767
04:58:35 INFO - 1499169515267 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:35 INFO - 1499169515267 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515270 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515274 Marionette TRACE 366 <- [1,1,null,{"sessionId":"2f245609-fe16-4050-8d0b-c5905e8d95fd","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515275 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
04:58:35 INFO - 1499169515276 Marionette TRACE 366 <- [1,2,null,{}]
04:58:35 INFO - 1499169515277 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:35 INFO - 1499169515277 Marionette TRACE 366 <- [1,3,null,{}]
04:58:35 INFO - 1499169515278 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:35 INFO - 1499169515279 Marionette TRACE 366 <- [1,4,null,{}]
04:58:35 INFO - 1499169515280 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}]
04:58:35 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499169515283 Marionette TRACE 366 <- [1,5,null,{"value":null}]
04:58:35 INFO - 1499169515285 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
04:58:35 INFO - 1499169515286 Marionette TRACE 366 <- [1,6,null,{}]
04:58:35 INFO - 1499169515288 Marionette DEBUG Closed connection 366
04:58:35 INFO - 1499169515289 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49768
04:58:35 INFO - 1499169515290 Marionette DEBUG Closed connection 367
04:58:35 INFO - 1499169515290 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49769
04:58:35 INFO - 1499169515291 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:35 INFO - 1499169515292 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515295 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515299 Marionette TRACE 368 <- [1,1,null,{"sessionId":"f2f453b4-e2cd-423a-b96d-04a2a782d0e0","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515301 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
04:58:35 INFO - 1499169515302 Marionette TRACE 368 <- [1,2,null,{}]
04:58:35 INFO - 1499169515304 Marionette DEBUG Closed connection 368
04:58:35 INFO - 1499169515305 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49770
04:58:35 INFO - 1499169515306 Marionette DEBUG Closed connection 369
04:58:35 INFO - 1499169515306 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49771
04:58:35 INFO - 1499169515307 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:35 INFO - 1499169515308 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515311 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515316 Marionette TRACE 370 <- [1,1,null,{"sessionId":"723578b4-35f6-43f4-9d09-107b79e27260","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515317 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"}]
04:58:35 INFO - 1499169515320 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"
04:58:35 INFO - 1499169515322 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"
04:58:35 INFO - 1499169515322 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"
04:58:35 INFO - 1499169515340 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"
04:58:35 INFO - 1499169515344 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"
04:58:35 INFO - 1499169515355 Marionette TRACE 370 <- [1,2,null,{}]
04:58:35 INFO - 1499169515357 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
04:58:35 INFO - 1499169515359 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"49457aa0-d25f-485c-aa0b-e99c476ebf29","ELEMENT":"49457aa0-d25f-485c-aa0b-e99c476ebf29"}}]
04:58:35 INFO - 1499169515360 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"49457aa0-d25f-485c-aa0b-e99c476ebf29"}]
04:58:35 INFO - 1499169515611 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:58:35 INFO - 1499169515611 Marionette TRACE 370 <- [1,4,null,{}]
04:58:35 INFO - 1499169515613 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"49457aa0-d25f-485c-aa0b-e99c476ebf29","name":"selected"}]
04:58:35 INFO - 1499169515617 Marionette TRACE 370 <- [1,5,null,{"value":true}]
04:58:35 INFO - 1499169515619 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}]
04:58:35 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499169515621 Marionette TRACE 370 <- [1,6,null,{"value":null}]
04:58:35 INFO - 1499169515622 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
04:58:35 INFO - 1499169515624 Marionette TRACE 370 <- [1,7,null,{}]
04:58:35 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 363ms
04:58:35 INFO - TEST-START | test_click.py TestClick.test_css_transforms
04:58:35 INFO - 1499169515626 Marionette DEBUG Closed connection 370
04:58:35 INFO - 1499169515627 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49772
04:58:35 INFO - 1499169515627 Marionette DEBUG Closed connection 371
04:58:35 INFO - 1499169515629 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49773
04:58:35 INFO - 1499169515630 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:35 INFO - 1499169515631 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515634 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515637 Marionette TRACE 372 <- [1,1,null,{"sessionId":"005815ce-eeb3-4028-98b2-d56ca8aa11eb","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515638 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
04:58:35 INFO - 1499169515638 Marionette TRACE 372 <- [1,2,null,{}]
04:58:35 INFO - 1499169515639 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:35 INFO - 1499169515640 Marionette TRACE 372 <- [1,3,null,{}]
04:58:35 INFO - 1499169515641 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:35 INFO - 1499169515641 Marionette TRACE 372 <- [1,4,null,{}]
04:58:35 INFO - 1499169515643 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}]
04:58:35 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499169515645 Marionette TRACE 372 <- [1,5,null,{"value":null}]
04:58:35 INFO - 1499169515646 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
04:58:35 INFO - 1499169515648 Marionette TRACE 372 <- [1,6,null,{}]
04:58:35 INFO - 1499169515650 Marionette DEBUG Closed connection 372
04:58:35 INFO - 1499169515650 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49774
04:58:35 INFO - 1499169515651 Marionette DEBUG Closed connection 373
04:58:35 INFO - 1499169515652 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49775
04:58:35 INFO - 1499169515653 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:35 INFO - 1499169515654 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515656 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515660 Marionette TRACE 374 <- [1,1,null,{"sessionId":"86979753-d5c1-4d84-9e24-54343d6d103d","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515661 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
04:58:35 INFO - 1499169515662 Marionette TRACE 374 <- [1,2,null,{}]
04:58:35 INFO - 1499169515664 Marionette DEBUG Closed connection 374
04:58:35 INFO - 1499169515665 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49776
04:58:35 INFO - 1499169515665 Marionette DEBUG Closed connection 375
04:58:35 INFO - 1499169515666 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49777
04:58:35 INFO - 1499169515667 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:35 INFO - 1499169515668 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515670 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515673 Marionette TRACE 376 <- [1,1,null,{"sessionId":"7706f682-f648-497c-bf86-c8dac48b8d92","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515674 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"}]
04:58:35 INFO - 1499169515676 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"
04:58:35 INFO - 1499169515678 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"
04:58:35 INFO - 1499169515678 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"
04:58:35 INFO - 1499169515700 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"
04:58:35 INFO - 1499169515702 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"
04:58:35 INFO - 1499169515705 Marionette TRACE 376 <- [1,2,null,{}]
04:58:35 INFO - 1499169515707 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
04:58:35 INFO - 1499169515709 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"69a40c9a-4fe6-460e-bf6f-690af74b1520","ELEMENT":"69a40c9a-4fe6-460e-bf6f-690af74b1520"}}]
04:58:35 INFO - 1499169515710 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"69a40c9a-4fe6-460e-bf6f-690af74b1520"}]
04:58:35 INFO - 1499169515963 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:58:35 INFO - 1499169515963 Marionette TRACE 376 <- [1,4,null,{}]
04:58:35 INFO - 1499169515965 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}]
04:58:35 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499169515968 Marionette TRACE 376 <- [1,5,null,{"value":null}]
04:58:35 INFO - 1499169515969 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
04:58:35 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 346ms
04:58:35 INFO - 1499169515970 Marionette TRACE 376 <- [1,6,null,{}]
04:58:35 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
04:58:35 INFO - 1499169515972 Marionette DEBUG Closed connection 376
04:58:35 INFO - 1499169515974 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49778
04:58:35 INFO - 1499169515974 Marionette DEBUG Closed connection 377
04:58:35 INFO - 1499169515975 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49779
04:58:35 INFO - 1499169515976 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:35 INFO - 1499169515977 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:35 INFO - 1499169515979 Marionette DEBUG Register listener.js for window 12
04:58:35 INFO - 1499169515982 Marionette TRACE 378 <- [1,1,null,{"sessionId":"6cd971cb-7dd1-40dc-9aca-117e93aab880","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:35 INFO - 1499169515984 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
04:58:35 INFO - 1499169515984 Marionette TRACE 378 <- [1,2,null,{}]
04:58:35 INFO - 1499169515985 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:35 INFO - 1499169515985 Marionette TRACE 378 <- [1,3,null,{}]
04:58:35 INFO - 1499169515986 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:35 INFO - 1499169515987 Marionette TRACE 378 <- [1,4,null,{}]
04:58:35 INFO - 1499169515988 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}]
04:58:35 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499169515991 Marionette TRACE 378 <- [1,5,null,{"value":null}]
04:58:35 INFO - 1499169515991 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
04:58:35 INFO - 1499169515993 Marionette TRACE 378 <- [1,6,null,{}]
04:58:35 INFO - 1499169515995 Marionette DEBUG Closed connection 378
04:58:35 INFO - 1499169515995 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49780
04:58:35 INFO - 1499169515996 Marionette DEBUG Closed connection 379
04:58:35 INFO - 1499169515997 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49781
04:58:36 INFO - 1499169515998 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169515999 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516001 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516004 Marionette TRACE 380 <- [1,1,null,{"sessionId":"38ae3428-ea46-450c-ae94-d65353d7500d","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516005 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
04:58:36 INFO - 1499169516006 Marionette TRACE 380 <- [1,2,null,{}]
04:58:36 INFO - 1499169516008 Marionette DEBUG Closed connection 380
04:58:36 INFO - 1499169516009 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49782
04:58:36 INFO - 1499169516010 Marionette DEBUG Closed connection 381
04:58:36 INFO - 1499169516010 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49783
04:58:36 INFO - 1499169516011 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:36 INFO - 1499169516012 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516014 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516017 Marionette TRACE 382 <- [1,1,null,{"sessionId":"cb8aba4c-038b-40d3-be86-5214ceda0f1e","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516019 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"}]
04:58:36 INFO - 1499169516020 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"
04:58:36 INFO - 1499169516022 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"
04:58:36 INFO - 1499169516022 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"
04:58:36 INFO - 1499169516041 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"
04:58:36 INFO - 1499169516045 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"
04:58:36 INFO - 1499169516054 Marionette TRACE 382 <- [1,2,null,{}]
04:58:36 INFO - 1499169516055 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
04:58:36 INFO - 1499169516057 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7d70ffb6-2f67-4956-be52-a840f0b4f533","ELEMENT":"7d70ffb6-2f67-4956-be52-a840f0b4f533"}}]
04:58:36 INFO - 1499169516058 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"7d70ffb6-2f67-4956-be52-a840f0b4f533"}]
04:58:36 INFO - 1499169516309 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:58:36 INFO - 1499169516310 Marionette TRACE 382 <- [1,4,null,{}]
04:58:36 INFO - 1499169516311 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}]
04:58:36 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 346ms
04:58:36 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499169516314 Marionette TRACE 382 <- [1,5,null,{"value":null}]
04:58:36 INFO - 1499169516315 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
04:58:36 INFO - 1499169516317 Marionette TRACE 382 <- [1,6,null,{}]
04:58:36 INFO - 1499169516319 Marionette DEBUG Closed connection 382
04:58:36 INFO - TEST-START | test_click.py TestClick.test_input_file
04:58:36 INFO - 1499169516321 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49784
04:58:36 INFO - 1499169516321 Marionette DEBUG Closed connection 383
04:58:36 INFO - 1499169516322 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49785
04:58:36 INFO - 1499169516323 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516323 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516326 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516329 Marionette TRACE 384 <- [1,1,null,{"sessionId":"868e3ef6-e0f3-4930-85bd-18f65015c640","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516330 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
04:58:36 INFO - 1499169516331 Marionette TRACE 384 <- [1,2,null,{}]
04:58:36 INFO - 1499169516332 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:36 INFO - 1499169516332 Marionette TRACE 384 <- [1,3,null,{}]
04:58:36 INFO - 1499169516333 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:36 INFO - 1499169516333 Marionette TRACE 384 <- [1,4,null,{}]
04:58:36 INFO - 1499169516335 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}]
04:58:36 INFO - TEST-START: test_click.py TestClick.test_input_file1499169516337 Marionette TRACE 384 <- [1,5,null,{"value":null}]
04:58:36 INFO - 1499169516338 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
04:58:36 INFO - 1499169516339 Marionette TRACE 384 <- [1,6,null,{}]
04:58:36 INFO - 1499169516341 Marionette DEBUG Closed connection 384
04:58:36 INFO - 1499169516342 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49786
04:58:36 INFO - 1499169516343 Marionette DEBUG Closed connection 385
04:58:36 INFO - 1499169516343 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49787
04:58:36 INFO - 1499169516345 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516345 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516348 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516351 Marionette TRACE 386 <- [1,1,null,{"sessionId":"7aa53a2a-4b6d-410e-bf7a-4dafe76a4039","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516352 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
04:58:36 INFO - 1499169516353 Marionette TRACE 386 <- [1,2,null,{}]
04:58:36 INFO - 1499169516356 Marionette DEBUG Closed connection 386
04:58:36 INFO - 1499169516356 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49788
04:58:36 INFO - 1499169516357 Marionette DEBUG Closed connection 387
04:58:36 INFO - 1499169516358 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49789
04:58:36 INFO - 1499169516359 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:36 INFO - 1499169516360 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516362 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516366 Marionette TRACE 388 <- [1,1,null,{"sessionId":"3cda26e5-46cd-47aa-9a59-89c4098d0ba1","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516368 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
04:58:36 INFO - 1499169516369 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"
04:58:36 INFO - 1499169516371 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"
04:58:36 INFO - 1499169516372 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"
04:58:36 INFO - 1499169516390 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:58:36 INFO - 1499169516394 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:58:36 INFO - 1499169516402 Marionette TRACE 388 <- [1,2,null,{}]
04:58:36 INFO - 1499169516404 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
04:58:36 INFO - 1499169516406 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c990594-5280-403f-a076-71c2e622a189","ELEMENT":"8c990594-5280-403f-a076-71c2e622a189"}}]
04:58:36 INFO - 1499169516407 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"8c990594-5280-403f-a076-71c2e622a189"}]
04:58:36 INFO - 1499169516437 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]
04:58:36 INFO - 1499169516439 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}]
04:58:36 INFO - TEST-END: test_click.py TestClick.test_input_file1499169516442 Marionette TRACE 388 <- [1,5,null,{"value":null}]
04:58:36 INFO - 1499169516443 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
04:58:36 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 127ms
04:58:36 INFO - 1499169516445 Marionette TRACE 388 <- [1,6,null,{}]
04:58:36 INFO - TEST-START | test_click.py TestClick.test_obscured_element
04:58:36 INFO - 1499169516447 Marionette DEBUG Closed connection 388
04:58:36 INFO - 1499169516448 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49790
04:58:36 INFO - 1499169516449 Marionette DEBUG Closed connection 389
04:58:36 INFO - 1499169516450 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49791
04:58:36 INFO - 1499169516451 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516451 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516454 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516458 Marionette TRACE 390 <- [1,1,null,{"sessionId":"6b0bfdad-cf9c-40e7-a5e2-23af6d6bd374","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516459 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
04:58:36 INFO - 1499169516460 Marionette TRACE 390 <- [1,2,null,{}]
04:58:36 INFO - 1499169516461 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:36 INFO - 1499169516461 Marionette TRACE 390 <- [1,3,null,{}]
04:58:36 INFO - 1499169516462 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:36 INFO - 1499169516463 Marionette TRACE 390 <- [1,4,null,{}]
04:58:36 INFO - 1499169516464 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}]
04:58:36 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499169516467 Marionette TRACE 390 <- [1,5,null,{"value":null}]
04:58:36 INFO - 1499169516469 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
04:58:36 INFO - 1499169516470 Marionette TRACE 390 <- [1,6,null,{}]
04:58:36 INFO - 1499169516472 Marionette DEBUG Closed connection 390
04:58:36 INFO - 1499169516473 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49792
04:58:36 INFO - 1499169516474 Marionette DEBUG Closed connection 391
04:58:36 INFO - 1499169516475 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49793
04:58:36 INFO - 1499169516476 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516477 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516480 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516491 Marionette TRACE 392 <- [1,1,null,{"sessionId":"fc8b85c3-a045-4b3c-9b37-a8d2b771b227","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516492 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
04:58:36 INFO - 1499169516494 Marionette TRACE 392 <- [1,2,null,{}]
04:58:36 INFO - 1499169516496 Marionette DEBUG Closed connection 392
04:58:36 INFO - 1499169516497 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49794
04:58:36 INFO - 1499169516498 Marionette DEBUG Closed connection 393
04:58:36 INFO - 1499169516498 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49795
04:58:36 INFO - 1499169516499 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:36 INFO - 1499169516500 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516503 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516507 Marionette TRACE 394 <- [1,1,null,{"sessionId":"3d891a91-d572-44c8-a414-4c882f77a62f","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516508 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"}]
04:58:36 INFO - 1499169516510 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:58:36 INFO - 1499169516513 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:58:36 INFO - 1499169516513 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
04:58:36 INFO - 1499169516525 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"
04:58:36 INFO - 1499169516530 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"
04:58:36 INFO - 1499169516539 Marionette TRACE 394 <- [1,2,null,{}]
04:58:36 INFO - 1499169516540 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
04:58:36 INFO - 1499169516542 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4db38002-f00c-4163-8805-b34ac6e85903","ELEMENT":"4db38002-f00c-4163-8805-b34ac6e85903"}}]
04:58:36 INFO - 1499169516555 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
04:58:36 INFO - 1499169516558 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"97156c5c-7b6a-4722-afec-cbc5abb38ae8","ELEMENT":"97156c5c-7b6a-4722-afec-cbc5abb38ae8"}}]
04:58:36 INFO - 1499169516560 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"4db38002-f00c-4163-8805-b34ac6e85903"}]
04:58:36 INFO - 1499169516811 Marionette DEBUG Canceled page load listener because no navigation has been detected
04:58:36 INFO - 1499169516812 Marionette TRACE 394 <- [1,5,null,{}]
04:58:36 INFO - 1499169516814 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"97156c5c-7b6a-4722-afec-cbc5abb38ae8"}]
04:58:36 INFO - 1499169516835 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]
04:58:36 INFO - 1499169516837 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
04:58:36 INFO - 1499169516841 Marionette TRACE 394 <- [1,7,null,{"value":false}]
04:58:36 INFO - 1499169516843 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}]
04:58:36 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499169516846 Marionette TRACE 394 <- [1,8,null,{"value":null}]
04:58:36 INFO - 1499169516848 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
04:58:36 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 406ms
04:58:36 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
04:58:36 INFO - 1499169516851 Marionette TRACE 394 <- [1,9,null,{}]
04:58:36 INFO - 1499169516854 Marionette DEBUG Closed connection 394
04:58:36 INFO - 1499169516855 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49796
04:58:36 INFO - 1499169516856 Marionette DEBUG Closed connection 395
04:58:36 INFO - 1499169516857 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49797
04:58:36 INFO - 1499169516858 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516861 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516863 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516869 Marionette TRACE 396 <- [1,1,null,{"sessionId":"0042e1f9-de59-4547-a6d2-5baa9d90994a","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516871 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
04:58:36 INFO - 1499169516872 Marionette TRACE 396 <- [1,2,null,{}]
04:58:36 INFO - 1499169516874 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
04:58:36 INFO - 1499169516875 Marionette TRACE 396 <- [1,3,null,{}]
04:58:36 INFO - 1499169516876 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
04:58:36 INFO - 1499169516877 Marionette TRACE 396 <- [1,4,null,{}]
04:58:36 INFO - 1499169516880 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}]
04:58:36 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499169516884 Marionette TRACE 396 <- [1,5,null,{"value":null}]
04:58:36 INFO - 1499169516885 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
04:58:36 INFO - 1499169516887 Marionette TRACE 396 <- [1,6,null,{}]
04:58:36 INFO - 1499169516890 Marionette DEBUG Closed connection 396
04:58:36 INFO - 1499169516891 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49798
04:58:36 INFO - 1499169516892 Marionette DEBUG Closed connection 397
04:58:36 INFO - 1499169516893 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49799
04:58:36 INFO - 1499169516894 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
04:58:36 INFO - 1499169516895 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516898 Marionette DEBUG Register listener.js for window 12
04:58:36 INFO - 1499169516904 Marionette TRACE 398 <- [1,1,null,{"sessionId":"cef8758c-5d6b-4ff9-9070-7bc0158a6458","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:36 INFO - 1499169516978 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
04:58:36 INFO - 1499169516980 Marionette TRACE 398 <- [1,2,null,{}]
04:58:36 INFO - 1499169516985 Marionette DEBUG Closed connection 398
04:58:36 INFO - 1499169516986 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49800
04:58:36 INFO - 1499169516987 Marionette DEBUG Closed connection 399
04:58:36 INFO - 1499169516988 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49801
04:58:36 INFO - 1499169516990 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
04:58:36 INFO - 1499169516993 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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}
04:58:36 INFO - 1499169516996 Marionette DEBUG Register listener.js for window 12
04:58:37 INFO - 1499169517002 Marionette TRACE 400 <- [1,1,null,{"sessionId":"c347a1cb-a1a9-4ce5-8397-9af7b0232eba","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":3320,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-283.001\\AppData\\Local\\Temp\\tmpfafbl_.mozrunner","moz:accessibilityChecks":false}}]
04:58:37 INFO - 1499169517005 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"}]
04:58:37 INFO - 1499169517007 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"
04:58:37 INFO - 1499169517012 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"
04:58:37 INFO - 1499169517012 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"
04:58:37 INFO - 1499169517038 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"
04:58:37 INFO - 1499169517041 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"
04:58:37 INFO - 1499169517047 Marionette TRACE 400 <- [1,2,null,{}]
04:58:37 INFO - 1499169517055 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
04:58:37 INFO - 1499169517059 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f232c728-530b-4ab9-9cb0-9e2ee5d88215","ELEMENT":"f232c728-530b-4ab9-9cb0-9e2ee5d88215"}}]
04:58:37 INFO - 1499169517061 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"f232c728-530b-4ab9-9cb0-9e2ee5d88215"}]
04:58:37 INFO - 1499169517087 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
04:58:37 INFO - 1499169517089 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"f232c728-530b-4ab9-9cb0-9e2ee5d88215"}]
04:58:37 INFO - 1499169517118 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element