could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:40:33 INFO - 1499478033284 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}]
18:40:33 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499478033291 Marionette TRACE 352 <- [1,5,null,{"value":null}]
18:40:33 INFO - 1499478033293 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033297 Marionette TRACE 352 <- [1,6,null,{}]
18:40:33 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1129ms
18:40:33 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033396 Marionette DEBUG Closed connection 352
18:40:33 INFO - 1499478033398 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49785
18:40:33 INFO - 1499478033419 Marionette DEBUG Closed connection 353
18:40:33 INFO - 1499478033421 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49786
18:40:33 INFO - 1499478033425 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:33 INFO - 1499478033427 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:33 INFO - 1499478033449 Marionette DEBUG Register listener.js for window 12
18:40:33 INFO - 1499478033460 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d3c76d09-0063-4db1-858a-3d30b5a9bbbf","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:33 INFO - 1499478033471 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
18:40:33 INFO - 1499478033473 Marionette TRACE 354 <- [1,2,null,{}]
18:40:33 INFO - 1499478033475 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:33 INFO - 1499478033477 Marionette TRACE 354 <- [1,3,null,{}]
18:40:33 INFO - 1499478033479 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:33 INFO - 1499478033480 Marionette TRACE 354 <- [1,4,null,{}]
18:40:33 INFO - 1499478033482 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}]
18:40:33 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499478033490 Marionette TRACE 354 <- [1,5,null,{"value":null}]
18:40:33 INFO - 1499478033492 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033496 Marionette TRACE 354 <- [1,6,null,{}]
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033522 Marionette DEBUG Closed connection 354
18:40:33 INFO - 1499478033523 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49787
18:40:33 INFO - 1499478033527 Marionette DEBUG Closed connection 355
18:40:33 INFO - 1499478033529 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49788
18:40:33 INFO - 1499478033531 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:33 INFO - 1499478033533 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:33 INFO - 1499478033554 Marionette DEBUG Register listener.js for window 12
18:40:33 INFO - 1499478033565 Marionette TRACE 356 <- [1,1,null,{"sessionId":"b1e00b71-1271-474a-8254-7f86c277b960","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:33 INFO - 1499478033576 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033580 Marionette TRACE 356 <- [1,2,null,{}]
18:40:33 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:33 INFO - 1499478033603 Marionette DEBUG Closed connection 356
18:40:33 INFO - 1499478033604 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49789
18:40:33 INFO - 1499478033608 Marionette DEBUG Closed connection 357
18:40:33 INFO - 1499478033609 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49790
18:40:33 INFO - 1499478033611 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:33 INFO - 1499478033614 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:33 INFO - 1499478033636 Marionette DEBUG Register listener.js for window 12
18:40:33 INFO - 1499478033646 Marionette TRACE 358 <- [1,1,null,{"sessionId":"8406bfed-4ef9-43d0-a3ca-1f6c93eae801","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:33 INFO - 1499478033655 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49340/clicks.html"}]
18:40:33 INFO - 1499478033660 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/hidden.html"
18:40:33 INFO - 1499478033678 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/hidden.html"
18:40:33 INFO - 1499478033679 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/hidden.html"
18:40:33 INFO - ++DOMWINDOW == 29 (000000B5E9B3C800) [pid = 2128] [serial = 44] [outer = 000000B5E3185800]
18:40:33 INFO - 1499478033737 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49340/clicks.html"
18:40:33 INFO - 1499478033742 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49340/clicks.html"
18:40:33 INFO - 1499478033762 Marionette TRACE 358 <- [1,2,null,{}]
18:40:33 INFO - 1499478033765 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
18:40:33 INFO - 1499478033775 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cf6f1350-ee64-4df4-bcda-b820e1f3dc70","ELEMENT":"cf6f1350-ee64-4df4-bcda-b820e1f3dc70"}}]
18:40:33 INFO - 1499478033777 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"cf6f1350-ee64-4df4-bcda-b820e1f3dc70"}]
18:40:34 INFO - 1499478034037 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/clicks.html"
18:40:34 INFO - [2128] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
18:40:34 INFO - 1499478034054 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/clicks.html"
18:40:34 INFO - 1499478034056 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/clicks.html"
18:40:34 INFO - ++DOMWINDOW == 30 (000000B5EC1C6000) [pid = 2128] [serial = 45] [outer = 000000B5E3185800]
18:40:34 INFO - 1499478034122 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49340/test.html"
18:40:34 INFO - 1499478034126 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49340/test.html"
18:40:34 INFO - 1499478034141 Marionette TRACE 358 <- [1,4,null,{}]
18:40:34 INFO - 1499478034150 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
18:40:34 INFO - 1499478034160 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8ee48b4c-b97f-46c8-9d09-f44e008b356f","ELEMENT":"8ee48b4c-b97f-46c8-9d09-f44e008b356f"}}]
18:40:34 INFO - 1499478034162 Marionette TRACE 358 -> [0,6,"getTitle",{}]
18:40:34 INFO - 1499478034164 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
18:40:34 INFO - 1499478034166 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}]
18:40:34 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499478034173 Marionette TRACE 358 <- [1,7,null,{"value":null}]
18:40:34 INFO - 1499478034175 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034179 Marionette TRACE 358 <- [1,8,null,{}]
18:40:34 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 790ms
18:40:34 INFO - TEST-START | test_click.py TestClick.test_container_element
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034185 Marionette DEBUG Closed connection 358
18:40:34 INFO - 1499478034187 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49793
18:40:34 INFO - 1499478034189 Marionette DEBUG Closed connection 359
18:40:34 INFO - 1499478034190 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49794
18:40:34 INFO - 1499478034192 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:34 INFO - 1499478034197 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:34 INFO - 1499478034219 Marionette DEBUG Register listener.js for window 12
18:40:34 INFO - 1499478034230 Marionette TRACE 360 <- [1,1,null,{"sessionId":"6bfe2d54-548d-4951-bc6e-685a27a7fae2","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:34 INFO - 1499478034263 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
18:40:34 INFO - 1499478034264 Marionette TRACE 360 <- [1,2,null,{}]
18:40:34 INFO - 1499478034268 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:34 INFO - 1499478034269 Marionette TRACE 360 <- [1,3,null,{}]
18:40:34 INFO - 1499478034271 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:34 INFO - 1499478034273 Marionette TRACE 360 <- [1,4,null,{}]
18:40:34 INFO - 1499478034275 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}]
18:40:34 INFO - TEST-START: test_click.py TestClick.test_container_element1499478034282 Marionette TRACE 360 <- [1,5,null,{"value":null}]
18:40:34 INFO - 1499478034284 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034289 Marionette TRACE 360 <- [1,6,null,{}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034294 Marionette DEBUG Closed connection 360
18:40:34 INFO - 1499478034296 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49795
18:40:34 INFO - 1499478034298 Marionette DEBUG Closed connection 361
18:40:34 INFO - 1499478034299 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49796
18:40:34 INFO - 1499478034301 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:34 INFO - 1499478034303 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:34 INFO - 1499478034326 Marionette DEBUG Register listener.js for window 12
18:40:34 INFO - 1499478034336 Marionette TRACE 362 <- [1,1,null,{"sessionId":"8dcde181-c863-4b6e-8562-f1e1ad1a1e26","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:34 INFO - 1499478034368 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034372 Marionette TRACE 362 <- [1,2,null,{}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:34 INFO - 1499478034395 Marionette DEBUG Closed connection 362
18:40:34 INFO - 1499478034396 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49797
18:40:34 INFO - 1499478034401 Marionette DEBUG Closed connection 363
18:40:34 INFO - 1499478034403 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49798
18:40:34 INFO - 1499478034406 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:34 INFO - 1499478034408 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:34 INFO - 1499478034430 Marionette DEBUG Register listener.js for window 12
18:40:34 INFO - 1499478034453 Marionette TRACE 364 <- [1,1,null,{"sessionId":"493e392e-1907-4f8f-9d43-91b3bb4b80be","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:34 INFO - 1499478034464 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"}]
18:40:34 INFO - 1499478034468 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49340/test.html"
18:40:34 INFO - 1499478034474 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49340/test.html"
18:40:34 INFO - 1499478034475 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49340/test.html"
18:40:34 INFO - ++DOMWINDOW == 31 (000000B5E270C000) [pid = 2128] [serial = 46] [outer = 000000B5E3185800]
18:40:34 INFO - 1499478034528 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"
18:40:34 INFO - 1499478034533 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"
18:40:34 INFO - 1499478034548 Marionette TRACE 364 <- [1,2,null,{}]
18:40:34 INFO - 1499478034557 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
18:40:34 INFO - 1499478034569 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"75e85356-d198-410e-8b88-300d79dda86c","ELEMENT":"75e85356-d198-410e-8b88-300d79dda86c"}}]
18:40:34 INFO - 1499478034571 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"75e85356-d198-410e-8b88-300d79dda86c"}]
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
18:40:34 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
18:40:35 INFO - 1499478035045 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:40:35 INFO - 1499478035046 Marionette TRACE 364 <- [1,4,null,{}]
18:40:35 INFO - 1499478035049 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"75e85356-d198-410e-8b88-300d79dda86c","name":"selected"}]
18:40:35 INFO - 1499478035076 Marionette TRACE 364 <- [1,5,null,{"value":true}]
18:40:35 INFO - 1499478035079 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}]
18:40:35 INFO - TEST-END: test_click.py TestClick.test_container_element1499478035108 Marionette TRACE 364 <- [1,6,null,{"value":null}]
18:40:35 INFO - 1499478035112 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035117 Marionette TRACE 364 <- [1,7,null,{}]
18:40:35 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 937ms
18:40:35 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035153 Marionette DEBUG Closed connection 364
18:40:35 INFO - 1499478035155 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49799
18:40:35 INFO - 1499478035156 Marionette DEBUG Closed connection 365
18:40:35 INFO - 1499478035158 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49800
18:40:35 INFO - 1499478035160 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:35 INFO - 1499478035162 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:35 INFO - 1499478035185 Marionette DEBUG Register listener.js for window 12
18:40:35 INFO - 1499478035197 Marionette TRACE 366 <- [1,1,null,{"sessionId":"f54b5182-c86a-47ab-9125-96288ac30708","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:35 INFO - 1499478035209 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
18:40:35 INFO - 1499478035211 Marionette TRACE 366 <- [1,2,null,{}]
18:40:35 INFO - 1499478035212 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:35 INFO - 1499478035214 Marionette TRACE 366 <- [1,3,null,{}]
18:40:35 INFO - 1499478035215 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:35 INFO - 1499478035217 Marionette TRACE 366 <- [1,4,null,{}]
18:40:35 INFO - 1499478035219 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}]
18:40:35 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499478035227 Marionette TRACE 366 <- [1,5,null,{"value":null}]
18:40:35 INFO - 1499478035228 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035233 Marionette TRACE 366 <- [1,6,null,{}]
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035239 Marionette DEBUG Closed connection 366
18:40:35 INFO - 1499478035240 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49801
18:40:35 INFO - 1499478035242 Marionette DEBUG Closed connection 367
18:40:35 INFO - 1499478035243 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49802
18:40:35 INFO - 1499478035245 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:35 INFO - 1499478035247 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:35 INFO - 1499478035270 Marionette DEBUG Register listener.js for window 12
18:40:35 INFO - 1499478035281 Marionette TRACE 368 <- [1,1,null,{"sessionId":"e019be00-64ce-45c4-abf6-a1fe19ea9c93","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:35 INFO - 1499478035287 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035291 Marionette TRACE 368 <- [1,2,null,{}]
18:40:35 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:35 INFO - 1499478035297 Marionette DEBUG Closed connection 368
18:40:35 INFO - 1499478035298 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49803
18:40:35 INFO - 1499478035299 Marionette DEBUG Closed connection 369
18:40:35 INFO - 1499478035301 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49804
18:40:35 INFO - 1499478035303 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:35 INFO - 1499478035305 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:35 INFO - 1499478035328 Marionette DEBUG Register listener.js for window 12
18:40:35 INFO - 1499478035339 Marionette TRACE 370 <- [1,1,null,{"sessionId":"93b21d79-9188-430c-a085-17f6a63d0588","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:35 INFO - 1499478035345 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"}]
18:40:35 INFO - 1499478035349 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"
18:40:35 INFO - 1499478035356 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"
18:40:35 INFO - 1499478035357 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"
18:40:35 INFO - ++DOMWINDOW == 32 (000000B5EC1C1800) [pid = 2128] [serial = 47] [outer = 000000B5E3185800]
18:40:35 INFO - 1499478035402 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"
18:40:36 INFO - 1499478036353 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"
18:40:36 INFO - 1499478036381 Marionette TRACE 370 <- [1,2,null,{}]
18:40:36 INFO - 1499478036387 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
18:40:36 INFO - 1499478036394 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bfe3f618-ecf5-47ca-a31b-26d2667dab74","ELEMENT":"bfe3f618-ecf5-47ca-a31b-26d2667dab74"}}]
18:40:36 INFO - 1499478036396 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"bfe3f618-ecf5-47ca-a31b-26d2667dab74"}]
18:40:36 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
18:40:36 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
18:40:36 INFO - [2128] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
18:40:36 INFO - 1499478036903 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:40:36 INFO - 1499478036905 Marionette TRACE 370 <- [1,4,null,{}]
18:40:36 INFO - 1499478036921 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"bfe3f618-ecf5-47ca-a31b-26d2667dab74","name":"selected"}]
18:40:36 INFO - 1499478036949 Marionette TRACE 370 <- [1,5,null,{"value":true}]
18:40:36 INFO - 1499478036951 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}]
18:40:36 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499478036958 Marionette TRACE 370 <- [1,6,null,{"value":null}]
18:40:36 INFO - 1499478036960 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
18:40:36 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:36 INFO - 1499478036964 Marionette TRACE 370 <- [1,7,null,{}]
18:40:36 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1846ms
18:40:36 INFO - TEST-START | test_click.py TestClick.test_css_transforms
18:40:36 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:36 INFO - 1499478036973 Marionette DEBUG Closed connection 370
18:40:36 INFO - 1499478036974 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49805
18:40:36 INFO - 1499478036976 Marionette DEBUG Closed connection 371
18:40:36 INFO - 1499478036977 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49806
18:40:36 INFO - 1499478036980 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:36 INFO - 1499478036982 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:37 INFO - 1499478037005 Marionette DEBUG Register listener.js for window 12
18:40:37 INFO - 1499478037061 Marionette TRACE 372 <- [1,1,null,{"sessionId":"96a7de73-475c-4d5e-87db-f2beb19303b8","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:37 INFO - 1499478037072 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
18:40:37 INFO - 1499478037073 Marionette TRACE 372 <- [1,2,null,{}]
18:40:37 INFO - 1499478037075 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:37 INFO - 1499478037077 Marionette TRACE 372 <- [1,3,null,{}]
18:40:37 INFO - 1499478037080 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:37 INFO - 1499478037082 Marionette TRACE 372 <- [1,4,null,{}]
18:40:37 INFO - 1499478037085 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}]
18:40:37 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499478037093 Marionette TRACE 372 <- [1,5,null,{"value":null}]
18:40:37 INFO - 1499478037097 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037102 Marionette TRACE 372 <- [1,6,null,{}]
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037108 Marionette DEBUG Closed connection 372
18:40:37 INFO - 1499478037110 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49807
18:40:37 INFO - 1499478037111 Marionette DEBUG Closed connection 373
18:40:37 INFO - 1499478037113 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49808
18:40:37 INFO - 1499478037115 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:37 INFO - 1499478037117 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:37 INFO - 1499478037140 Marionette DEBUG Register listener.js for window 12
18:40:37 INFO - 1499478037151 Marionette TRACE 374 <- [1,1,null,{"sessionId":"1b87e102-8528-4d77-ac39-00047465f48a","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:37 INFO - 1499478037180 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037184 Marionette TRACE 374 <- [1,2,null,{}]
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037207 Marionette DEBUG Closed connection 374
18:40:37 INFO - 1499478037209 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49809
18:40:37 INFO - 1499478037212 Marionette DEBUG Closed connection 375
18:40:37 INFO - 1499478037214 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49810
18:40:37 INFO - 1499478037216 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:37 INFO - 1499478037218 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:37 INFO - 1499478037241 Marionette DEBUG Register listener.js for window 12
18:40:37 INFO - 1499478037251 Marionette TRACE 376 <- [1,1,null,{"sessionId":"a9364d71-6600-48da-beda-7547b40a53db","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:37 INFO - 1499478037262 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"}]
18:40:37 INFO - 1499478037265 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"
18:40:37 INFO - 1499478037276 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"
18:40:37 INFO - 1499478037277 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"
18:40:37 INFO - ++DOMWINDOW == 33 (000000B5EAF44800) [pid = 2128] [serial = 48] [outer = 000000B5E3185800]
18:40:37 INFO - 1499478037368 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"
18:40:37 INFO - 1499478037381 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"
18:40:37 INFO - 1499478037398 Marionette TRACE 376 <- [1,2,null,{}]
18:40:37 INFO - 1499478037401 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
18:40:37 INFO - 1499478037408 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2cb3e967-6445-4251-bc31-db80f6907164","ELEMENT":"2cb3e967-6445-4251-bc31-db80f6907164"}}]
18:40:37 INFO - 1499478037416 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"2cb3e967-6445-4251-bc31-db80f6907164"}]
18:40:37 INFO - 1499478037865 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:40:37 INFO - 1499478037869 Marionette TRACE 376 <- [1,4,null,{}]
18:40:37 INFO - 1499478037922 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}]
18:40:37 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499478037937 Marionette TRACE 376 <- [1,5,null,{"value":null}]
18:40:37 INFO - 1499478037945 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037954 Marionette TRACE 376 <- [1,6,null,{}]
18:40:37 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 992ms
18:40:37 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
18:40:37 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:37 INFO - 1499478037967 Marionette DEBUG Closed connection 376
18:40:37 INFO - 1499478037969 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49811
18:40:37 INFO - 1499478037972 Marionette DEBUG Closed connection 377
18:40:37 INFO - 1499478037975 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49812
18:40:37 INFO - 1499478037981 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:37 INFO - 1499478037992 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:38 INFO - 1499478038039 Marionette DEBUG Register listener.js for window 12
18:40:38 INFO - 1499478038073 Marionette TRACE 378 <- [1,1,null,{"sessionId":"668f26ff-9b65-4e25-a831-dd832676ae38","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:38 INFO - 1499478038112 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
18:40:38 INFO - 1499478038115 Marionette TRACE 378 <- [1,2,null,{}]
18:40:38 INFO - 1499478038118 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:38 INFO - 1499478038123 Marionette TRACE 378 <- [1,3,null,{}]
18:40:38 INFO - 1499478038125 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:38 INFO - 1499478038128 Marionette TRACE 378 <- [1,4,null,{}]
18:40:38 INFO - 1499478038132 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}]
18:40:38 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499478038145 Marionette TRACE 378 <- [1,5,null,{"value":null}]
18:40:38 INFO - 1499478038151 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
18:40:38 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:38 INFO - 1499478038157 Marionette TRACE 378 <- [1,6,null,{}]
18:40:38 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:38 INFO - 1499478038168 Marionette DEBUG Closed connection 378
18:40:38 INFO - 1499478038172 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49813
18:40:38 INFO - 1499478038174 Marionette DEBUG Closed connection 379
18:40:38 INFO - 1499478038177 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49814
18:40:38 INFO - 1499478038180 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:38 INFO - 1499478038183 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:38 INFO - 1499478038231 Marionette DEBUG Register listener.js for window 12
18:40:38 INFO - 1499478038258 Marionette TRACE 380 <- [1,1,null,{"sessionId":"e89f03f6-5029-4962-8b07-94c13fd12550","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:38 INFO - 1499478038291 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
18:40:38 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:38 INFO - 1499478038299 Marionette TRACE 380 <- [1,2,null,{}]
18:40:38 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:38 INFO - 1499478038324 Marionette DEBUG Closed connection 380
18:40:38 INFO - 1499478038326 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49815
18:40:38 INFO - 1499478038378 Marionette DEBUG Closed connection 381
18:40:38 INFO - 1499478038380 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49816
18:40:38 INFO - 1499478038392 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:38 INFO - 1499478038399 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:38 INFO - 1499478038445 Marionette DEBUG Register listener.js for window 12
18:40:38 INFO - 1499478038461 Marionette TRACE 382 <- [1,1,null,{"sessionId":"5f72698c-c141-478a-a8f5-f05b6b69c7ec","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:38 INFO - 1499478038473 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"}]
18:40:38 INFO - 1499478038479 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"
18:40:38 INFO - 1499478038488 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"
18:40:38 INFO - 1499478038489 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"
18:40:38 INFO - ++DOMWINDOW == 34 (000000B5E2724800) [pid = 2128] [serial = 49] [outer = 000000B5E3185800]
18:40:38 INFO - 1499478038550 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"
18:40:38 INFO - 1499478038559 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"
18:40:38 INFO - 1499478038586 Marionette TRACE 382 <- [1,2,null,{}]
18:40:38 INFO - 1499478038590 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
18:40:38 INFO - 1499478038601 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"92d607c3-b33b-4356-8574-ee45f04456e6","ELEMENT":"92d607c3-b33b-4356-8574-ee45f04456e6"}}]
18:40:38 INFO - 1499478038604 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"92d607c3-b33b-4356-8574-ee45f04456e6"}]
18:40:39 INFO - 1499478039430 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:40:39 INFO - 1499478039435 Marionette TRACE 382 <- [1,4,null,{}]
18:40:39 INFO - 1499478039443 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}]
18:40:39 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499478039457 Marionette TRACE 382 <- [1,5,null,{"value":null}]
18:40:39 INFO - 1499478039462 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039473 Marionette TRACE 382 <- [1,6,null,{}]
18:40:39 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1517ms
18:40:39 INFO - TEST-START | test_click.py TestClick.test_input_file
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039483 Marionette DEBUG Closed connection 382
18:40:39 INFO - 1499478039486 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49817
18:40:39 INFO - 1499478039513 Marionette DEBUG Closed connection 383
18:40:39 INFO - 1499478039515 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49818
18:40:39 INFO - 1499478039552 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:39 INFO - 1499478039563 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:39 INFO - 1499478039590 Marionette DEBUG Register listener.js for window 12
18:40:39 INFO - 1499478039610 Marionette TRACE 384 <- [1,1,null,{"sessionId":"c8f6cdfe-873a-457d-a057-676a5fa8435e","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:39 INFO - 1499478039652 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
18:40:39 INFO - 1499478039655 Marionette TRACE 384 <- [1,2,null,{}]
18:40:39 INFO - 1499478039716 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:39 INFO - 1499478039721 Marionette TRACE 384 <- [1,3,null,{}]
18:40:39 INFO - 1499478039726 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:39 INFO - 1499478039729 Marionette TRACE 384 <- [1,4,null,{}]
18:40:39 INFO - 1499478039732 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}]
18:40:39 INFO - TEST-START: test_click.py TestClick.test_input_file1499478039747 Marionette TRACE 384 <- [1,5,null,{"value":null}]
18:40:39 INFO - 1499478039753 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039759 Marionette TRACE 384 <- [1,6,null,{}]
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039770 Marionette DEBUG Closed connection 384
18:40:39 INFO - 1499478039773 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49819
18:40:39 INFO - 1499478039797 Marionette DEBUG Closed connection 385
18:40:39 INFO - 1499478039799 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49820
18:40:39 INFO - 1499478039804 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:39 INFO - 1499478039808 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:39 INFO - 1499478039833 Marionette DEBUG Register listener.js for window 12
18:40:39 INFO - 1499478039847 Marionette TRACE 386 <- [1,1,null,{"sessionId":"bbdf96e2-5e3f-40ea-b639-f3e055d5a5cf","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:39 INFO - 1499478039859 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039866 Marionette TRACE 386 <- [1,2,null,{}]
18:40:39 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:39 INFO - 1499478039875 Marionette DEBUG Closed connection 386
18:40:39 INFO - 1499478039878 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49821
18:40:39 INFO - --DOMWINDOW == 33 (000000B5E9B38800) [pid = 2128] [serial = 33] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 32 (000000B5EB219000) [pid = 2128] [serial = 34] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 31 (000000B5E5971000) [pid = 2128] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 30 (000000B5DC611000) [pid = 2128] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 29 (000000B5D6EC9000) [pid = 2128] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 28 (000000B5DF20E800) [pid = 2128] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 27 (000000B5E6DD6800) [pid = 2128] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - --DOMWINDOW == 26 (000000B5E935B800) [pid = 2128] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49340/test_accessibility.html]
18:40:39 INFO - 1499478039908 Marionette DEBUG Closed connection 387
18:40:39 INFO - 1499478039910 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49822
18:40:39 INFO - 1499478039919 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:39 INFO - 1499478039924 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:39 INFO - 1499478039948 Marionette DEBUG Register listener.js for window 12
18:40:39 INFO - 1499478039962 Marionette TRACE 388 <- [1,1,null,{"sessionId":"4b41be7d-d1d2-4290-9bd2-3ec04287a435","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:39 INFO - 1499478039977 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
18:40:39 INFO - 1499478039982 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"
18:40:39 INFO - 1499478039991 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"
18:40:39 INFO - 1499478039992 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"
18:40:39 INFO - ++DOMWINDOW == 27 (000000B5D6EC8000) [pid = 2128] [serial = 50] [outer = 000000B5E3185800]
18:40:40 INFO - 1499478040049 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:40:40 INFO - 1499478040056 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:40:40 INFO - 1499478040071 Marionette TRACE 388 <- [1,2,null,{}]
18:40:40 INFO - 1499478040083 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
18:40:40 INFO - 1499478040093 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e9eb07d8-9cdf-4e4b-8843-63ff49b32ce8","ELEMENT":"e9eb07d8-9cdf-4e4b-8843-63ff49b32ce8"}}]
18:40:40 INFO - 1499478040095 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"e9eb07d8-9cdf-4e4b-8843-63ff49b32ce8"}]
18:40:40 INFO - 1499478040267 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:40:40 INFO - 1499478040384 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}]
18:40:40 INFO - TEST-END: test_click.py TestClick.test_input_file1499478040392 Marionette TRACE 388 <- [1,5,null,{"value":null}]
18:40:40 INFO - 1499478040394 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
18:40:40 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:40 INFO - 1499478040399 Marionette TRACE 388 <- [1,6,null,{}]
18:40:40 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 924ms
18:40:40 INFO - TEST-START | test_click.py TestClick.test_obscured_element
18:40:40 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:40 INFO - 1499478040436 Marionette DEBUG Closed connection 388
18:40:40 INFO - 1499478040438 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49823
18:40:40 INFO - 1499478040441 Marionette DEBUG Closed connection 389
18:40:40 INFO - 1499478040444 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49824
18:40:40 INFO - 1499478040447 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:40 INFO - 1499478040450 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:40 INFO - 1499478040473 Marionette DEBUG Register listener.js for window 12
18:40:40 INFO - 1499478040486 Marionette TRACE 390 <- [1,1,null,{"sessionId":"48e7092c-f3aa-4ea8-b931-a8ba0633022b","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:40 INFO - 1499478040500 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
18:40:40 INFO - 1499478040502 Marionette TRACE 390 <- [1,2,null,{}]
18:40:40 INFO - 1499478040505 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:40 INFO - 1499478040506 Marionette TRACE 390 <- [1,3,null,{}]
18:40:40 INFO - 1499478040511 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:40 INFO - 1499478040512 Marionette TRACE 390 <- [1,4,null,{}]
18:40:41 INFO - 1499478041346 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}]
18:40:41 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499478041361 Marionette TRACE 390 <- [1,5,null,{"value":null}]
18:40:41 INFO - 1499478041409 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
18:40:41 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:41 INFO - 1499478041414 Marionette TRACE 390 <- [1,6,null,{}]
18:40:41 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:41 INFO - 1499478041470 Marionette DEBUG Closed connection 390
18:40:41 INFO - 1499478041472 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49825
18:40:41 INFO - 1499478041527 Marionette DEBUG Closed connection 391
18:40:41 INFO - 1499478041529 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49826
18:40:41 INFO - 1499478041582 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:41 INFO - 1499478041587 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:41 INFO - 1499478041610 Marionette DEBUG Register listener.js for window 12
18:40:41 INFO - 1499478041625 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b05fb1f9-af29-44b1-ad62-627a1d8397ff","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:41 INFO - 1499478041682 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
18:40:41 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:41 INFO - 1499478041688 Marionette TRACE 392 <- [1,2,null,{}]
18:40:41 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:41 INFO - 1499478041748 Marionette DEBUG Closed connection 392
18:40:41 INFO - 1499478041753 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49827
18:40:41 INFO - 1499478041799 Marionette DEBUG Closed connection 393
18:40:41 INFO - 1499478041800 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49828
18:40:41 INFO - 1499478041825 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:41 INFO - 1499478041827 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:41 INFO - 1499478041850 Marionette DEBUG Register listener.js for window 12
18:40:41 INFO - 1499478041863 Marionette TRACE 394 <- [1,1,null,{"sessionId":"7daf2876-4ecc-491c-9cf2-c995bf60a375","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:41 INFO - 1499478041875 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"}]
18:40:41 INFO - 1499478041879 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:40:41 INFO - 1499478041886 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:40:41 INFO - 1499478041887 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
18:40:41 INFO - ++DOMWINDOW == 28 (000000B5D6AC9800) [pid = 2128] [serial = 51] [outer = 000000B5E3185800]
18:40:41 INFO - 1499478041947 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"
18:40:41 INFO - 1499478041954 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"
18:40:41 INFO - 1499478041971 Marionette TRACE 394 <- [1,2,null,{}]
18:40:41 INFO - 1499478041979 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
18:40:41 INFO - 1499478041987 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1b504d6f-eb30-4e9c-82b8-bc0e4a468b0f","ELEMENT":"1b504d6f-eb30-4e9c-82b8-bc0e4a468b0f"}}]
18:40:41 INFO - 1499478041989 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
18:40:42 INFO - 1499478041998 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"329cdca1-5c31-4621-a47b-93b6005259b2","ELEMENT":"329cdca1-5c31-4621-a47b-93b6005259b2"}}]
18:40:42 INFO - 1499478042000 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"1b504d6f-eb30-4e9c-82b8-bc0e4a468b0f"}]
18:40:42 INFO - 1499478042447 Marionette DEBUG Canceled page load listener because no navigation has been detected
18:40:42 INFO - 1499478042450 Marionette TRACE 394 <- [1,5,null,{}]
18:40:42 INFO - 1499478042452 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"329cdca1-5c31-4621-a47b-93b6005259b2"}]
18:40:42 INFO - 1499478042614 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
18:40:42 INFO - 1499478042620 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
18:40:42 INFO - 1499478042629 Marionette TRACE 394 <- [1,7,null,{"value":false}]
18:40:42 INFO - 1499478042631 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}]
18:40:42 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499478042640 Marionette TRACE 394 <- [1,8,null,{"value":null}]
18:40:42 INFO - 1499478042642 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042647 Marionette TRACE 394 <- [1,9,null,{}]
18:40:42 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 2247ms
18:40:42 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042653 Marionette DEBUG Closed connection 394
18:40:42 INFO - 1499478042655 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49829
18:40:42 INFO - 1499478042656 Marionette DEBUG Closed connection 395
18:40:42 INFO - 1499478042658 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49830
18:40:42 INFO - 1499478042660 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:42 INFO - 1499478042662 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:42 INFO - 1499478042687 Marionette DEBUG Register listener.js for window 12
18:40:42 INFO - 1499478042698 Marionette TRACE 396 <- [1,1,null,{"sessionId":"87d19001-6b33-4e2a-981d-092b0f9ebbe0","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:42 INFO - 1499478042705 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
18:40:42 INFO - 1499478042706 Marionette TRACE 396 <- [1,2,null,{}]
18:40:42 INFO - 1499478042708 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
18:40:42 INFO - 1499478042710 Marionette TRACE 396 <- [1,3,null,{}]
18:40:42 INFO - 1499478042712 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
18:40:42 INFO - 1499478042713 Marionette TRACE 396 <- [1,4,null,{}]
18:40:42 INFO - 1499478042716 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}]
18:40:42 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499478042724 Marionette TRACE 396 <- [1,5,null,{"value":null}]
18:40:42 INFO - 1499478042725 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042730 Marionette TRACE 396 <- [1,6,null,{}]
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042736 Marionette DEBUG Closed connection 396
18:40:42 INFO - 1499478042737 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49831
18:40:42 INFO - 1499478042739 Marionette DEBUG Closed connection 397
18:40:42 INFO - 1499478042742 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49832
18:40:42 INFO - 1499478042744 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
18:40:42 INFO - 1499478042747 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:42 INFO - 1499478042772 Marionette DEBUG Register listener.js for window 12
18:40:42 INFO - 1499478042783 Marionette TRACE 398 <- [1,1,null,{"sessionId":"d5f10d4b-4788-4799-b44d-302829be3fff","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:42 INFO - 1499478042789 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042793 Marionette TRACE 398 <- [1,2,null,{}]
18:40:42 INFO - [2128] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
18:40:42 INFO - 1499478042799 Marionette DEBUG Closed connection 398
18:40:42 INFO - 1499478042801 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49833
18:40:42 INFO - 1499478042802 Marionette DEBUG Closed connection 399
18:40:42 INFO - 1499478042804 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49834
18:40:42 INFO - 1499478042806 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
18:40:42 INFO - 1499478042809 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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}
18:40:42 INFO - 1499478042833 Marionette DEBUG Register listener.js for window 12
18:40:42 INFO - 1499478042845 Marionette TRACE 400 <- [1,1,null,{"sessionId":"9fc076b1-1cd8-4373-835a-ae06895b938e","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":2128,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-220.001\\AppData\\Local\\Temp\\tmpxjkie1.mozrunner","moz:accessibilityChecks":false}}]
18:40:42 INFO - 1499478042851 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"}]
18:40:42 INFO - 1499478042855 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"
18:40:42 INFO - 1499478042862 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"
18:40:42 INFO - 1499478042862 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"
18:40:42 INFO - ++DOMWINDOW == 29 (000000B5E2729000) [pid = 2128] [serial = 52] [outer = 000000B5E3185800]
18:40:43 INFO - 1499478043015 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"
18:40:43 INFO - 1499478043020 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"
18:40:43 INFO - 1499478043035 Marionette TRACE 400 <- [1,2,null,{}]
18:40:43 INFO - 1499478043041 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
18:40:43 INFO - 1499478043049 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9fa4543a-cf4f-4e8a-abbb-30bac4418715","ELEMENT":"9fa4543a-cf4f-4e8a-abbb-30bac4418715"}}]
18:40:43 INFO - 1499478043051 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"9fa4543a-cf4f-4e8a-abbb-30bac4418715"}]
18:40:43 INFO - 1499478043176 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
18:40:43 INFO - 1499478043179 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"9fa4543a-cf4f-4e8a-abbb-30bac4418715"}]
18:40:43 INFO - 1499478043354 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element