could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:44:28 INFO - 1499705068553 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}]
09:44:28 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499705068555 Marionette TRACE 352 <- [1,5,null,{"value":null}]
09:44:28 INFO - 1499705068556 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
09:44:28 INFO - 1499705068557 Marionette TRACE 352 <- [1,6,null,{}]
09:44:28 INFO - 1499705068559 Marionette DEBUG Closed connection 352
09:44:28 INFO - 1499705068560 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49768
09:44:28 INFO - 1499705068560 Marionette DEBUG Closed connection 353
09:44:28 INFO - 1499705068561 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49769
09:44:28 INFO - 1499705068562 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:28 INFO - 1499705068562 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068565 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068568 Marionette TRACE 354 <- [1,1,null,{"sessionId":"0a7fe71c-8024-4a26-b7a4-fdfb4266bd67","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068569 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
09:44:28 INFO - 1499705068569 Marionette TRACE 354 <- [1,2,null,{}]
09:44:28 INFO - 1499705068570 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:28 INFO - 1499705068570 Marionette TRACE 354 <- [1,3,null,{}]
09:44:28 INFO - 1499705068571 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:28 INFO - 1499705068572 Marionette TRACE 354 <- [1,4,null,{}]
09:44:28 INFO - 1499705068574 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}]
09:44:28 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499705068576 Marionette TRACE 354 <- [1,5,null,{"value":null}]
09:44:28 INFO - 1499705068577 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
09:44:28 INFO - 1499705068578 Marionette TRACE 354 <- [1,6,null,{}]
09:44:28 INFO - 1499705068579 Marionette DEBUG Closed connection 354
09:44:28 INFO - 1499705068580 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49770
09:44:28 INFO - 1499705068581 Marionette DEBUG Closed connection 355
09:44:28 INFO - 1499705068581 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49771
09:44:28 INFO - 1499705068582 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:28 INFO - 1499705068583 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068585 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068588 Marionette TRACE 356 <- [1,1,null,{"sessionId":"534dc434-c638-4b42-86ca-17de61410f66","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068589 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
09:44:28 INFO - 1499705068590 Marionette TRACE 356 <- [1,2,null,{}]
09:44:28 INFO - 1499705068591 Marionette DEBUG Closed connection 356
09:44:28 INFO - 1499705068592 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49772
09:44:28 INFO - 1499705068593 Marionette DEBUG Closed connection 357
09:44:28 INFO - 1499705068593 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49773
09:44:28 INFO - 1499705068594 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:28 INFO - 1499705068595 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068597 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068600 Marionette TRACE 358 <- [1,1,null,{"sessionId":"6a04eb77-7148-4258-b3eb-a0a6b338b9e4","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068601 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49334/clicks.html"}]
09:44:28 INFO - 1499705068602 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/hidden.html"
09:44:28 INFO - 1499705068609 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/hidden.html"
09:44:28 INFO - 1499705068609 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/hidden.html"
09:44:28 INFO - 1499705068615 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/clicks.html"
09:44:28 INFO - 1499705068619 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/clicks.html"
09:44:28 INFO - 1499705068620 Marionette TRACE 358 <- [1,2,null,{}]
09:44:28 INFO - 1499705068623 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:44:28 INFO - 1499705068625 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"320fccdd-f667-4223-8276-dbc9342309c0","ELEMENT":"320fccdd-f667-4223-8276-dbc9342309c0"}}]
09:44:28 INFO - 1499705068626 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"320fccdd-f667-4223-8276-dbc9342309c0"}]
09:44:28 INFO - 1499705068674 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/clicks.html"
09:44:28 INFO - 1499705068680 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/clicks.html"
09:44:28 INFO - 1499705068680 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/clicks.html"
09:44:28 INFO - 1499705068686 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/test.html"
09:44:28 INFO - 1499705068690 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/test.html"
09:44:28 INFO - 1499705068690 Marionette TRACE 358 <- [1,4,null,{}]
09:44:28 INFO - 1499705068693 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:44:28 INFO - 1499705068698 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8061bf81-4e5c-49f3-8c70-f34182e88587","ELEMENT":"8061bf81-4e5c-49f3-8c70-f34182e88587"}}]
09:44:28 INFO - 1499705068699 Marionette TRACE 358 -> [0,6,"getTitle",{}]
09:44:28 INFO - 1499705068699 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
09:44:28 INFO - 1499705068701 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}]
09:44:28 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499705068703 Marionette TRACE 358 <- [1,7,null,{"value":null}]
09:44:28 INFO - 1499705068704 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
09:44:28 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 147ms
09:44:28 INFO - TEST-START | test_click.py TestClick.test_container_element
09:44:28 INFO - 1499705068705 Marionette TRACE 358 <- [1,8,null,{}]
09:44:28 INFO - 1499705068706 Marionette DEBUG Closed connection 358
09:44:28 INFO - 1499705068707 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49776
09:44:28 INFO - 1499705068708 Marionette DEBUG Closed connection 359
09:44:28 INFO - 1499705068709 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49777
09:44:28 INFO - 1499705068710 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:28 INFO - 1499705068711 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068713 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068716 Marionette TRACE 360 <- [1,1,null,{"sessionId":"d806b534-7ef0-4a0f-85e2-c22125aca80c","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068717 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
09:44:28 INFO - 1499705068717 Marionette TRACE 360 <- [1,2,null,{}]
09:44:28 INFO - 1499705068718 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:28 INFO - 1499705068718 Marionette TRACE 360 <- [1,3,null,{}]
09:44:28 INFO - 1499705068719 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:28 INFO - 1499705068720 Marionette TRACE 360 <- [1,4,null,{}]
09:44:28 INFO - 1499705068722 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}]
09:44:28 INFO - TEST-START: test_click.py TestClick.test_container_element1499705068724 Marionette TRACE 360 <- [1,5,null,{"value":null}]
09:44:28 INFO - 1499705068725 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
09:44:28 INFO - 1499705068726 Marionette TRACE 360 <- [1,6,null,{}]
09:44:28 INFO - 1499705068728 Marionette DEBUG Closed connection 360
09:44:28 INFO - 1499705068728 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49778
09:44:28 INFO - 1499705068729 Marionette DEBUG Closed connection 361
09:44:28 INFO - 1499705068730 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49779
09:44:28 INFO - 1499705068730 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:28 INFO - 1499705068731 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068733 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068736 Marionette TRACE 362 <- [1,1,null,{"sessionId":"ad8cfacd-d8c6-460e-ade1-036880e74797","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068737 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
09:44:28 INFO - 1499705068738 Marionette TRACE 362 <- [1,2,null,{}]
09:44:28 INFO - 1499705068740 Marionette DEBUG Closed connection 362
09:44:28 INFO - 1499705068740 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49780
09:44:28 INFO - 1499705068741 Marionette DEBUG Closed connection 363
09:44:28 INFO - 1499705068741 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49781
09:44:28 INFO - 1499705068742 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:28 INFO - 1499705068743 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:28 INFO - 1499705068745 Marionette DEBUG Register listener.js for window 4294967297
09:44:28 INFO - 1499705068748 Marionette TRACE 364 <- [1,1,null,{"sessionId":"2cac646a-25a5-4cc3-988a-cb8f86095313","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:28 INFO - 1499705068749 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"}]
09:44:28 INFO - 1499705068751 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/test.html"
09:44:28 INFO - 1499705068752 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/test.html"
09:44:28 INFO - 1499705068752 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/test.html"
09:44:28 INFO - 1499705068758 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"
09:44:28 INFO - 1499705068761 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"
09:44:28 INFO - 1499705068769 Marionette TRACE 364 <- [1,2,null,{}]
09:44:28 INFO - 1499705068773 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:44:28 INFO - 1499705068780 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5793f1bf-233b-4daa-8814-df2bd3251a63","ELEMENT":"5793f1bf-233b-4daa-8814-df2bd3251a63"}}]
09:44:28 INFO - 1499705068781 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"5793f1bf-233b-4daa-8814-df2bd3251a63"}]
09:44:29 INFO - 1499705069020 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:44:29 INFO - 1499705069021 Marionette TRACE 364 <- [1,4,null,{}]
09:44:29 INFO - 1499705069022 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"5793f1bf-233b-4daa-8814-df2bd3251a63","name":"selected"}]
09:44:29 INFO - 1499705069026 Marionette TRACE 364 <- [1,5,null,{"value":true}]
09:44:29 INFO - 1499705069028 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}]
09:44:29 INFO - TEST-END: test_click.py TestClick.test_container_element1499705069030 Marionette TRACE 364 <- [1,6,null,{"value":null}]
09:44:29 INFO - 1499705069031 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
09:44:29 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 327ms
09:44:29 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:44:29 INFO - 1499705069032 Marionette TRACE 364 <- [1,7,null,{}]
09:44:29 INFO - 1499705069033 Marionette DEBUG Closed connection 364
09:44:29 INFO - 1499705069034 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49782
09:44:29 INFO - 1499705069035 Marionette DEBUG Closed connection 365
09:44:29 INFO - 1499705069036 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49783
09:44:29 INFO - 1499705069036 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069037 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069039 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069042 Marionette TRACE 366 <- [1,1,null,{"sessionId":"8f196779-0249-4ce2-a2d6-d7a663711425","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069043 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
09:44:29 INFO - 1499705069043 Marionette TRACE 366 <- [1,2,null,{}]
09:44:29 INFO - 1499705069044 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:29 INFO - 1499705069045 Marionette TRACE 366 <- [1,3,null,{}]
09:44:29 INFO - 1499705069046 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:29 INFO - 1499705069046 Marionette TRACE 366 <- [1,4,null,{}]
09:44:29 INFO - 1499705069048 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}]
09:44:29 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499705069050 Marionette TRACE 366 <- [1,5,null,{"value":null}]
09:44:29 INFO - 1499705069051 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
09:44:29 INFO - 1499705069052 Marionette TRACE 366 <- [1,6,null,{}]
09:44:29 INFO - 1499705069053 Marionette DEBUG Closed connection 366
09:44:29 INFO - 1499705069054 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49784
09:44:29 INFO - 1499705069054 Marionette DEBUG Closed connection 367
09:44:29 INFO - 1499705069055 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49785
09:44:29 INFO - 1499705069056 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069057 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069059 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069062 Marionette TRACE 368 <- [1,1,null,{"sessionId":"daaf03cb-a339-49f9-9f20-35147163598a","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069063 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
09:44:29 INFO - 1499705069065 Marionette TRACE 368 <- [1,2,null,{}]
09:44:29 INFO - 1499705069066 Marionette DEBUG Closed connection 368
09:44:29 INFO - 1499705069067 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49786
09:44:29 INFO - 1499705069067 Marionette DEBUG Closed connection 369
09:44:29 INFO - 1499705069068 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49787
09:44:29 INFO - 1499705069069 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:29 INFO - 1499705069069 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069071 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069074 Marionette TRACE 370 <- [1,1,null,{"sessionId":"0fcd57ea-d74b-46d1-ae62-320e48317566","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069075 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"}]
09:44:29 INFO - 1499705069077 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"
09:44:29 INFO - 1499705069080 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"
09:44:29 INFO - 1499705069080 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"
09:44:29 INFO - 1499705069087 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"
09:44:29 INFO - 1499705069091 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"
09:44:29 INFO - 1499705069093 Marionette TRACE 370 <- [1,2,null,{}]
09:44:29 INFO - 1499705069100 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:44:29 INFO - 1499705069102 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"98898f4a-5554-42bf-bf7f-81b436430bbc","ELEMENT":"98898f4a-5554-42bf-bf7f-81b436430bbc"}}]
09:44:29 INFO - 1499705069103 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"98898f4a-5554-42bf-bf7f-81b436430bbc"}]
09:44:29 INFO - 1499705069341 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:44:29 INFO - 1499705069342 Marionette TRACE 370 <- [1,4,null,{}]
09:44:29 INFO - 1499705069343 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"98898f4a-5554-42bf-bf7f-81b436430bbc","name":"selected"}]
09:44:29 INFO - 1499705069346 Marionette TRACE 370 <- [1,5,null,{"value":true}]
09:44:29 INFO - 1499705069348 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}]
09:44:29 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499705069350 Marionette TRACE 370 <- [1,6,null,{"value":null}]
09:44:29 INFO - 1499705069351 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
09:44:29 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 320ms
09:44:29 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:44:29 INFO - 1499705069352 Marionette TRACE 370 <- [1,7,null,{}]
09:44:29 INFO - 1499705069354 Marionette DEBUG Closed connection 370
09:44:29 INFO - 1499705069354 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49788
09:44:29 INFO - 1499705069355 Marionette DEBUG Closed connection 371
09:44:29 INFO - 1499705069356 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49789
09:44:29 INFO - 1499705069357 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069357 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069360 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069363 Marionette TRACE 372 <- [1,1,null,{"sessionId":"53967864-4ed2-48e0-a413-9755a2582f51","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069364 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
09:44:29 INFO - 1499705069364 Marionette TRACE 372 <- [1,2,null,{}]
09:44:29 INFO - 1499705069365 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:29 INFO - 1499705069365 Marionette TRACE 372 <- [1,3,null,{}]
09:44:29 INFO - 1499705069366 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:29 INFO - 1499705069366 Marionette TRACE 372 <- [1,4,null,{}]
09:44:29 INFO - 1499705069368 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}]
09:44:29 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499705069371 Marionette TRACE 372 <- [1,5,null,{"value":null}]
09:44:29 INFO - 1499705069371 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
09:44:29 INFO - 1499705069373 Marionette TRACE 372 <- [1,6,null,{}]
09:44:29 INFO - 1499705069375 Marionette DEBUG Closed connection 372
09:44:29 INFO - 1499705069375 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49790
09:44:29 INFO - 1499705069376 Marionette DEBUG Closed connection 373
09:44:29 INFO - 1499705069377 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49791
09:44:29 INFO - 1499705069378 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069378 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069380 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069383 Marionette TRACE 374 <- [1,1,null,{"sessionId":"5cae1668-e7e8-4edc-b5b8-cf7bae8bc047","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069384 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
09:44:29 INFO - 1499705069385 Marionette TRACE 374 <- [1,2,null,{}]
09:44:29 INFO - 1499705069386 Marionette DEBUG Closed connection 374
09:44:29 INFO - 1499705069387 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49792
09:44:29 INFO - 1499705069388 Marionette DEBUG Closed connection 375
09:44:29 INFO - 1499705069388 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49793
09:44:29 INFO - 1499705069389 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:29 INFO - 1499705069390 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069392 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069395 Marionette TRACE 376 <- [1,1,null,{"sessionId":"5057fa4d-5020-4527-9bca-1d21366e257e","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069396 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"}]
09:44:29 INFO - 1499705069403 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"
09:44:29 INFO - 1499705069404 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"
09:44:29 INFO - 1499705069405 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"
09:44:29 INFO - 1499705069412 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"
09:44:29 INFO - 1499705069414 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"
09:44:29 INFO - 1499705069419 Marionette TRACE 376 <- [1,2,null,{}]
09:44:29 INFO - 1499705069422 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:44:29 INFO - 1499705069424 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c3e2657f-ac63-4113-860a-15cfc7d18191","ELEMENT":"c3e2657f-ac63-4113-860a-15cfc7d18191"}}]
09:44:29 INFO - 1499705069425 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"c3e2657f-ac63-4113-860a-15cfc7d18191"}]
09:44:29 INFO - 1499705069664 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:44:29 INFO - 1499705069665 Marionette TRACE 376 <- [1,4,null,{}]
09:44:29 INFO - 1499705069667 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}]
09:44:29 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499705069669 Marionette TRACE 376 <- [1,5,null,{"value":null}]
09:44:29 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 319ms
09:44:29 INFO - 1499705069670 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
09:44:29 INFO - 1499705069671 Marionette TRACE 376 <- [1,6,null,{}]
09:44:29 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:44:29 INFO - 1499705069673 Marionette DEBUG Closed connection 376
09:44:29 INFO - 1499705069674 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49794
09:44:29 INFO - 1499705069675 Marionette DEBUG Closed connection 377
09:44:29 INFO - 1499705069675 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49795
09:44:29 INFO - 1499705069676 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069677 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069679 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069689 Marionette TRACE 378 <- [1,1,null,{"sessionId":"d7be1be2-13bd-4006-986b-93312ace7dbf","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069690 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
09:44:29 INFO - 1499705069690 Marionette TRACE 378 <- [1,2,null,{}]
09:44:29 INFO - 1499705069691 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:29 INFO - 1499705069692 Marionette TRACE 378 <- [1,3,null,{}]
09:44:29 INFO - 1499705069693 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:29 INFO - 1499705069693 Marionette TRACE 378 <- [1,4,null,{}]
09:44:29 INFO - 1499705069695 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}]
09:44:29 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499705069697 Marionette TRACE 378 <- [1,5,null,{"value":null}]
09:44:29 INFO - 1499705069698 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
09:44:29 INFO - 1499705069699 Marionette TRACE 378 <- [1,6,null,{}]
09:44:29 INFO - 1499705069701 Marionette DEBUG Closed connection 378
09:44:29 INFO - 1499705069701 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49796
09:44:29 INFO - 1499705069702 Marionette DEBUG Closed connection 379
09:44:29 INFO - 1499705069702 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49797
09:44:29 INFO - 1499705069703 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069704 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069706 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069709 Marionette TRACE 380 <- [1,1,null,{"sessionId":"f5b6bc0f-c6a5-4c80-bb35-a1584df32e12","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069711 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
09:44:29 INFO - 1499705069712 Marionette TRACE 380 <- [1,2,null,{}]
09:44:29 INFO - 1499705069713 Marionette DEBUG Closed connection 380
09:44:29 INFO - 1499705069714 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49798
09:44:29 INFO - 1499705069714 Marionette DEBUG Closed connection 381
09:44:29 INFO - 1499705069715 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49799
09:44:29 INFO - 1499705069716 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:29 INFO - 1499705069717 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:29 INFO - 1499705069719 Marionette DEBUG Register listener.js for window 4294967297
09:44:29 INFO - 1499705069721 Marionette TRACE 382 <- [1,1,null,{"sessionId":"bf944d41-0806-4847-90b1-c772a6dfdd24","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:29 INFO - 1499705069723 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"}]
09:44:29 INFO - 1499705069724 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"
09:44:29 INFO - 1499705069726 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"
09:44:29 INFO - 1499705069726 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"
09:44:29 INFO - 1499705069731 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"
09:44:29 INFO - 1499705069734 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"
09:44:29 INFO - 1499705069736 Marionette TRACE 382 <- [1,2,null,{}]
09:44:29 INFO - 1499705069739 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:44:29 INFO - 1499705069745 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1005c504-7b00-4287-b6b9-12cf45718c8a","ELEMENT":"1005c504-7b00-4287-b6b9-12cf45718c8a"}}]
09:44:29 INFO - 1499705069746 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"1005c504-7b00-4287-b6b9-12cf45718c8a"}]
09:44:29 INFO - 1499705069984 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:44:29 INFO - 1499705069985 Marionette TRACE 382 <- [1,4,null,{}]
09:44:29 INFO - 1499705069986 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}]
09:44:29 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499705069989 Marionette TRACE 382 <- [1,5,null,{"value":null}]
09:44:29 INFO - 1499705069990 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
09:44:29 INFO - 1499705069991 Marionette TRACE 382 <- [1,6,null,{}]
09:44:29 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 319ms
09:44:29 INFO - TEST-START | test_click.py TestClick.test_input_file
09:44:29 INFO - 1499705069992 Marionette DEBUG Closed connection 382
09:44:29 INFO - 1499705069994 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49800
09:44:29 INFO - 1499705069995 Marionette DEBUG Closed connection 383
09:44:29 INFO - 1499705069996 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49801
09:44:29 INFO - 1499705069996 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:29 INFO - 1499705069997 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705069999 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070002 Marionette TRACE 384 <- [1,1,null,{"sessionId":"7dfaa3d5-112e-4819-a98c-268a96ec05b0","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070003 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
09:44:30 INFO - 1499705070003 Marionette TRACE 384 <- [1,2,null,{}]
09:44:30 INFO - 1499705070004 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:30 INFO - 1499705070005 Marionette TRACE 384 <- [1,3,null,{}]
09:44:30 INFO - 1499705070006 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:30 INFO - 1499705070006 Marionette TRACE 384 <- [1,4,null,{}]
09:44:30 INFO - 1499705070008 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}]
09:44:30 INFO - TEST-START: test_click.py TestClick.test_input_file1499705070010 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:44:30 INFO - 1499705070011 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:44:30 INFO - 1499705070012 Marionette TRACE 384 <- [1,6,null,{}]
09:44:30 INFO - 1499705070014 Marionette DEBUG Closed connection 384
09:44:30 INFO - 1499705070014 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49802
09:44:30 INFO - 1499705070015 Marionette DEBUG Closed connection 385
09:44:30 INFO - 1499705070016 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49803
09:44:30 INFO - 1499705070017 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:30 INFO - 1499705070017 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070019 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070022 Marionette TRACE 386 <- [1,1,null,{"sessionId":"be996649-7626-4dc0-a8e2-4d72d86f2b1e","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070023 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
09:44:30 INFO - 1499705070024 Marionette TRACE 386 <- [1,2,null,{}]
09:44:30 INFO - 1499705070025 Marionette DEBUG Closed connection 386
09:44:30 INFO - 1499705070026 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49804
09:44:30 INFO - 1499705070027 Marionette DEBUG Closed connection 387
09:44:30 INFO - 1499705070028 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49805
09:44:30 INFO - 1499705070029 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:30 INFO - 1499705070030 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070032 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070034 Marionette TRACE 388 <- [1,1,null,{"sessionId":"067431f8-e57c-40cc-890f-3c80e87616b8","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070036 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:44:30 INFO - 1499705070037 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"
09:44:30 INFO - 1499705070039 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"
09:44:30 INFO - 1499705070039 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"
09:44:30 INFO - 1499705070045 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:44:30 INFO - 1499705070049 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:44:30 INFO - 1499705070050 Marionette TRACE 388 <- [1,2,null,{}]
09:44:30 INFO - 1499705070052 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:44:30 INFO - 1499705070054 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d21ec8e0-0dfc-468f-bce8-91664add0e91","ELEMENT":"d21ec8e0-0dfc-468f-bce8-91664add0e91"}}]
09:44:30 INFO - 1499705070055 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"d21ec8e0-0dfc-468f-bce8-91664add0e91"}]
09:44:30 INFO - 1499705070086 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:44:30 INFO - 1499705070087 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}]
09:44:30 INFO - TEST-END: test_click.py TestClick.test_input_file1499705070091 Marionette TRACE 388 <- [1,5,null,{"value":null}]
09:44:30 INFO - 1499705070092 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
09:44:30 INFO - 1499705070093 Marionette TRACE 388 <- [1,6,null,{}]
09:44:30 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 101ms
09:44:30 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:44:30 INFO - 1499705070094 Marionette DEBUG Closed connection 388
09:44:30 INFO - 1499705070096 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49806
09:44:30 INFO - 1499705070096 Marionette DEBUG Closed connection 389
09:44:30 INFO - 1499705070097 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49807
09:44:30 INFO - 1499705070097 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:30 INFO - 1499705070098 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070100 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070103 Marionette TRACE 390 <- [1,1,null,{"sessionId":"8930adcd-b5c0-43ed-b9e3-a76d6959c253","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070104 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
09:44:30 INFO - 1499705070104 Marionette TRACE 390 <- [1,2,null,{}]
09:44:30 INFO - 1499705070105 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:30 INFO - 1499705070106 Marionette TRACE 390 <- [1,3,null,{}]
09:44:30 INFO - 1499705070106 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:30 INFO - 1499705070107 Marionette TRACE 390 <- [1,4,null,{}]
09:44:30 INFO - 1499705070109 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}]
09:44:30 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499705070111 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:44:30 INFO - 1499705070112 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:44:30 INFO - 1499705070113 Marionette TRACE 390 <- [1,6,null,{}]
09:44:30 INFO - 1499705070114 Marionette DEBUG Closed connection 390
09:44:30 INFO - 1499705070115 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49808
09:44:30 INFO - 1499705070116 Marionette DEBUG Closed connection 391
09:44:30 INFO - 1499705070117 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49809
09:44:30 INFO - 1499705070117 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:30 INFO - 1499705070118 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070120 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070123 Marionette TRACE 392 <- [1,1,null,{"sessionId":"c88aa822-a99b-4da6-9cf9-5a1b8d6de92b","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070124 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
09:44:30 INFO - 1499705070125 Marionette TRACE 392 <- [1,2,null,{}]
09:44:30 INFO - 1499705070127 Marionette DEBUG Closed connection 392
09:44:30 INFO - 1499705070127 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49810
09:44:30 INFO - 1499705070128 Marionette DEBUG Closed connection 393
09:44:30 INFO - 1499705070128 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49811
09:44:30 INFO - 1499705070129 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:30 INFO - 1499705070130 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070132 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070134 Marionette TRACE 394 <- [1,1,null,{"sessionId":"6fa502da-b855-49c6-8224-38eb0974dbd5","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070135 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"}]
09:44:30 INFO - 1499705070137 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:44:30 INFO - 1499705070139 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:44:30 INFO - 1499705070139 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:44:30 INFO - 1499705070145 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"
09:44:30 INFO - 1499705070147 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"
09:44:30 INFO - 1499705070149 Marionette TRACE 394 <- [1,2,null,{}]
09:44:30 INFO - 1499705070152 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:44:30 INFO - 1499705070154 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f1d3d829-3d50-4432-ac92-f9ca7f63222b","ELEMENT":"f1d3d829-3d50-4432-ac92-f9ca7f63222b"}}]
09:44:30 INFO - 1499705070155 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:44:30 INFO - 1499705070156 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4fc21807-210e-4ebe-b817-e7d15e7c60e7","ELEMENT":"4fc21807-210e-4ebe-b817-e7d15e7c60e7"}}]
09:44:30 INFO - 1499705070162 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"f1d3d829-3d50-4432-ac92-f9ca7f63222b"}]
09:44:30 INFO - 1499705070396 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:44:30 INFO - 1499705070397 Marionette TRACE 394 <- [1,5,null,{}]
09:44:30 INFO - 1499705070398 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"4fc21807-210e-4ebe-b817-e7d15e7c60e7"}]
09:44:30 INFO - 1499705070411 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:44:30 INFO - 1499705070413 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:44:30 INFO - 1499705070416 Marionette TRACE 394 <- [1,7,null,{"value":false}]
09:44:30 INFO - 1499705070417 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}]
09:44:30 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499705070419 Marionette TRACE 394 <- [1,8,null,{"value":null}]
09:44:30 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 327ms
09:44:30 INFO - 1499705070420 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
09:44:30 INFO - 1499705070421 Marionette TRACE 394 <- [1,9,null,{}]
09:44:30 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:44:30 INFO - 1499705070422 Marionette DEBUG Closed connection 394
09:44:30 INFO - 1499705070424 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49812
09:44:30 INFO - 1499705070425 Marionette DEBUG Closed connection 395
09:44:30 INFO - 1499705070425 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49813
09:44:30 INFO - 1499705070426 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:30 INFO - 1499705070427 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070429 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070432 Marionette TRACE 396 <- [1,1,null,{"sessionId":"88c2535a-e11c-42f4-8095-3c75598ac96a","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070433 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
09:44:30 INFO - 1499705070433 Marionette TRACE 396 <- [1,2,null,{}]
09:44:30 INFO - 1499705070434 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:44:30 INFO - 1499705070435 Marionette TRACE 396 <- [1,3,null,{}]
09:44:30 INFO - 1499705070435 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
09:44:30 INFO - 1499705070436 Marionette TRACE 396 <- [1,4,null,{}]
09:44:30 INFO - 1499705070438 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}]
09:44:30 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499705070440 Marionette TRACE 396 <- [1,5,null,{"value":null}]
09:44:30 INFO - 1499705070441 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
09:44:30 INFO - 1499705070442 Marionette TRACE 396 <- [1,6,null,{}]
09:44:30 INFO - 1499705070443 Marionette DEBUG Closed connection 396
09:44:30 INFO - 1499705070444 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49814
09:44:30 INFO - 1499705070444 Marionette DEBUG Closed connection 397
09:44:30 INFO - 1499705070445 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49815
09:44:30 INFO - 1499705070446 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:44:30 INFO - 1499705070447 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070449 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070451 Marionette TRACE 398 <- [1,1,null,{"sessionId":"eb1df466-62e9-43ab-8549-04f4bbc4f946","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070452 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
09:44:30 INFO - 1499705070453 Marionette TRACE 398 <- [1,2,null,{}]
09:44:30 INFO - 1499705070455 Marionette DEBUG Closed connection 398
09:44:30 INFO - 1499705070455 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49816
09:44:30 INFO - 1499705070456 Marionette DEBUG Closed connection 399
09:44:30 INFO - 1499705070456 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49817
09:44:30 INFO - 1499705070457 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:44:30 INFO - 1499705070458 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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}
09:44:30 INFO - 1499705070460 Marionette DEBUG Register listener.js for window 4294967297
09:44:30 INFO - 1499705070462 Marionette TRACE 400 <- [1,1,null,{"sessionId":"c4412e16-a950-4223-9d91-d112a1473f30","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":736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-262.001\\AppData\\Local\\Temp\\tmpitcjse.mozrunner","moz:accessibilityChecks":false}}]
09:44:30 INFO - 1499705070464 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"}]
09:44:30 INFO - 1499705070465 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"
09:44:30 INFO - 1499705070467 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"
09:44:30 INFO - 1499705070467 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"
09:44:30 INFO - 1499705070473 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"
09:44:30 INFO - 1499705070475 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"
09:44:30 INFO - 1499705070481 Marionette TRACE 400 <- [1,2,null,{}]
09:44:30 INFO - 1499705070484 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:44:30 INFO - 1499705070487 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"da613624-e123-49dd-8c1a-d6418b061546","ELEMENT":"da613624-e123-49dd-8c1a-d6418b061546"}}]
09:44:30 INFO - 1499705070488 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"da613624-e123-49dd-8c1a-d6418b061546"}]
09:44:30 INFO - 1499705070514 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
09:44:30 INFO - 1499705070516 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"da613624-e123-49dd-8c1a-d6418b061546"}]
09:44:30 INFO - 1499705070529 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element