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:1330:5\n"},null]
15:24:07 INFO - 1498861447649 Marionette TRACE 358 -> [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}]
15:24:07 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1498861447651 Marionette TRACE 358 <- [1,5,null,{"value":null}]
15:24:07 INFO - 1498861447652 Marionette TRACE 358 -> [0,6,"deleteSession",{}]
15:24:07 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 111ms
15:24:07 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
15:24:07 INFO - 1498861447653 Marionette TRACE 358 <- [1,6,null,{}]
15:24:07 INFO - 1498861447654 Marionette DEBUG Closed connection 358
15:24:07 INFO - 1498861447655 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49727
15:24:07 INFO - 1498861447656 Marionette DEBUG Closed connection 359
15:24:07 INFO - 1498861447657 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49728
15:24:07 INFO - 1498861447657 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:07 INFO - 1498861447658 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447660 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447663 Marionette TRACE 360 <- [1,1,null,{"sessionId":"0ffecf8e-7e06-48db-a6ca-23ec2cf0ebcb","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447664 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
15:24:07 INFO - 1498861447664 Marionette TRACE 360 <- [1,2,null,{}]
15:24:07 INFO - 1498861447665 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:07 INFO - 1498861447666 Marionette TRACE 360 <- [1,3,null,{}]
15:24:07 INFO - 1498861447666 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:07 INFO - 1498861447667 Marionette TRACE 360 <- [1,4,null,{}]
15:24:07 INFO - 1498861447668 Marionette TRACE 360 -> [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}]
15:24:07 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1498861447670 Marionette TRACE 360 <- [1,5,null,{"value":null}]
15:24:07 INFO - 1498861447671 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
15:24:07 INFO - 1498861447672 Marionette TRACE 360 <- [1,6,null,{}]
15:24:07 INFO - 1498861447674 Marionette DEBUG Closed connection 360
15:24:07 INFO - 1498861447674 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49729
15:24:07 INFO - 1498861447675 Marionette DEBUG Closed connection 361
15:24:07 INFO - 1498861447675 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49730
15:24:07 INFO - 1498861447676 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:07 INFO - 1498861447676 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447678 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447681 Marionette TRACE 362 <- [1,1,null,{"sessionId":"cbb53833-ea13-43b7-8a7f-423b25fb6537","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447682 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
15:24:07 INFO - 1498861447683 Marionette TRACE 362 <- [1,2,null,{}]
15:24:07 INFO - 1498861447685 Marionette DEBUG Closed connection 362
15:24:07 INFO - 1498861447685 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49731
15:24:07 INFO - 1498861447686 Marionette DEBUG Closed connection 363
15:24:07 INFO - 1498861447686 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49732
15:24:07 INFO - 1498861447687 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:07 INFO - 1498861447688 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447691 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447693 Marionette TRACE 364 <- [1,1,null,{"sessionId":"c4807441-9675-48fd-8697-3ae2d94e002b","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447694 Marionette TRACE 364 -> [0,2,"get",{"url":"http://127.0.0.1:49332/clicks.html"}]
15:24:07 INFO - 1498861447696 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/hidden.html"
15:24:07 INFO - 1498861447702 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/hidden.html"
15:24:07 INFO - 1498861447703 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/hidden.html"
15:24:07 INFO - 1498861447710 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/clicks.html"
15:24:07 INFO - 1498861447715 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/clicks.html"
15:24:07 INFO - 1498861447717 Marionette TRACE 364 <- [1,2,null,{}]
15:24:07 INFO - 1498861447720 Marionette TRACE 364 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
15:24:07 INFO - 1498861447725 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c4ef31e1-6286-4e1c-83f1-6bd5cf25a959","ELEMENT":"c4ef31e1-6286-4e1c-83f1-6bd5cf25a959"}}]
15:24:07 INFO - 1498861447727 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"c4ef31e1-6286-4e1c-83f1-6bd5cf25a959"}]
15:24:07 INFO - 1498861447763 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/clicks.html"
15:24:07 INFO - 1498861447770 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/clicks.html"
15:24:07 INFO - 1498861447770 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/clicks.html"
15:24:07 INFO - 1498861447779 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/test.html"
15:24:07 INFO - 1498861447783 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/test.html"
15:24:07 INFO - 1498861447784 Marionette TRACE 364 <- [1,4,null,{}]
15:24:07 INFO - 1498861447787 Marionette TRACE 364 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
15:24:07 INFO - 1498861447794 Marionette TRACE 364 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0af2a02-f20f-44a2-81ee-c9c77dc12d64","ELEMENT":"e0af2a02-f20f-44a2-81ee-c9c77dc12d64"}}]
15:24:07 INFO - 1498861447795 Marionette TRACE 364 -> [0,6,"getTitle",{}]
15:24:07 INFO - 1498861447797 Marionette TRACE 364 <- [1,6,null,{"value":"Marionette Test"}]
15:24:07 INFO - 1498861447798 Marionette TRACE 364 -> [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}]
15:24:07 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1498861447807 Marionette TRACE 364 <- [1,7,null,{"value":null}]
15:24:07 INFO - 1498861447808 Marionette TRACE 364 -> [0,8,"deleteSession",{}]
15:24:07 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 156ms
15:24:07 INFO - TEST-START | test_click.py TestClick.test_container_element
15:24:07 INFO - 1498861447809 Marionette TRACE 364 <- [1,8,null,{}]
15:24:07 INFO - 1498861447810 Marionette DEBUG Closed connection 364
15:24:07 INFO - 1498861447811 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49735
15:24:07 INFO - 1498861447812 Marionette DEBUG Closed connection 365
15:24:07 INFO - 1498861447812 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49736
15:24:07 INFO - 1498861447813 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:07 INFO - 1498861447814 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447822 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447825 Marionette TRACE 366 <- [1,1,null,{"sessionId":"37aa0536-4d17-4e4c-9609-fec70ede4ff9","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447826 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
15:24:07 INFO - 1498861447827 Marionette TRACE 366 <- [1,2,null,{}]
15:24:07 INFO - 1498861447828 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:07 INFO - 1498861447828 Marionette TRACE 366 <- [1,3,null,{}]
15:24:07 INFO - 1498861447829 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:07 INFO - 1498861447829 Marionette TRACE 366 <- [1,4,null,{}]
15:24:07 INFO - 1498861447831 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')","sandbox":"simpletest","line":316}]
15:24:07 INFO - TEST-START: test_click.py TestClick.test_container_element1498861447833 Marionette TRACE 366 <- [1,5,null,{"value":null}]
15:24:07 INFO - 1498861447834 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
15:24:07 INFO - 1498861447835 Marionette TRACE 366 <- [1,6,null,{}]
15:24:07 INFO - 1498861447836 Marionette DEBUG Closed connection 366
15:24:07 INFO - 1498861447837 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49737
15:24:07 INFO - 1498861447837 Marionette DEBUG Closed connection 367
15:24:07 INFO - 1498861447838 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49738
15:24:07 INFO - 1498861447839 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:07 INFO - 1498861447839 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447842 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447844 Marionette TRACE 368 <- [1,1,null,{"sessionId":"b060145c-1cb4-4007-915f-6d996e7cef6e","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447845 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
15:24:07 INFO - 1498861447846 Marionette TRACE 368 <- [1,2,null,{}]
15:24:07 INFO - 1498861447848 Marionette DEBUG Closed connection 368
15:24:07 INFO - 1498861447848 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49739
15:24:07 INFO - 1498861447849 Marionette DEBUG Closed connection 369
15:24:07 INFO - 1498861447849 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49740
15:24:07 INFO - 1498861447850 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:07 INFO - 1498861447851 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:07 INFO - 1498861447853 Marionette DEBUG Register listener.js for window 2147483649
15:24:07 INFO - 1498861447863 Marionette TRACE 370 <- [1,1,null,{"sessionId":"9d3eb235-864c-4d96-a8d7-35f782acdd3a","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:07 INFO - 1498861447865 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%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"}]
15:24:07 INFO - 1498861447866 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/test.html"
15:24:07 INFO - 1498861447868 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/test.html"
15:24:07 INFO - 1498861447868 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/test.html"
15:24:07 INFO - 1498861447878 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"
15:24:07 INFO - 1498861447886 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"
15:24:07 INFO - 1498861447887 Marionette TRACE 370 <- [1,2,null,{}]
15:24:07 INFO - 1498861447893 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:24:07 INFO - 1498861447898 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"68093dad-30f2-49b9-b7e5-87067a31eea0","ELEMENT":"68093dad-30f2-49b9-b7e5-87067a31eea0"}}]
15:24:07 INFO - 1498861447899 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"68093dad-30f2-49b9-b7e5-87067a31eea0"}]
15:24:08 INFO - 1498861448139 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:24:08 INFO - 1498861448140 Marionette TRACE 370 <- [1,4,null,{}]
15:24:08 INFO - 1498861448141 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"68093dad-30f2-49b9-b7e5-87067a31eea0","name":"selected"}]
15:24:08 INFO - 1498861448145 Marionette TRACE 370 <- [1,5,null,{"value":true}]
15:24:08 INFO - 1498861448146 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')","sandbox":"simpletest","line":328}]
15:24:08 INFO - TEST-END: test_click.py TestClick.test_container_element1498861448148 Marionette TRACE 370 <- [1,6,null,{"value":null}]
15:24:08 INFO - 1498861448149 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
15:24:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 341ms
15:24:08 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
15:24:08 INFO - 1498861448150 Marionette TRACE 370 <- [1,7,null,{}]
15:24:08 INFO - 1498861448151 Marionette DEBUG Closed connection 370
15:24:08 INFO - 1498861448153 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49741
15:24:08 INFO - 1498861448153 Marionette DEBUG Closed connection 371
15:24:08 INFO - 1498861448154 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49742
15:24:08 INFO - 1498861448155 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448155 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448157 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448160 Marionette TRACE 372 <- [1,1,null,{"sessionId":"5698ed0b-6a9e-41bd-a491-d8491f520c5a","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448161 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
15:24:08 INFO - 1498861448161 Marionette TRACE 372 <- [1,2,null,{}]
15:24:08 INFO - 1498861448162 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:08 INFO - 1498861448162 Marionette TRACE 372 <- [1,3,null,{}]
15:24:08 INFO - 1498861448163 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:08 INFO - 1498861448163 Marionette TRACE 372 <- [1,4,null,{}]
15:24:08 INFO - 1498861448165 Marionette TRACE 372 -> [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}]
15:24:08 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1498861448167 Marionette TRACE 372 <- [1,5,null,{"value":null}]
15:24:08 INFO - 1498861448168 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
15:24:08 INFO - 1498861448169 Marionette TRACE 372 <- [1,6,null,{}]
15:24:08 INFO - 1498861448170 Marionette DEBUG Closed connection 372
15:24:08 INFO - 1498861448170 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49743
15:24:08 INFO - 1498861448171 Marionette DEBUG Closed connection 373
15:24:08 INFO - 1498861448172 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49744
15:24:08 INFO - 1498861448174 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448175 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448177 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448179 Marionette TRACE 374 <- [1,1,null,{"sessionId":"cfd9f863-3dcb-478d-aa0d-abfabd82dbf7","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448180 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
15:24:08 INFO - 1498861448182 Marionette TRACE 374 <- [1,2,null,{}]
15:24:08 INFO - 1498861448183 Marionette DEBUG Closed connection 374
15:24:08 INFO - 1498861448183 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49745
15:24:08 INFO - 1498861448184 Marionette DEBUG Closed connection 375
15:24:08 INFO - 1498861448185 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49746
15:24:08 INFO - 1498861448186 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:08 INFO - 1498861448186 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448188 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448191 Marionette TRACE 376 <- [1,1,null,{"sessionId":"b2b3dcaf-b5ad-4fe1-b846-ec1ff7496fea","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448192 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%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"}]
15:24:08 INFO - 1498861448193 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"
15:24:08 INFO - 1498861448195 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"
15:24:08 INFO - 1498861448196 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"
15:24:08 INFO - 1498861448201 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"
15:24:08 INFO - 1498861448203 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"
15:24:08 INFO - 1498861448205 Marionette TRACE 376 <- [1,2,null,{}]
15:24:08 INFO - 1498861448211 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:24:08 INFO - 1498861448213 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ec805ce1-d675-4dbb-847b-27b3ea29e722","ELEMENT":"ec805ce1-d675-4dbb-847b-27b3ea29e722"}}]
15:24:08 INFO - 1498861448214 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"ec805ce1-d675-4dbb-847b-27b3ea29e722"}]
15:24:08 INFO - 1498861448452 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:24:08 INFO - 1498861448453 Marionette TRACE 376 <- [1,4,null,{}]
15:24:08 INFO - 1498861448454 Marionette TRACE 376 -> [0,5,"getElementProperty",{"id":"ec805ce1-d675-4dbb-847b-27b3ea29e722","name":"selected"}]
15:24:08 INFO - 1498861448458 Marionette TRACE 376 <- [1,5,null,{"value":true}]
15:24:08 INFO - 1498861448459 Marionette TRACE 376 -> [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}]
15:24:08 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1498861448462 Marionette TRACE 376 <- [1,6,null,{"value":null}]
15:24:08 INFO - 1498861448462 Marionette TRACE 376 -> [0,7,"deleteSession",{}]
15:24:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 313ms
15:24:08 INFO - TEST-START | test_click.py TestClick.test_css_transforms
15:24:08 INFO - 1498861448463 Marionette TRACE 376 <- [1,7,null,{}]
15:24:08 INFO - 1498861448465 Marionette DEBUG Closed connection 376
15:24:08 INFO - 1498861448466 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49747
15:24:08 INFO - 1498861448466 Marionette DEBUG Closed connection 377
15:24:08 INFO - 1498861448467 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49748
15:24:08 INFO - 1498861448468 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448468 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448471 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448473 Marionette TRACE 378 <- [1,1,null,{"sessionId":"34409835-b399-43ff-9eff-2ce5ec785d8e","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448474 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
15:24:08 INFO - 1498861448475 Marionette TRACE 378 <- [1,2,null,{}]
15:24:08 INFO - 1498861448476 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:08 INFO - 1498861448476 Marionette TRACE 378 <- [1,3,null,{}]
15:24:08 INFO - 1498861448477 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:08 INFO - 1498861448477 Marionette TRACE 378 <- [1,4,null,{}]
15:24:08 INFO - 1498861448479 Marionette TRACE 378 -> [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}]
15:24:08 INFO - TEST-START: test_click.py TestClick.test_css_transforms1498861448481 Marionette TRACE 378 <- [1,5,null,{"value":null}]
15:24:08 INFO - 1498861448482 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
15:24:08 INFO - 1498861448483 Marionette TRACE 378 <- [1,6,null,{}]
15:24:08 INFO - 1498861448484 Marionette DEBUG Closed connection 378
15:24:08 INFO - 1498861448485 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49749
15:24:08 INFO - 1498861448485 Marionette DEBUG Closed connection 379
15:24:08 INFO - 1498861448486 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49750
15:24:08 INFO - 1498861448487 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448487 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448490 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448492 Marionette TRACE 380 <- [1,1,null,{"sessionId":"1788b009-aa45-4e16-88b2-90de00586a79","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448493 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
15:24:08 INFO - 1498861448495 Marionette TRACE 380 <- [1,2,null,{}]
15:24:08 INFO - 1498861448496 Marionette DEBUG Closed connection 380
15:24:08 INFO - 1498861448496 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49751
15:24:08 INFO - 1498861448497 Marionette DEBUG Closed connection 381
15:24:08 INFO - 1498861448497 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49752
15:24:08 INFO - 1498861448498 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:08 INFO - 1498861448499 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448502 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448504 Marionette TRACE 382 <- [1,1,null,{"sessionId":"d593c3c2-dfaf-453d-ba3c-5e1629d76cf4","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448505 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%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"}]
15:24:08 INFO - 1498861448507 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"
15:24:08 INFO - 1498861448508 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"
15:24:08 INFO - 1498861448509 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"
15:24:08 INFO - 1498861448514 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"
15:24:08 INFO - 1498861448517 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"
15:24:08 INFO - 1498861448520 Marionette TRACE 382 <- [1,2,null,{}]
15:24:08 INFO - 1498861448522 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
15:24:08 INFO - 1498861448527 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"15181e1a-e8f6-4593-992f-f96fa563680e","ELEMENT":"15181e1a-e8f6-4593-992f-f96fa563680e"}}]
15:24:08 INFO - 1498861448529 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"15181e1a-e8f6-4593-992f-f96fa563680e"}]
15:24:08 INFO - 1498861448767 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:24:08 INFO - 1498861448768 Marionette TRACE 382 <- [1,4,null,{}]
15:24:08 INFO - 1498861448769 Marionette TRACE 382 -> [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}]
15:24:08 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 322ms
15:24:08 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
15:24:08 INFO - TEST-END: test_click.py TestClick.test_css_transforms1498861448783 Marionette TRACE 382 <- [1,5,null,{"value":null}]
15:24:08 INFO - 1498861448784 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
15:24:08 INFO - 1498861448785 Marionette TRACE 382 <- [1,6,null,{}]
15:24:08 INFO - 1498861448786 Marionette DEBUG Closed connection 382
15:24:08 INFO - 1498861448787 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49753
15:24:08 INFO - 1498861448788 Marionette DEBUG Closed connection 383
15:24:08 INFO - 1498861448789 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49754
15:24:08 INFO - 1498861448790 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448790 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448792 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448795 Marionette TRACE 384 <- [1,1,null,{"sessionId":"0b680f52-ebd6-4673-84d5-05118d5bda85","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448796 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
15:24:08 INFO - 1498861448796 Marionette TRACE 384 <- [1,2,null,{}]
15:24:08 INFO - 1498861448797 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:08 INFO - 1498861448797 Marionette TRACE 384 <- [1,3,null,{}]
15:24:08 INFO - 1498861448799 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:08 INFO - 1498861448799 Marionette TRACE 384 <- [1,4,null,{}]
15:24:08 INFO - 1498861448801 Marionette TRACE 384 -> [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}]
15:24:08 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1498861448803 Marionette TRACE 384 <- [1,5,null,{"value":null}]
15:24:08 INFO - 1498861448804 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
15:24:08 INFO - 1498861448806 Marionette TRACE 384 <- [1,6,null,{}]
15:24:08 INFO - 1498861448807 Marionette DEBUG Closed connection 384
15:24:08 INFO - 1498861448807 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49755
15:24:08 INFO - 1498861448808 Marionette DEBUG Closed connection 385
15:24:08 INFO - 1498861448808 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49756
15:24:08 INFO - 1498861448809 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:08 INFO - 1498861448810 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448812 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448815 Marionette TRACE 386 <- [1,1,null,{"sessionId":"624d7d97-42a0-4d9e-ab4a-df91ea48c9ad","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448816 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
15:24:08 INFO - 1498861448817 Marionette TRACE 386 <- [1,2,null,{}]
15:24:08 INFO - 1498861448818 Marionette DEBUG Closed connection 386
15:24:08 INFO - 1498861448818 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49757
15:24:08 INFO - 1498861448819 Marionette DEBUG Closed connection 387
15:24:08 INFO - 1498861448820 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49758
15:24:08 INFO - 1498861448821 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:08 INFO - 1498861448821 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:08 INFO - 1498861448823 Marionette DEBUG Register listener.js for window 2147483649
15:24:08 INFO - 1498861448825 Marionette TRACE 388 <- [1,1,null,{"sessionId":"597c104c-0149-4de1-8d04-6e7a4e903a4a","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:08 INFO - 1498861448826 Marionette TRACE 388 -> [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"}]
15:24:08 INFO - 1498861448828 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"
15:24:08 INFO - 1498861448830 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"
15:24:08 INFO - 1498861448830 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"
15:24:08 INFO - 1498861448835 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"
15:24:08 INFO - 1498861448838 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"
15:24:08 INFO - 1498861448843 Marionette TRACE 388 <- [1,2,null,{}]
15:24:08 INFO - 1498861448846 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
15:24:08 INFO - 1498861448848 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b5ef5a9c-b393-4e74-a824-f3a1cfbcc9d2","ELEMENT":"b5ef5a9c-b393-4e74-a824-f3a1cfbcc9d2"}}]
15:24:08 INFO - 1498861448849 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"b5ef5a9c-b393-4e74-a824-f3a1cfbcc9d2"}]
15:24:09 INFO - 1498861449088 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:24:09 INFO - 1498861449090 Marionette TRACE 388 <- [1,4,null,{}]
15:24:09 INFO - 1498861449097 Marionette TRACE 388 -> [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}]
15:24:09 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1498861449101 Marionette TRACE 388 <- [1,5,null,{"value":null}]
15:24:09 INFO - 1498861449103 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
15:24:09 INFO - 1498861449105 Marionette TRACE 388 <- [1,6,null,{}]
15:24:09 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 321ms
15:24:09 INFO - TEST-START | test_click.py TestClick.test_input_file
15:24:09 INFO - 1498861449107 Marionette DEBUG Closed connection 388
15:24:09 INFO - 1498861449109 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49759
15:24:09 INFO - 1498861449110 Marionette DEBUG Closed connection 389
15:24:09 INFO - 1498861449110 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49760
15:24:09 INFO - 1498861449112 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449115 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449117 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449122 Marionette TRACE 390 <- [1,1,null,{"sessionId":"7477ea26-6a13-4776-90ed-b34b06d54404","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449124 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
15:24:09 INFO - 1498861449125 Marionette TRACE 390 <- [1,2,null,{}]
15:24:09 INFO - 1498861449126 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:09 INFO - 1498861449127 Marionette TRACE 390 <- [1,3,null,{}]
15:24:09 INFO - 1498861449128 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:09 INFO - 1498861449129 Marionette TRACE 390 <- [1,4,null,{}]
15:24:09 INFO - 1498861449131 Marionette TRACE 390 -> [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}]
15:24:09 INFO - TEST-START: test_click.py TestClick.test_input_file1498861449134 Marionette TRACE 390 <- [1,5,null,{"value":null}]
15:24:09 INFO - 1498861449135 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
15:24:09 INFO - 1498861449137 Marionette TRACE 390 <- [1,6,null,{}]
15:24:09 INFO - 1498861449139 Marionette DEBUG Closed connection 390
15:24:09 INFO - 1498861449140 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49761
15:24:09 INFO - 1498861449141 Marionette DEBUG Closed connection 391
15:24:09 INFO - 1498861449141 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49762
15:24:09 INFO - 1498861449143 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449143 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449146 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449150 Marionette TRACE 392 <- [1,1,null,{"sessionId":"1314e7ea-b24d-41e8-8eeb-6c4527cb9b14","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449151 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
15:24:09 INFO - 1498861449153 Marionette TRACE 392 <- [1,2,null,{}]
15:24:09 INFO - 1498861449155 Marionette DEBUG Closed connection 392
15:24:09 INFO - 1498861449156 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49763
15:24:09 INFO - 1498861449157 Marionette DEBUG Closed connection 393
15:24:09 INFO - 1498861449157 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49764
15:24:09 INFO - 1498861449160 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:09 INFO - 1498861449161 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449164 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449167 Marionette TRACE 394 <- [1,1,null,{"sessionId":"25f2ee1a-c3d9-45c0-a9ba-8e0b9a06999c","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449168 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
15:24:09 INFO - 1498861449170 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"
15:24:09 INFO - 1498861449172 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"
15:24:09 INFO - 1498861449172 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"
15:24:09 INFO - 1498861449177 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:24:09 INFO - 1498861449181 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:24:09 INFO - 1498861449186 Marionette TRACE 394 <- [1,2,null,{}]
15:24:09 INFO - 1498861449189 Marionette TRACE 394 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
15:24:09 INFO - 1498861449196 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1b2a7a17-941e-41cc-b03a-20d29c57103d","ELEMENT":"1b2a7a17-941e-41cc-b03a-20d29c57103d"}}]
15:24:09 INFO - 1498861449197 Marionette TRACE 394 -> [0,4,"clickElement",{"id":"1b2a7a17-941e-41cc-b03a-20d29c57103d"}]
15:24:09 INFO - 1498861449227 Marionette TRACE 394 <- [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:1330:5\n"},null]
15:24:09 INFO - 1498861449229 Marionette TRACE 394 -> [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}]
15:24:09 INFO - TEST-END: test_click.py TestClick.test_input_file1498861449231 Marionette TRACE 394 <- [1,5,null,{"value":null}]
15:24:09 INFO - 1498861449232 Marionette TRACE 394 -> [0,6,"deleteSession",{}]
15:24:09 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 128ms
15:24:09 INFO - 1498861449234 Marionette TRACE 394 <- [1,6,null,{}]
15:24:09 INFO - TEST-START | test_click.py TestClick.test_obscured_element
15:24:09 INFO - 1498861449235 Marionette DEBUG Closed connection 394
15:24:09 INFO - 1498861449236 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49765
15:24:09 INFO - 1498861449237 Marionette DEBUG Closed connection 395
15:24:09 INFO - 1498861449238 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49766
15:24:09 INFO - 1498861449239 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449239 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449242 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449245 Marionette TRACE 396 <- [1,1,null,{"sessionId":"153a172d-ce45-4064-a784-3830df36161d","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449246 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
15:24:09 INFO - 1498861449247 Marionette TRACE 396 <- [1,2,null,{}]
15:24:09 INFO - 1498861449248 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:09 INFO - 1498861449248 Marionette TRACE 396 <- [1,3,null,{}]
15:24:09 INFO - 1498861449249 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:09 INFO - 1498861449249 Marionette TRACE 396 <- [1,4,null,{}]
15:24:09 INFO - 1498861449251 Marionette TRACE 396 -> [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}]
15:24:09 INFO - TEST-START: test_click.py TestClick.test_obscured_element1498861449254 Marionette TRACE 396 <- [1,5,null,{"value":null}]
15:24:09 INFO - 1498861449255 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
15:24:09 INFO - 1498861449257 Marionette TRACE 396 <- [1,6,null,{}]
15:24:09 INFO - 1498861449258 Marionette DEBUG Closed connection 396
15:24:09 INFO - 1498861449259 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49767
15:24:09 INFO - 1498861449259 Marionette DEBUG Closed connection 397
15:24:09 INFO - 1498861449260 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49768
15:24:09 INFO - 1498861449261 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449262 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449264 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449267 Marionette TRACE 398 <- [1,1,null,{"sessionId":"e1076b3e-457a-48a6-9494-3a67d8716a18","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449269 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
15:24:09 INFO - 1498861449271 Marionette TRACE 398 <- [1,2,null,{}]
15:24:09 INFO - 1498861449273 Marionette DEBUG Closed connection 398
15:24:09 INFO - 1498861449275 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49769
15:24:09 INFO - 1498861449276 Marionette DEBUG Closed connection 399
15:24:09 INFO - 1498861449277 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49770
15:24:09 INFO - 1498861449278 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:09 INFO - 1498861449279 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449282 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449285 Marionette TRACE 400 <- [1,1,null,{"sessionId":"5cedf8b5-d774-4a43-a318-a66d2d92867f","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449286 Marionette TRACE 400 -> [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"}]
15:24:09 INFO - 1498861449288 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:24:09 INFO - 1498861449289 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:24:09 INFO - 1498861449290 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:24:09 INFO - 1498861449295 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"
15:24:09 INFO - 1498861449297 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"
15:24:09 INFO - 1498861449303 Marionette TRACE 400 <- [1,2,null,{}]
15:24:09 INFO - 1498861449311 Marionette TRACE 400 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
15:24:09 INFO - 1498861449313 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"731fc238-c4e4-488e-a109-088dd5b94195","ELEMENT":"731fc238-c4e4-488e-a109-088dd5b94195"}}]
15:24:09 INFO - 1498861449314 Marionette TRACE 400 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
15:24:09 INFO - 1498861449316 Marionette TRACE 400 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cc1ed59e-d58a-4cd8-a531-9adf384b5e95","ELEMENT":"cc1ed59e-d58a-4cd8-a531-9adf384b5e95"}}]
15:24:09 INFO - 1498861449317 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"731fc238-c4e4-488e-a109-088dd5b94195"}]
15:24:09 INFO - 1498861449550 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:24:09 INFO - 1498861449551 Marionette TRACE 400 <- [1,5,null,{}]
15:24:09 INFO - 1498861449552 Marionette TRACE 400 -> [0,6,"clickElement",{"id":"cc1ed59e-d58a-4cd8-a531-9adf384b5e95"}]
15:24:09 INFO - 1498861449566 Marionette TRACE 400 <- [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:1330:5\n"},null]
15:24:09 INFO - 1498861449568 Marionette TRACE 400 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
15:24:09 INFO - 1498861449570 Marionette TRACE 400 <- [1,7,null,{"value":false}]
15:24:09 INFO - 1498861449572 Marionette TRACE 400 -> [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}]
15:24:09 INFO - TEST-END: test_click.py TestClick.test_obscured_element1498861449574 Marionette TRACE 400 <- [1,8,null,{"value":null}]
15:24:09 INFO - 1498861449575 Marionette TRACE 400 -> [0,9,"deleteSession",{}]
15:24:09 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 342ms
15:24:09 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
15:24:09 INFO - 1498861449576 Marionette TRACE 400 <- [1,9,null,{}]
15:24:09 INFO - 1498861449577 Marionette DEBUG Closed connection 400
15:24:09 INFO - 1498861449578 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49771
15:24:09 INFO - 1498861449579 Marionette DEBUG Closed connection 401
15:24:09 INFO - 1498861449579 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49772
15:24:09 INFO - 1498861449580 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449581 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449583 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449586 Marionette TRACE 402 <- [1,1,null,{"sessionId":"6dda734e-5cf6-4d0e-8544-59b546228f25","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449587 Marionette TRACE 402 -> [0,2,"setTimeouts",{"script":30000}]
15:24:09 INFO - 1498861449587 Marionette TRACE 402 <- [1,2,null,{}]
15:24:09 INFO - 1498861449588 Marionette TRACE 402 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:24:09 INFO - 1498861449589 Marionette TRACE 402 <- [1,3,null,{}]
15:24:09 INFO - 1498861449590 Marionette TRACE 402 -> [0,4,"setTimeouts",{"implicit":0}]
15:24:09 INFO - 1498861449590 Marionette TRACE 402 <- [1,4,null,{}]
15:24:09 INFO - 1498861449593 Marionette TRACE 402 -> [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}]
15:24:09 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1498861449595 Marionette TRACE 402 <- [1,5,null,{"value":null}]
15:24:09 INFO - 1498861449596 Marionette TRACE 402 -> [0,6,"deleteSession",{}]
15:24:09 INFO - 1498861449597 Marionette TRACE 402 <- [1,6,null,{}]
15:24:09 INFO - 1498861449598 Marionette DEBUG Closed connection 402
15:24:09 INFO - 1498861449599 Marionette DEBUG Accepted connection 403 from 127.0.0.1:49773
15:24:09 INFO - 1498861449599 Marionette DEBUG Closed connection 403
15:24:09 INFO - 1498861449600 Marionette DEBUG Accepted connection 404 from 127.0.0.1:49774
15:24:09 INFO - 1498861449601 Marionette TRACE 404 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:24:09 INFO - 1498861449602 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449604 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449607 Marionette TRACE 404 <- [1,1,null,{"sessionId":"1ed9eae1-5b26-4ed7-baf2-670fe167fee4","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449608 Marionette TRACE 404 -> [0,2,"deleteSession",{}]
15:24:09 INFO - 1498861449609 Marionette TRACE 404 <- [1,2,null,{}]
15:24:09 INFO - 1498861449610 Marionette DEBUG Closed connection 404
15:24:09 INFO - 1498861449611 Marionette DEBUG Accepted connection 405 from 127.0.0.1:49775
15:24:09 INFO - 1498861449611 Marionette DEBUG Closed connection 405
15:24:09 INFO - 1498861449612 Marionette DEBUG Accepted connection 406 from 127.0.0.1:49776
15:24:09 INFO - 1498861449613 Marionette TRACE 406 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:24:09 INFO - 1498861449614 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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}
15:24:09 INFO - 1498861449616 Marionette DEBUG Register listener.js for window 2147483649
15:24:09 INFO - 1498861449618 Marionette TRACE 406 <- [1,1,null,{"sessionId":"b470b3d5-c566-4622-a15f-2b1b81e12c88","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":572,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpb9orrh.mozrunner","moz:accessibilityChecks":false}}]
15:24:09 INFO - 1498861449619 Marionette TRACE 406 -> [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"}]
15:24:09 INFO - 1498861449621 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"
15:24:09 INFO - 1498861449623 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"
15:24:09 INFO - 1498861449623 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"
15:24:09 INFO - 1498861449628 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"
15:24:09 INFO - 1498861449630 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"
15:24:09 INFO - 1498861449634 Marionette TRACE 406 <- [1,2,null,{}]
15:24:09 INFO - 1498861449637 Marionette TRACE 406 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
15:24:09 INFO - 1498861449643 Marionette TRACE 406 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e6a1a687-91ce-4ff7-a3af-ac2fb82f0711","ELEMENT":"e6a1a687-91ce-4ff7-a3af-ac2fb82f0711"}}]
15:24:09 INFO - 1498861449644 Marionette TRACE 406 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"e6a1a687-91ce-4ff7-a3af-ac2fb82f0711"}]
15:24:09 INFO - 1498861449665 Marionette TRACE 406 <- [1,4,null,{"value":"none"}]
15:24:09 INFO - 1498861449666 Marionette TRACE 406 -> [0,5,"clickElement",{"id":"e6a1a687-91ce-4ff7-a3af-ac2fb82f0711"}]
15:24:09 INFO - 1498861449680 Marionette TRACE 406 <- [1,5,{"error":"element click intercepted","message":"Element