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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:34:05 INFO - 1500744845579 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}]
10:34:05 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500744845586 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:34:05 INFO - 1500744845588 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845592 Marionette TRACE 352 <- [1,6,null,{}]
10:34:05 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 466ms
10:34:05 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845596 Marionette DEBUG Closed connection 352
10:34:05 INFO - 1500744845598 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49788
10:34:05 INFO - 1500744845599 Marionette DEBUG Closed connection 353
10:34:05 INFO - 1500744845601 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49789
10:34:05 INFO - 1500744845603 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:05 INFO - 1500744845605 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:05 INFO - 1500744845625 Marionette DEBUG Register listener.js for window 6442450945
10:34:05 INFO - 1500744845639 Marionette TRACE 354 <- [1,1,null,{"sessionId":"00ed133a-fac5-42b7-8954-a638cc448974","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:05 INFO - 1500744845642 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:34:05 INFO - 1500744845643 Marionette TRACE 354 <- [1,2,null,{}]
10:34:05 INFO - 1500744845645 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:05 INFO - 1500744845647 Marionette TRACE 354 <- [1,3,null,{}]
10:34:05 INFO - 1500744845648 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:05 INFO - 1500744845650 Marionette TRACE 354 <- [1,4,null,{}]
10:34:05 INFO - 1500744845652 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}]
10:34:05 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500744845660 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:34:05 INFO - 1500744845662 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845666 Marionette TRACE 354 <- [1,6,null,{}]
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845670 Marionette DEBUG Closed connection 354
10:34:05 INFO - 1500744845672 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49790
10:34:05 INFO - 1500744845674 Marionette DEBUG Closed connection 355
10:34:05 INFO - 1500744845675 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49791
10:34:05 INFO - 1500744845677 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:05 INFO - 1500744845679 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:05 INFO - 1500744845700 Marionette DEBUG Register listener.js for window 6442450945
10:34:05 INFO - 1500744845711 Marionette TRACE 356 <- [1,1,null,{"sessionId":"930e4a98-79a0-46a1-866b-6bf788f7ad3e","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:05 INFO - 1500744845714 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845718 Marionette TRACE 356 <- [1,2,null,{}]
10:34:05 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:05 INFO - 1500744845722 Marionette DEBUG Closed connection 356
10:34:05 INFO - 1500744845723 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49792
10:34:05 INFO - 1500744845725 Marionette DEBUG Closed connection 357
10:34:05 INFO - 1500744845726 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49793
10:34:05 INFO - 1500744845728 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:05 INFO - 1500744845731 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:05 INFO - 1500744845751 Marionette DEBUG Register listener.js for window 6442450945
10:34:05 INFO - 1500744845762 Marionette TRACE 358 <- [1,1,null,{"sessionId":"6fc7a714-c92f-4d37-a2b9-81bd3eb52689","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:05 INFO - 1500744845765 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49330/clicks.html"}]
10:34:05 INFO - 1500744845769 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/hidden.html"
10:34:05 INFO - 1500744845784 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/hidden.html"
10:34:05 INFO - 1500744845784 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/hidden.html"
10:34:05 INFO - ++DOMWINDOW == 17 (000000B1443B3000) [pid = 1656] [serial = 25] [outer = 000000B13702B000]
10:34:05 INFO - 1500744845807 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/clicks.html"
10:34:05 INFO - 1500744845818 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/clicks.html"
10:34:05 INFO - 1500744845824 Marionette TRACE 358 <- [1,2,null,{}]
10:34:05 INFO - 1500744845839 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:34:06 INFO - 1500744846027 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"758aabc0-6f48-45bd-96f8-17c01c21be53","ELEMENT":"758aabc0-6f48-45bd-96f8-17c01c21be53"}}]
10:34:06 INFO - 1500744846029 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"758aabc0-6f48-45bd-96f8-17c01c21be53"}]
10:34:06 INFO - 1500744846251 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/clicks.html"
10:34:06 INFO - 1500744846276 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/clicks.html"
10:34:06 INFO - 1500744846277 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/clicks.html"
10:34:06 INFO - ++DOMWINDOW == 18 (000000B14231A000) [pid = 1656] [serial = 26] [outer = 000000B13702B000]
10:34:06 INFO - 1500744846305 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/test.html"
10:34:06 INFO - 1500744846308 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/test.html"
10:34:06 INFO - 1500744846315 Marionette TRACE 358 <- [1,4,null,{}]
10:34:06 INFO - 1500744846332 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:34:06 INFO - 1500744846338 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"84935f76-0a20-450e-a4e4-a1e160d8f35d","ELEMENT":"84935f76-0a20-450e-a4e4-a1e160d8f35d"}}]
10:34:06 INFO - 1500744846340 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:34:06 INFO - 1500744846342 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:34:06 INFO - 1500744846344 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}]
10:34:06 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500744846352 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:34:06 INFO - 1500744846354 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:34:06 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 766ms
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846358 Marionette TRACE 358 <- [1,8,null,{}]
10:34:06 INFO - TEST-START | test_click.py TestClick.test_container_element
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846362 Marionette DEBUG Closed connection 358
10:34:06 INFO - 1500744846364 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49796
10:34:06 INFO - 1500744846365 Marionette DEBUG Closed connection 359
10:34:06 INFO - 1500744846367 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49797
10:34:06 INFO - 1500744846369 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:06 INFO - 1500744846371 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:06 INFO - 1500744846392 Marionette DEBUG Register listener.js for window 6442450945
10:34:06 INFO - 1500744846416 Marionette TRACE 360 <- [1,1,null,{"sessionId":"5f78b321-6b55-47f2-9c60-9a3beb9c7f42","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:06 INFO - 1500744846419 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:34:06 INFO - 1500744846420 Marionette TRACE 360 <- [1,2,null,{}]
10:34:06 INFO - 1500744846422 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:06 INFO - 1500744846424 Marionette TRACE 360 <- [1,3,null,{}]
10:34:06 INFO - 1500744846426 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:06 INFO - 1500744846427 Marionette TRACE 360 <- [1,4,null,{}]
10:34:06 INFO - 1500744846430 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}]
10:34:06 INFO - TEST-START: test_click.py TestClick.test_container_element1500744846437 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:34:06 INFO - 1500744846439 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846444 Marionette TRACE 360 <- [1,6,null,{}]
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846448 Marionette DEBUG Closed connection 360
10:34:06 INFO - 1500744846449 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49798
10:34:06 INFO - 1500744846451 Marionette DEBUG Closed connection 361
10:34:06 INFO - 1500744846452 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49799
10:34:06 INFO - 1500744846454 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:06 INFO - 1500744846456 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:06 INFO - 1500744846477 Marionette DEBUG Register listener.js for window 6442450945
10:34:06 INFO - 1500744846488 Marionette TRACE 362 <- [1,1,null,{"sessionId":"87551e5a-e398-4a10-afbe-c391b46b9d9f","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:06 INFO - 1500744846490 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846495 Marionette TRACE 362 <- [1,2,null,{}]
10:34:06 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:06 INFO - 1500744846498 Marionette DEBUG Closed connection 362
10:34:06 INFO - 1500744846500 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49800
10:34:06 INFO - 1500744846501 Marionette DEBUG Closed connection 363
10:34:06 INFO - 1500744846503 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49801
10:34:06 INFO - 1500744846505 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:06 INFO - 1500744846507 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:06 INFO - 1500744846528 Marionette DEBUG Register listener.js for window 6442450945
10:34:06 INFO - 1500744846539 Marionette TRACE 364 <- [1,1,null,{"sessionId":"bcd9e5fd-2bdc-4f14-8f7c-5978bc934d58","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:06 INFO - 1500744846542 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"}]
10:34:06 INFO - 1500744846546 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/test.html"
10:34:06 INFO - 1500744846550 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/test.html"
10:34:06 INFO - 1500744846551 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/test.html"
10:34:06 INFO - ++DOMWINDOW == 19 (000000B14265E800) [pid = 1656] [serial = 27] [outer = 000000B13702B000]
10:34:06 INFO - 1500744846572 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"
10:34:06 INFO - 1500744846579 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"
10:34:06 INFO - 1500744846602 Marionette TRACE 364 <- [1,2,null,{}]
10:34:06 INFO - 1500744846619 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:34:06 INFO - 1500744846625 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d18bfe82-64a4-4310-bedc-f60c503a912c","ELEMENT":"d18bfe82-64a4-4310-bedc-f60c503a912c"}}]
10:34:06 INFO - 1500744846627 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"d18bfe82-64a4-4310-bedc-f60c503a912c"}]
10:34:06 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:34:06 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:34:06 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:34:07 INFO - 1500744847049 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:34:07 INFO - 1500744847051 Marionette TRACE 364 <- [1,4,null,{}]
10:34:07 INFO - 1500744847053 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"d18bfe82-64a4-4310-bedc-f60c503a912c","name":"selected"}]
10:34:07 INFO - 1500744847080 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:34:07 INFO - 1500744847082 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}]
10:34:07 INFO - TEST-END: test_click.py TestClick.test_container_element1500744847089 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:34:07 INFO - 1500744847091 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 736ms
10:34:07 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:34:07 INFO - 1500744847095 Marionette TRACE 364 <- [1,7,null,{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - 1500744847100 Marionette DEBUG Closed connection 364
10:34:07 INFO - 1500744847101 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49802
10:34:07 INFO - 1500744847103 Marionette DEBUG Closed connection 365
10:34:07 INFO - 1500744847104 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49803
10:34:07 INFO - 1500744847106 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:07 INFO - 1500744847108 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:07 INFO - 1500744847139 Marionette DEBUG Register listener.js for window 6442450945
10:34:07 INFO - 1500744847150 Marionette TRACE 366 <- [1,1,null,{"sessionId":"f7e92008-f407-41b9-92f3-3f3fe21d2d51","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:07 INFO - 1500744847153 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:34:07 INFO - 1500744847155 Marionette TRACE 366 <- [1,2,null,{}]
10:34:07 INFO - 1500744847156 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:07 INFO - 1500744847158 Marionette TRACE 366 <- [1,3,null,{}]
10:34:07 INFO - 1500744847160 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:07 INFO - 1500744847161 Marionette TRACE 366 <- [1,4,null,{}]
10:34:07 INFO - 1500744847164 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}]
10:34:07 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500744847171 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:34:07 INFO - 1500744847172 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - 1500744847177 Marionette TRACE 366 <- [1,6,null,{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - 1500744847181 Marionette DEBUG Closed connection 366
10:34:07 INFO - 1500744847182 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49804
10:34:07 INFO - 1500744847184 Marionette DEBUG Closed connection 367
10:34:07 INFO - 1500744847185 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49805
10:34:07 INFO - 1500744847188 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:07 INFO - 1500744847190 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:07 INFO - 1500744847211 Marionette DEBUG Register listener.js for window 6442450945
10:34:07 INFO - 1500744847222 Marionette TRACE 368 <- [1,1,null,{"sessionId":"259197ab-8312-4d36-b048-c1bcb20d9a9a","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:07 INFO - 1500744847225 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - 1500744847230 Marionette TRACE 368 <- [1,2,null,{}]
10:34:07 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:07 INFO - 1500744847234 Marionette DEBUG Closed connection 368
10:34:07 INFO - 1500744847235 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49806
10:34:07 INFO - 1500744847237 Marionette DEBUG Closed connection 369
10:34:07 INFO - 1500744847239 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49807
10:34:07 INFO - 1500744847241 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:07 INFO - 1500744847243 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:07 INFO - 1500744847681 Marionette DEBUG Register listener.js for window 6442450945
10:34:07 INFO - 1500744847692 Marionette TRACE 370 <- [1,1,null,{"sessionId":"4b4a029a-624c-4427-bfc5-e938fabd47fe","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:07 INFO - 1500744847695 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"}]
10:34:07 INFO - 1500744847737 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"
10:34:07 INFO - 1500744847742 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"
10:34:07 INFO - 1500744847742 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"
10:34:07 INFO - ++DOMWINDOW == 20 (000000B142654000) [pid = 1656] [serial = 28] [outer = 000000B13702B000]
10:34:07 INFO - 1500744847767 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"
10:34:07 INFO - 1500744847771 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"
10:34:07 INFO - 1500744847780 Marionette TRACE 370 <- [1,2,null,{}]
10:34:07 INFO - 1500744847795 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:34:07 INFO - 1500744847832 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"50e6c4e6-9280-4410-8531-7865aff48435","ELEMENT":"50e6c4e6-9280-4410-8531-7865aff48435"}}]
10:34:07 INFO - 1500744847834 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"50e6c4e6-9280-4410-8531-7865aff48435"}]
10:34:08 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:34:08 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:34:08 INFO - [Child 1656] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:34:08 INFO - 1500744848296 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:34:08 INFO - 1500744848298 Marionette TRACE 370 <- [1,4,null,{}]
10:34:08 INFO - 1500744848300 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"50e6c4e6-9280-4410-8531-7865aff48435","name":"selected"}]
10:34:08 INFO - 1500744848338 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:34:08 INFO - 1500744848516 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}]
10:34:08 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500744848524 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:34:08 INFO - 1500744848526 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:34:08 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1434ms
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848530 Marionette TRACE 370 <- [1,7,null,{}]
10:34:08 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848534 Marionette DEBUG Closed connection 370
10:34:08 INFO - 1500744848536 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49808
10:34:08 INFO - 1500744848537 Marionette DEBUG Closed connection 371
10:34:08 INFO - 1500744848539 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49809
10:34:08 INFO - 1500744848545 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:08 INFO - 1500744848547 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:08 INFO - 1500744848568 Marionette DEBUG Register listener.js for window 6442450945
10:34:08 INFO - 1500744848579 Marionette TRACE 372 <- [1,1,null,{"sessionId":"8fdc270f-f66b-4d44-993f-b6acb3bb7a25","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:08 INFO - 1500744848582 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:34:08 INFO - 1500744848584 Marionette TRACE 372 <- [1,2,null,{}]
10:34:08 INFO - 1500744848585 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:08 INFO - 1500744848587 Marionette TRACE 372 <- [1,3,null,{}]
10:34:08 INFO - 1500744848589 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:08 INFO - 1500744848590 Marionette TRACE 372 <- [1,4,null,{}]
10:34:08 INFO - 1500744848593 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}]
10:34:08 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500744848600 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:34:08 INFO - 1500744848601 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848606 Marionette TRACE 372 <- [1,6,null,{}]
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848614 Marionette DEBUG Closed connection 372
10:34:08 INFO - 1500744848616 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49810
10:34:08 INFO - 1500744848619 Marionette DEBUG Closed connection 373
10:34:08 INFO - 1500744848620 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49811
10:34:08 INFO - 1500744848622 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:08 INFO - 1500744848624 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:08 INFO - 1500744848646 Marionette DEBUG Register listener.js for window 6442450945
10:34:08 INFO - 1500744848657 Marionette TRACE 374 <- [1,1,null,{"sessionId":"54efb231-7fc6-45a5-b7f2-a648de738c5d","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:08 INFO - 1500744848660 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848664 Marionette TRACE 374 <- [1,2,null,{}]
10:34:08 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:08 INFO - 1500744848668 Marionette DEBUG Closed connection 374
10:34:08 INFO - 1500744848669 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49812
10:34:08 INFO - 1500744848671 Marionette DEBUG Closed connection 375
10:34:08 INFO - 1500744848672 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49813
10:34:08 INFO - 1500744848674 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:08 INFO - 1500744848677 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:09 INFO - 1500744849043 Marionette DEBUG Register listener.js for window 6442450945
10:34:09 INFO - 1500744849246 Marionette TRACE 376 <- [1,1,null,{"sessionId":"3c1778ad-e3ad-42c8-a428-490b4f966b45","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:09 INFO - 1500744849249 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"}]
10:34:09 INFO - 1500744849260 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"
10:34:09 INFO - 1500744849265 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"
10:34:09 INFO - 1500744849266 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"
10:34:09 INFO - ++DOMWINDOW == 21 (000000B1464CC800) [pid = 1656] [serial = 29] [outer = 000000B13702B000]
10:34:09 INFO - 1500744849290 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"
10:34:09 INFO - 1500744849294 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"
10:34:09 INFO - 1500744849306 Marionette TRACE 376 <- [1,2,null,{}]
10:34:09 INFO - 1500744849321 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:34:09 INFO - 1500744849346 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b8d43a18-af13-46f4-968a-d25a7e9694b4","ELEMENT":"b8d43a18-af13-46f4-968a-d25a7e9694b4"}}]
10:34:09 INFO - 1500744849349 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"b8d43a18-af13-46f4-968a-d25a7e9694b4"}]
10:34:09 INFO - 1500744849819 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:34:09 INFO - 1500744849821 Marionette TRACE 376 <- [1,4,null,{}]
10:34:09 INFO - 1500744849824 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}]
10:34:09 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500744849832 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:34:09 INFO - 1500744849833 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1307ms
10:34:09 INFO - 1500744849838 Marionette TRACE 376 <- [1,6,null,{}]
10:34:09 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - 1500744849842 Marionette DEBUG Closed connection 376
10:34:09 INFO - 1500744849843 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49814
10:34:09 INFO - 1500744849845 Marionette DEBUG Closed connection 377
10:34:09 INFO - 1500744849846 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49815
10:34:09 INFO - 1500744849848 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:09 INFO - 1500744849850 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:09 INFO - 1500744849872 Marionette DEBUG Register listener.js for window 6442450945
10:34:09 INFO - 1500744849882 Marionette TRACE 378 <- [1,1,null,{"sessionId":"7287a991-791d-4f4f-badb-e2d58b30667c","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:09 INFO - 1500744849885 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:34:09 INFO - 1500744849886 Marionette TRACE 378 <- [1,2,null,{}]
10:34:09 INFO - 1500744849888 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:09 INFO - 1500744849890 Marionette TRACE 378 <- [1,3,null,{}]
10:34:09 INFO - 1500744849891 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:09 INFO - 1500744849893 Marionette TRACE 378 <- [1,4,null,{}]
10:34:09 INFO - 1500744849895 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}]
10:34:09 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500744849902 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:34:09 INFO - 1500744849904 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - 1500744849909 Marionette TRACE 378 <- [1,6,null,{}]
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - 1500744849913 Marionette DEBUG Closed connection 378
10:34:09 INFO - 1500744849914 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49816
10:34:09 INFO - 1500744849916 Marionette DEBUG Closed connection 379
10:34:09 INFO - 1500744849917 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49817
10:34:09 INFO - 1500744849919 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:09 INFO - 1500744849921 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:09 INFO - 1500744849943 Marionette DEBUG Register listener.js for window 6442450945
10:34:09 INFO - 1500744849954 Marionette TRACE 380 <- [1,1,null,{"sessionId":"5aa1fea9-873b-4241-a844-01f6499aa21c","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:09 INFO - 1500744849957 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - 1500744849961 Marionette TRACE 380 <- [1,2,null,{}]
10:34:09 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:09 INFO - 1500744849964 Marionette DEBUG Closed connection 380
10:34:09 INFO - 1500744849966 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49818
10:34:09 INFO - 1500744849967 Marionette DEBUG Closed connection 381
10:34:09 INFO - 1500744849968 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49819
10:34:09 INFO - 1500744849970 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:09 INFO - 1500744849973 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:09 INFO - 1500744849994 Marionette DEBUG Register listener.js for window 6442450945
10:34:10 INFO - 1500744850005 Marionette TRACE 382 <- [1,1,null,{"sessionId":"1814aa6d-bb02-47f8-b2fe-55e337806d78","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:10 INFO - 1500744850008 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"}]
10:34:10 INFO - 1500744850022 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"
10:34:10 INFO - 1500744850026 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"
10:34:10 INFO - 1500744850027 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"
10:34:10 INFO - ++DOMWINDOW == 22 (000000B145502800) [pid = 1656] [serial = 30] [outer = 000000B13702B000]
10:34:10 INFO - 1500744850052 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"
10:34:10 INFO - 1500744850056 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"
10:34:10 INFO - 1500744850066 Marionette TRACE 382 <- [1,2,null,{}]
10:34:10 INFO - 1500744850081 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:34:10 INFO - 1500744850088 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"68128c5d-d29a-4e9b-8dbd-7d22e32376d9","ELEMENT":"68128c5d-d29a-4e9b-8dbd-7d22e32376d9"}}]
10:34:10 INFO - 1500744850090 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"68128c5d-d29a-4e9b-8dbd-7d22e32376d9"}]
10:34:10 INFO - 1500744850524 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:34:10 INFO - 1500744850526 Marionette TRACE 382 <- [1,4,null,{}]
10:34:10 INFO - 1500744850529 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}]
10:34:10 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500744850536 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:34:10 INFO - 1500744850538 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:34:10 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 704ms
10:34:10 INFO - TEST-START | test_click.py TestClick.test_input_file
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850542 Marionette TRACE 382 <- [1,6,null,{}]
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850547 Marionette DEBUG Closed connection 382
10:34:10 INFO - 1500744850549 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49820
10:34:10 INFO - 1500744850551 Marionette DEBUG Closed connection 383
10:34:10 INFO - 1500744850553 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49821
10:34:10 INFO - 1500744850556 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:10 INFO - 1500744850558 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:10 INFO - 1500744850666 Marionette DEBUG Register listener.js for window 6442450945
10:34:10 INFO - 1500744850677 Marionette TRACE 384 <- [1,1,null,{"sessionId":"a93f7837-e4eb-49bb-9977-8d5d12028a0c","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:10 INFO - 1500744850679 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:34:10 INFO - 1500744850681 Marionette TRACE 384 <- [1,2,null,{}]
10:34:10 INFO - 1500744850683 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:10 INFO - 1500744850684 Marionette TRACE 384 <- [1,3,null,{}]
10:34:10 INFO - 1500744850687 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:10 INFO - 1500744850689 Marionette TRACE 384 <- [1,4,null,{}]
10:34:10 INFO - 1500744850693 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}]
10:34:10 INFO - TEST-START: test_click.py TestClick.test_input_file1500744850731 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:34:10 INFO - 1500744850733 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850738 Marionette TRACE 384 <- [1,6,null,{}]
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850744 Marionette DEBUG Closed connection 384
10:34:10 INFO - 1500744850746 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49822
10:34:10 INFO - 1500744850749 Marionette DEBUG Closed connection 385
10:34:10 INFO - 1500744850752 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49823
10:34:10 INFO - 1500744850754 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:10 INFO - 1500744850756 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:10 INFO - 1500744850779 Marionette DEBUG Register listener.js for window 6442450945
10:34:10 INFO - 1500744850792 Marionette TRACE 386 <- [1,1,null,{"sessionId":"b5ee7d69-9bfe-40ea-97b2-8e2c7f5f91db","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:10 INFO - 1500744850795 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850799 Marionette TRACE 386 <- [1,2,null,{}]
10:34:10 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:10 INFO - 1500744850804 Marionette DEBUG Closed connection 386
10:34:10 INFO - 1500744850805 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49824
10:34:10 INFO - --DOMWINDOW == 21 (000000B14496D800) [pid = 1656] [serial = 17] [outer = 0000000000000000] [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%20position%3A%20absolute%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%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%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]
10:34:10 INFO - --DOMWINDOW == 20 (000000B145462800) [pid = 1656] [serial = 16] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 19 (000000B144E1B800) [pid = 1656] [serial = 15] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 18 (000000B144E17800) [pid = 1656] [serial = 14] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 17 (000000B144E12800) [pid = 1656] [serial = 13] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 16 (000000B144178000) [pid = 1656] [serial = 12] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 15 (000000B13FCC4800) [pid = 1656] [serial = 11] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - --DOMWINDOW == 14 (000000B142335000) [pid = 1656] [serial = 10] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
10:34:10 INFO - 1500744850807 Marionette DEBUG Closed connection 387
10:34:10 INFO - 1500744850808 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49825
10:34:10 INFO - 1500744850810 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:10 INFO - 1500744850813 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:10 INFO - 1500744850834 Marionette DEBUG Register listener.js for window 6442450945
10:34:10 INFO - 1500744850858 Marionette TRACE 388 <- [1,1,null,{"sessionId":"c0f1ca47-32c9-4128-83c9-6e5430bc169a","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:10 INFO - 1500744850861 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:34:10 INFO - 1500744850866 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"
10:34:10 INFO - 1500744850871 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"
10:34:10 INFO - 1500744850872 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"
10:34:10 INFO - ++DOMWINDOW == 15 (000000B141688000) [pid = 1656] [serial = 31] [outer = 000000B13702B000]
10:34:10 INFO - 1500744850894 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:34:10 INFO - 1500744850904 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:34:10 INFO - 1500744850911 Marionette TRACE 388 <- [1,2,null,{}]
10:34:10 INFO - 1500744850925 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:34:10 INFO - 1500744850933 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"95313dd7-e357-4470-941b-46f969228666","ELEMENT":"95313dd7-e357-4470-941b-46f969228666"}}]
10:34:10 INFO - 1500744850935 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"95313dd7-e357-4470-941b-46f969228666"}]
10:34:11 INFO - 1500744851091 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:34:11 INFO - 1500744851094 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}]
10:34:11 INFO - TEST-END: test_click.py TestClick.test_input_file1500744851101 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:34:11 INFO - 1500744851103 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 565ms
10:34:11 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:34:11 INFO - 1500744851107 Marionette TRACE 388 <- [1,6,null,{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851111 Marionette DEBUG Closed connection 388
10:34:11 INFO - 1500744851113 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49826
10:34:11 INFO - 1500744851114 Marionette DEBUG Closed connection 389
10:34:11 INFO - 1500744851116 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49827
10:34:11 INFO - 1500744851118 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:11 INFO - 1500744851120 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:11 INFO - 1500744851142 Marionette DEBUG Register listener.js for window 6442450945
10:34:11 INFO - 1500744851152 Marionette TRACE 390 <- [1,1,null,{"sessionId":"894ef4bc-f78b-41e5-b25c-f9b778fc706d","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:11 INFO - 1500744851155 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:34:11 INFO - 1500744851157 Marionette TRACE 390 <- [1,2,null,{}]
10:34:11 INFO - 1500744851158 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:11 INFO - 1500744851160 Marionette TRACE 390 <- [1,3,null,{}]
10:34:11 INFO - 1500744851162 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:11 INFO - 1500744851164 Marionette TRACE 390 <- [1,4,null,{}]
10:34:11 INFO - 1500744851166 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}]
10:34:11 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500744851173 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:34:11 INFO - 1500744851175 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851179 Marionette TRACE 390 <- [1,6,null,{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851183 Marionette DEBUG Closed connection 390
10:34:11 INFO - 1500744851185 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49828
10:34:11 INFO - 1500744851186 Marionette DEBUG Closed connection 391
10:34:11 INFO - 1500744851187 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49829
10:34:11 INFO - 1500744851189 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:11 INFO - 1500744851191 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:11 INFO - 1500744851214 Marionette DEBUG Register listener.js for window 6442450945
10:34:11 INFO - 1500744851225 Marionette TRACE 392 <- [1,1,null,{"sessionId":"ce8272d0-8ad4-4c92-b976-28239e36967f","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:11 INFO - 1500744851228 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851232 Marionette TRACE 392 <- [1,2,null,{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851236 Marionette DEBUG Closed connection 392
10:34:11 INFO - 1500744851237 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49830
10:34:11 INFO - 1500744851239 Marionette DEBUG Closed connection 393
10:34:11 INFO - 1500744851240 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49831
10:34:11 INFO - 1500744851242 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:11 INFO - 1500744851245 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:11 INFO - 1500744851268 Marionette DEBUG Register listener.js for window 6442450945
10:34:11 INFO - 1500744851279 Marionette TRACE 394 <- [1,1,null,{"sessionId":"2640b4ef-d2d6-4493-a631-82de6b450559","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:11 INFO - 1500744851284 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"}]
10:34:11 INFO - 1500744851288 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:34:11 INFO - 1500744851293 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:34:11 INFO - 1500744851294 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:34:11 INFO - ++DOMWINDOW == 16 (000000B142331800) [pid = 1656] [serial = 32] [outer = 000000B13702B000]
10:34:11 INFO - 1500744851320 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"
10:34:11 INFO - 1500744851324 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"
10:34:11 INFO - 1500744851331 Marionette TRACE 394 <- [1,2,null,{}]
10:34:11 INFO - 1500744851345 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:34:11 INFO - 1500744851353 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bc875155-2904-4aeb-bb2e-2c84ab374703","ELEMENT":"bc875155-2904-4aeb-bb2e-2c84ab374703"}}]
10:34:11 INFO - 1500744851355 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:34:11 INFO - 1500744851360 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f65e9c42-628a-4e9c-b42d-ca0cefdaa477","ELEMENT":"f65e9c42-628a-4e9c-b42d-ca0cefdaa477"}}]
10:34:11 INFO - 1500744851362 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"bc875155-2904-4aeb-bb2e-2c84ab374703"}]
10:34:11 INFO - 1500744851783 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:34:11 INFO - 1500744851785 Marionette TRACE 394 <- [1,5,null,{}]
10:34:11 INFO - 1500744851787 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"f65e9c42-628a-4e9c-b42d-ca0cefdaa477"}]
10:34:11 INFO - 1500744851911 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:34:11 INFO - 1500744851914 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:34:11 INFO - 1500744851926 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:34:11 INFO - 1500744851928 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}]
10:34:11 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500744851935 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:34:11 INFO - 1500744851937 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 833ms
10:34:11 INFO - 1500744851941 Marionette TRACE 394 <- [1,9,null,{}]
10:34:11 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:34:11 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:11 INFO - 1500744851945 Marionette DEBUG Closed connection 394
10:34:11 INFO - 1500744851946 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49832
10:34:11 INFO - 1500744851948 Marionette DEBUG Closed connection 395
10:34:11 INFO - 1500744851949 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49833
10:34:11 INFO - 1500744851951 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:11 INFO - 1500744851953 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:11 INFO - 1500744851975 Marionette DEBUG Register listener.js for window 6442450945
10:34:11 INFO - 1500744851986 Marionette TRACE 396 <- [1,1,null,{"sessionId":"1625fa50-9aba-495c-95fa-53fe8f7b0449","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:11 INFO - 1500744851989 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:34:11 INFO - 1500744851990 Marionette TRACE 396 <- [1,2,null,{}]
10:34:11 INFO - 1500744851992 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:34:11 INFO - 1500744851994 Marionette TRACE 396 <- [1,3,null,{}]
10:34:12 INFO - 1500744851996 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:34:12 INFO - 1500744851997 Marionette TRACE 396 <- [1,4,null,{}]
10:34:12 INFO - 1500744852000 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}]
10:34:12 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500744852007 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:34:12 INFO - 1500744852009 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:34:12 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:12 INFO - 1500744852014 Marionette TRACE 396 <- [1,6,null,{}]
10:34:12 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:12 INFO - 1500744852018 Marionette DEBUG Closed connection 396
10:34:12 INFO - 1500744852019 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49834
10:34:12 INFO - 1500744852021 Marionette DEBUG Closed connection 397
10:34:12 INFO - 1500744852022 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49835
10:34:12 INFO - 1500744852024 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:34:12 INFO - 1500744852026 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:12 INFO - 1500744852048 Marionette DEBUG Register listener.js for window 6442450945
10:34:12 INFO - 1500744852059 Marionette TRACE 398 <- [1,1,null,{"sessionId":"e7c6b2e2-1ed4-453c-9b7c-1c8e28ec9c58","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:12 INFO - 1500744852061 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:34:12 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:12 INFO - 1500744852065 Marionette TRACE 398 <- [1,2,null,{}]
10:34:12 INFO - [Parent 2176] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:34:12 INFO - 1500744852069 Marionette DEBUG Closed connection 398
10:34:12 INFO - 1500744852071 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49836
10:34:12 INFO - 1500744852072 Marionette DEBUG Closed connection 399
10:34:12 INFO - 1500744852074 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49837
10:34:12 INFO - 1500744852076 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:34:12 INFO - 1500744852078 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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}
10:34:12 INFO - 1500744852101 Marionette DEBUG Register listener.js for window 6442450945
10:34:12 INFO - 1500744852111 Marionette TRACE 400 <- [1,1,null,{"sessionId":"15036583-f7a5-45f4-8efa-9a7416ef09ce","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":2176,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-062.001\\AppData\\Local\\Temp\\tmpde0jx9.mozrunner","moz:accessibilityChecks":false}}]
10:34:12 INFO - 1500744852114 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"}]
10:34:12 INFO - 1500744852118 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"
10:34:12 INFO - 1500744852123 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"
10:34:12 INFO - 1500744852123 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"
10:34:12 INFO - ++DOMWINDOW == 17 (000000B145508800) [pid = 1656] [serial = 33] [outer = 000000B13702B000]
10:34:12 INFO - 1500744852150 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"
10:34:12 INFO - 1500744852153 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"
10:34:12 INFO - 1500744852167 Marionette TRACE 400 <- [1,2,null,{}]
10:34:12 INFO - 1500744852182 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:34:12 INFO - 1500744852188 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2ee6a99b-29ff-4052-bd06-15b5a3666074","ELEMENT":"2ee6a99b-29ff-4052-bd06-15b5a3666074"}}]
10:34:12 INFO - 1500744852190 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"2ee6a99b-29ff-4052-bd06-15b5a3666074"}]
10:34:12 INFO - 1500744852323 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:34:12 INFO - 1500744852325 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"2ee6a99b-29ff-4052-bd06-15b5a3666074"}]
10:34:12 INFO - 1500744852453 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element