could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:04:22 INFO - 1501002262179 Marionette TRACE 353 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:04:22 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1501002262187 Marionette TRACE 353 <- [1,5,null,{"value":null}]
10:04:22 INFO - 1501002262189 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262193 Marionette TRACE 353 <- [1,6,null,{}]
10:04:22 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 632ms
10:04:22 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262199 Marionette DEBUG Closed connection 353
10:04:22 INFO - 1501002262201 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49780
10:04:22 INFO - 1501002262220 Marionette DEBUG Closed connection 354
10:04:22 INFO - 1501002262221 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49781
10:04:22 INFO - 1501002262224 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:22 INFO - 1501002262226 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:22 INFO - 1501002262246 Marionette DEBUG Register listener.js for window 12
10:04:22 INFO - 1501002262257 Marionette TRACE 355 <- [1,1,null,{"sessionId":"ba53911b-bb5e-4186-b38d-776d3dc4bdc3","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:22 INFO - 1501002262266 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
10:04:22 INFO - 1501002262268 Marionette TRACE 355 <- [1,2,null,{}]
10:04:22 INFO - 1501002262270 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:22 INFO - 1501002262271 Marionette TRACE 355 <- [1,3,null,{}]
10:04:22 INFO - 1501002262273 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:22 INFO - 1501002262275 Marionette TRACE 355 <- [1,4,null,{}]
10:04:22 INFO - 1501002262277 Marionette TRACE 355 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:04:22 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1501002262289 Marionette TRACE 355 <- [1,5,null,{"value":null}]
10:04:22 INFO - 1501002262291 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262296 Marionette TRACE 355 <- [1,6,null,{}]
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262302 Marionette DEBUG Closed connection 355
10:04:22 INFO - 1501002262303 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49782
10:04:22 INFO - 1501002262305 Marionette DEBUG Closed connection 356
10:04:22 INFO - 1501002262306 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49783
10:04:22 INFO - 1501002262327 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:22 INFO - 1501002262329 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:22 INFO - 1501002262349 Marionette DEBUG Register listener.js for window 12
10:04:22 INFO - 1501002262381 Marionette TRACE 357 <- [1,1,null,{"sessionId":"f23d60f6-1521-4142-bd17-ccbf6bfefdf0","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:22 INFO - 1501002262390 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262394 Marionette TRACE 357 <- [1,2,null,{}]
10:04:22 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:22 INFO - 1501002262414 Marionette DEBUG Closed connection 357
10:04:22 INFO - 1501002262416 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49784
10:04:22 INFO - 1501002262419 Marionette DEBUG Closed connection 358
10:04:22 INFO - 1501002262421 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49785
10:04:22 INFO - 1501002262423 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:22 INFO - 1501002262426 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:22 INFO - 1501002262445 Marionette DEBUG Register listener.js for window 12
10:04:22 INFO - 1501002262456 Marionette TRACE 359 <- [1,1,null,{"sessionId":"ff6f9b17-1913-4f66-9456-2c1870603927","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:22 INFO - 1501002262467 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49327/clicks.html"}]
10:04:22 INFO - 1501002262471 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/hidden.html"
10:04:22 INFO - 1501002262489 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/hidden.html"
10:04:22 INFO - 1501002262490 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/hidden.html"
10:04:22 INFO - ++DOMWINDOW == 21 (000000FA64212800) [pid = 3308] [serial = 41] [outer = 000000FA5BF10800]
10:04:22 INFO - 1501002262549 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/clicks.html"
10:04:22 INFO - 1501002262554 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/clicks.html"
10:04:22 INFO - 1501002262573 Marionette TRACE 359 <- [1,2,null,{}]
10:04:22 INFO - 1501002262579 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:04:22 INFO - 1501002262589 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7124ea32-4beb-458d-82e7-f3ef12b03b2e","ELEMENT":"7124ea32-4beb-458d-82e7-f3ef12b03b2e"}}]
10:04:22 INFO - 1501002262591 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"7124ea32-4beb-458d-82e7-f3ef12b03b2e"}]
10:04:23 INFO - 1501002263407 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/clicks.html"
10:04:23 INFO - [Parent 3308] 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
10:04:23 INFO - 1501002263420 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/clicks.html"
10:04:23 INFO - 1501002263421 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/clicks.html"
10:04:23 INFO - ++DOMWINDOW == 22 (000000FA6420E000) [pid = 3308] [serial = 42] [outer = 000000FA5BF10800]
10:04:23 INFO - 1501002263532 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49327/test.html"
10:04:23 INFO - 1501002263538 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49327/test.html"
10:04:23 INFO - 1501002263633 Marionette TRACE 359 <- [1,4,null,{}]
10:04:23 INFO - 1501002263645 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:04:23 INFO - 1501002263658 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"216d8efd-515b-4217-8941-9a3e6da17d7a","ELEMENT":"216d8efd-515b-4217-8941-9a3e6da17d7a"}}]
10:04:23 INFO - 1501002263663 Marionette TRACE 359 -> [0,6,"getTitle",{}]
10:04:23 INFO - 1501002263667 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
10:04:23 INFO - 1501002263674 Marionette TRACE 359 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:04:23 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1501002263687 Marionette TRACE 359 <- [1,7,null,{"value":null}]
10:04:23 INFO - 1501002263691 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
10:04:23 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:23 INFO - 1501002263701 Marionette TRACE 359 <- [1,8,null,{}]
10:04:23 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1508ms
10:04:23 INFO - TEST-START | test_click.py TestClick.test_container_element
10:04:23 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:23 INFO - 1501002263728 Marionette DEBUG Closed connection 359
10:04:23 INFO - 1501002263732 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49788
10:04:23 INFO - 1501002263737 Marionette DEBUG Closed connection 360
10:04:23 INFO - 1501002263740 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49789
10:04:23 INFO - 1501002263743 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:23 INFO - 1501002263754 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:23 INFO - 1501002263791 Marionette DEBUG Register listener.js for window 12
10:04:23 INFO - 1501002263824 Marionette TRACE 361 <- [1,1,null,{"sessionId":"aa5b8b08-50d2-4c94-9ee5-16be9069cb7a","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:23 INFO - 1501002263842 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
10:04:23 INFO - 1501002263845 Marionette TRACE 361 <- [1,2,null,{}]
10:04:23 INFO - 1501002263898 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:23 INFO - 1501002263900 Marionette TRACE 361 <- [1,3,null,{}]
10:04:23 INFO - 1501002263904 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:23 INFO - 1501002263907 Marionette TRACE 361 <- [1,4,null,{}]
10:04:23 INFO - 1501002263911 Marionette TRACE 361 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:04:23 INFO - TEST-START: test_click.py TestClick.test_container_element1501002263924 Marionette TRACE 361 <- [1,5,null,{"value":null}]
10:04:23 INFO - 1501002263929 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
10:04:23 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:23 INFO - 1501002263937 Marionette TRACE 361 <- [1,6,null,{}]
10:04:23 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:23 INFO - 1501002263946 Marionette DEBUG Closed connection 361
10:04:23 INFO - 1501002263950 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49790
10:04:23 INFO - 1501002263952 Marionette DEBUG Closed connection 362
10:04:23 INFO - 1501002263954 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49791
10:04:23 INFO - 1501002263962 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:23 INFO - 1501002263967 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:24 INFO - 1501002264004 Marionette DEBUG Register listener.js for window 12
10:04:24 INFO - 1501002264021 Marionette TRACE 363 <- [1,1,null,{"sessionId":"3ffc16ec-949e-4914-ab6b-2663b11a5d47","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:24 INFO - 1501002264063 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:24 INFO - 1501002264071 Marionette TRACE 363 <- [1,2,null,{}]
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:24 INFO - 1501002264092 Marionette DEBUG Closed connection 363
10:04:24 INFO - 1501002264094 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49792
10:04:24 INFO - 1501002264097 Marionette DEBUG Closed connection 364
10:04:24 INFO - 1501002264099 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49793
10:04:24 INFO - 1501002264102 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:24 INFO - 1501002264106 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:24 INFO - 1501002264143 Marionette DEBUG Register listener.js for window 12
10:04:24 INFO - 1501002264160 Marionette TRACE 365 <- [1,1,null,{"sessionId":"32dacd02-76a8-47ec-a803-efa5cecfe771","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:24 INFO - 1501002264179 Marionette TRACE 365 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:04:24 INFO - 1501002264185 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49327/test.html"
10:04:24 INFO - 1501002264194 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49327/test.html"
10:04:24 INFO - 1501002264196 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49327/test.html"
10:04:24 INFO - ++DOMWINDOW == 23 (000000FA5B835000) [pid = 3308] [serial = 43] [outer = 000000FA5BF10800]
10:04:24 INFO - 1501002264265 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:24 INFO - 1501002264279 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:24 INFO - 1501002264293 Marionette TRACE 365 <- [1,2,null,{}]
10:04:24 INFO - 1501002264304 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:04:24 INFO - 1501002264316 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"96a7f90f-3cab-41e7-9131-1fd6d5e4aa6a","ELEMENT":"96a7f90f-3cab-41e7-9131-1fd6d5e4aa6a"}}]
10:04:24 INFO - 1501002264319 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"96a7f90f-3cab-41e7-9131-1fd6d5e4aa6a"}]
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:04:24 INFO - 1501002264812 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:04:24 INFO - 1501002264814 Marionette TRACE 365 <- [1,4,null,{}]
10:04:24 INFO - 1501002264816 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"96a7f90f-3cab-41e7-9131-1fd6d5e4aa6a","name":"selected"}]
10:04:24 INFO - 1501002264852 Marionette TRACE 365 <- [1,5,null,{"value":true}]
10:04:24 INFO - 1501002264904 Marionette TRACE 365 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:04:24 INFO - TEST-END: test_click.py TestClick.test_container_element1501002264915 Marionette TRACE 365 <- [1,6,null,{"value":null}]
10:04:24 INFO - 1501002264924 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:24 INFO - 1501002264929 Marionette TRACE 365 <- [1,7,null,{}]
10:04:24 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1228ms
10:04:24 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:04:24 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:24 INFO - 1501002264951 Marionette DEBUG Closed connection 365
10:04:24 INFO - 1501002264953 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49794
10:04:24 INFO - 1501002264957 Marionette DEBUG Closed connection 366
10:04:24 INFO - 1501002264960 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49795
10:04:24 INFO - 1501002264962 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:24 INFO - 1501002264966 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:25 INFO - 1501002265006 Marionette DEBUG Register listener.js for window 12
10:04:25 INFO - 1501002265022 Marionette TRACE 367 <- [1,1,null,{"sessionId":"e6d1bd2f-0a56-4ea4-aa25-2cb928a20040","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:25 INFO - 1501002265041 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
10:04:25 INFO - 1501002265044 Marionette TRACE 367 <- [1,2,null,{}]
10:04:25 INFO - 1501002265046 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:25 INFO - 1501002265048 Marionette TRACE 367 <- [1,3,null,{}]
10:04:25 INFO - 1501002265050 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:25 INFO - 1501002265052 Marionette TRACE 367 <- [1,4,null,{}]
10:04:25 INFO - 1501002265055 Marionette TRACE 367 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:04:25 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1501002265065 Marionette TRACE 367 <- [1,5,null,{"value":null}]
10:04:25 INFO - 1501002265075 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:25 INFO - 1501002265080 Marionette TRACE 367 <- [1,6,null,{}]
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:25 INFO - 1501002265101 Marionette DEBUG Closed connection 367
10:04:25 INFO - 1501002265103 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49796
10:04:25 INFO - 1501002265105 Marionette DEBUG Closed connection 368
10:04:25 INFO - 1501002265107 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49797
10:04:25 INFO - 1501002265110 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:25 INFO - 1501002265116 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:25 INFO - 1501002265154 Marionette DEBUG Register listener.js for window 12
10:04:25 INFO - 1501002265182 Marionette TRACE 369 <- [1,1,null,{"sessionId":"f8356d17-9b95-4735-862e-698ab311f631","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:25 INFO - 1501002265195 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:25 INFO - 1501002265201 Marionette TRACE 369 <- [1,2,null,{}]
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:25 INFO - 1501002265225 Marionette DEBUG Closed connection 369
10:04:25 INFO - 1501002265231 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49798
10:04:25 INFO - 1501002265279 Marionette DEBUG Closed connection 370
10:04:25 INFO - 1501002265281 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49799
10:04:25 INFO - 1501002265286 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:25 INFO - 1501002265289 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:25 INFO - 1501002265328 Marionette DEBUG Register listener.js for window 12
10:04:25 INFO - 1501002265344 Marionette TRACE 371 <- [1,1,null,{"sessionId":"c33582c2-253e-47a4-83cf-48704541be19","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:25 INFO - 1501002265355 Marionette TRACE 371 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:04:25 INFO - 1501002265361 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:25 INFO - 1501002265370 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:25 INFO - 1501002265371 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:25 INFO - ++DOMWINDOW == 24 (000000FA62360000) [pid = 3308] [serial = 44] [outer = 000000FA5BF10800]
10:04:25 INFO - 1501002265443 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:25 INFO - 1501002265450 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:25 INFO - 1501002265616 Marionette TRACE 371 <- [1,2,null,{}]
10:04:25 INFO - 1501002265623 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:04:25 INFO - 1501002265635 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c04e3b7a-4a99-4b92-b0bb-7b46fe929415","ELEMENT":"c04e3b7a-4a99-4b92-b0bb-7b46fe929415"}}]
10:04:25 INFO - 1501002265639 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"c04e3b7a-4a99-4b92-b0bb-7b46fe929415"}]
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:04:25 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:04:26 INFO - 1501002266078 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:04:26 INFO - 1501002266082 Marionette TRACE 371 <- [1,4,null,{}]
10:04:26 INFO - 1501002266091 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"c04e3b7a-4a99-4b92-b0bb-7b46fe929415","name":"selected"}]
10:04:26 INFO - 1501002266121 Marionette TRACE 371 <- [1,5,null,{"value":true}]
10:04:26 INFO - 1501002266129 Marionette TRACE 371 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:04:26 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1501002266140 Marionette TRACE 371 <- [1,6,null,{"value":null}]
10:04:26 INFO - 1501002266144 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1226ms
10:04:26 INFO - 1501002266154 Marionette TRACE 371 <- [1,7,null,{}]
10:04:26 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - 1501002266163 Marionette DEBUG Closed connection 371
10:04:26 INFO - 1501002266166 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49800
10:04:26 INFO - 1501002266198 Marionette DEBUG Closed connection 372
10:04:26 INFO - 1501002266201 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49801
10:04:26 INFO - 1501002266224 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:26 INFO - 1501002266233 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:26 INFO - 1501002266255 Marionette DEBUG Register listener.js for window 12
10:04:26 INFO - 1501002266274 Marionette TRACE 373 <- [1,1,null,{"sessionId":"e5046a64-afd6-4994-9662-3b70308dd2e5","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:26 INFO - 1501002266289 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
10:04:26 INFO - 1501002266292 Marionette TRACE 373 <- [1,2,null,{}]
10:04:26 INFO - 1501002266297 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:26 INFO - 1501002266300 Marionette TRACE 373 <- [1,3,null,{}]
10:04:26 INFO - 1501002266304 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:26 INFO - 1501002266306 Marionette TRACE 373 <- [1,4,null,{}]
10:04:26 INFO - 1501002266310 Marionette TRACE 373 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:04:26 INFO - TEST-START: test_click.py TestClick.test_css_transforms1501002266322 Marionette TRACE 373 <- [1,5,null,{"value":null}]
10:04:26 INFO - 1501002266330 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - 1501002266338 Marionette TRACE 373 <- [1,6,null,{}]
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - 1501002266349 Marionette DEBUG Closed connection 373
10:04:26 INFO - 1501002266352 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49802
10:04:26 INFO - 1501002266358 Marionette DEBUG Closed connection 374
10:04:26 INFO - 1501002266360 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49803
10:04:26 INFO - 1501002266398 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:26 INFO - 1501002266401 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:26 INFO - 1501002266422 Marionette DEBUG Register listener.js for window 12
10:04:26 INFO - 1501002266437 Marionette TRACE 375 <- [1,1,null,{"sessionId":"825b3eda-76ea-4a67-bad5-a3d676875d42","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:26 INFO - --DOMWINDOW == 23 (000000FA59486000) [pid = 3308] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49327/test_accessibility.html]
10:04:26 INFO - --DOMWINDOW == 22 (000000FA55A34800) [pid = 3308] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49327/test_accessibility.html]
10:04:26 INFO - --DOMWINDOW == 21 (000000FA5FB2C800) [pid = 3308] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49327/test_accessibility.html]
10:04:26 INFO - --DOMWINDOW == 20 (000000FA5BF15000) [pid = 3308] [serial = 33] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
10:04:26 INFO - 1501002266469 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - 1501002266475 Marionette TRACE 375 <- [1,2,null,{}]
10:04:26 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:26 INFO - 1501002266496 Marionette DEBUG Closed connection 375
10:04:26 INFO - 1501002266498 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49804
10:04:26 INFO - 1501002266501 Marionette DEBUG Closed connection 376
10:04:26 INFO - 1501002266503 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49805
10:04:26 INFO - 1501002266505 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:26 INFO - 1501002266509 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:26 INFO - 1501002266529 Marionette DEBUG Register listener.js for window 12
10:04:26 INFO - 1501002266544 Marionette TRACE 377 <- [1,1,null,{"sessionId":"ee0ee221-835d-4127-8512-61d45b8b0354","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:26 INFO - 1501002266552 Marionette TRACE 377 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:04:26 INFO - 1501002266556 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:26 INFO - 1501002266565 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:26 INFO - 1501002266566 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:26 INFO - ++DOMWINDOW == 21 (000000FA506A2800) [pid = 3308] [serial = 45] [outer = 000000FA5BF10800]
10:04:26 INFO - 1501002266626 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:04:26 INFO - 1501002266632 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:04:26 INFO - 1501002266651 Marionette TRACE 377 <- [1,2,null,{}]
10:04:26 INFO - 1501002266657 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:04:26 INFO - 1501002266665 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5845d1a1-d41c-4dc8-ab59-0f78c13320de","ELEMENT":"5845d1a1-d41c-4dc8-ab59-0f78c13320de"}}]
10:04:26 INFO - 1501002266667 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"5845d1a1-d41c-4dc8-ab59-0f78c13320de"}]
10:04:27 INFO - 1501002267067 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:04:27 INFO - 1501002267070 Marionette TRACE 377 <- [1,4,null,{}]
10:04:27 INFO - 1501002267072 Marionette TRACE 377 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:04:27 INFO - TEST-END: test_click.py TestClick.test_css_transforms1501002267081 Marionette TRACE 377 <- [1,5,null,{"value":null}]
10:04:27 INFO - 1501002267083 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267088 Marionette TRACE 377 <- [1,6,null,{}]
10:04:27 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 931ms
10:04:27 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267094 Marionette DEBUG Closed connection 377
10:04:27 INFO - 1501002267096 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49806
10:04:27 INFO - 1501002267098 Marionette DEBUG Closed connection 378
10:04:27 INFO - 1501002267100 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49807
10:04:27 INFO - 1501002267103 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:27 INFO - 1501002267106 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:27 INFO - 1501002267127 Marionette DEBUG Register listener.js for window 12
10:04:27 INFO - 1501002267140 Marionette TRACE 379 <- [1,1,null,{"sessionId":"22ca59df-c1df-4cc5-8706-c9e36858d2b8","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:27 INFO - 1501002267147 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
10:04:27 INFO - 1501002267149 Marionette TRACE 379 <- [1,2,null,{}]
10:04:27 INFO - 1501002267151 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:27 INFO - 1501002267153 Marionette TRACE 379 <- [1,3,null,{}]
10:04:27 INFO - 1501002267154 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:27 INFO - 1501002267156 Marionette TRACE 379 <- [1,4,null,{}]
10:04:27 INFO - 1501002267159 Marionette TRACE 379 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:04:27 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1501002267168 Marionette TRACE 379 <- [1,5,null,{"value":null}]
10:04:27 INFO - 1501002267172 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267177 Marionette TRACE 379 <- [1,6,null,{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267183 Marionette DEBUG Closed connection 379
10:04:27 INFO - 1501002267185 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49808
10:04:27 INFO - 1501002267187 Marionette DEBUG Closed connection 380
10:04:27 INFO - 1501002267189 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49809
10:04:27 INFO - 1501002267191 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:27 INFO - 1501002267196 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:27 INFO - 1501002267219 Marionette DEBUG Register listener.js for window 12
10:04:27 INFO - 1501002267234 Marionette TRACE 381 <- [1,1,null,{"sessionId":"f2f3aef6-6939-4181-ab29-a03bb3f69f85","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:27 INFO - 1501002267240 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267246 Marionette TRACE 381 <- [1,2,null,{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267254 Marionette DEBUG Closed connection 381
10:04:27 INFO - 1501002267258 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49810
10:04:27 INFO - 1501002267261 Marionette DEBUG Closed connection 382
10:04:27 INFO - 1501002267262 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49811
10:04:27 INFO - 1501002267265 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:27 INFO - 1501002267267 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:27 INFO - 1501002267289 Marionette DEBUG Register listener.js for window 12
10:04:27 INFO - 1501002267302 Marionette TRACE 383 <- [1,1,null,{"sessionId":"98003cb8-f211-41a4-8aa5-38a9e0fd0ec0","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:27 INFO - 1501002267309 Marionette TRACE 383 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:04:27 INFO - 1501002267315 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:04:27 INFO - 1501002267323 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:04:27 INFO - 1501002267324 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:04:27 INFO - ++DOMWINDOW == 22 (000000FA5C5CF800) [pid = 3308] [serial = 46] [outer = 000000FA5BF10800]
10:04:27 INFO - 1501002267380 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:27 INFO - 1501002267388 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:27 INFO - 1501002267406 Marionette TRACE 383 <- [1,2,null,{}]
10:04:27 INFO - 1501002267409 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:04:27 INFO - 1501002267417 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8023393f-3841-4742-8ada-1a28709c21a7","ELEMENT":"8023393f-3841-4742-8ada-1a28709c21a7"}}]
10:04:27 INFO - 1501002267421 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"8023393f-3841-4742-8ada-1a28709c21a7"}]
10:04:27 INFO - 1501002267853 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:04:27 INFO - 1501002267855 Marionette TRACE 383 <- [1,4,null,{}]
10:04:27 INFO - 1501002267857 Marionette TRACE 383 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:04:27 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1501002267865 Marionette TRACE 383 <- [1,5,null,{"value":null}]
10:04:27 INFO - 1501002267867 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267872 Marionette TRACE 383 <- [1,6,null,{}]
10:04:27 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 784ms
10:04:27 INFO - TEST-START | test_click.py TestClick.test_input_file
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267878 Marionette DEBUG Closed connection 383
10:04:27 INFO - 1501002267879 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49812
10:04:27 INFO - 1501002267881 Marionette DEBUG Closed connection 384
10:04:27 INFO - 1501002267882 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49813
10:04:27 INFO - 1501002267885 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:27 INFO - 1501002267887 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:27 INFO - 1501002267908 Marionette DEBUG Register listener.js for window 12
10:04:27 INFO - 1501002267920 Marionette TRACE 385 <- [1,1,null,{"sessionId":"59e6f2d4-4e34-4785-8f4c-2af6b50ca6a7","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:27 INFO - 1501002267926 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
10:04:27 INFO - 1501002267928 Marionette TRACE 385 <- [1,2,null,{}]
10:04:27 INFO - 1501002267929 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:27 INFO - 1501002267931 Marionette TRACE 385 <- [1,3,null,{}]
10:04:27 INFO - 1501002267935 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:27 INFO - 1501002267937 Marionette TRACE 385 <- [1,4,null,{}]
10:04:27 INFO - 1501002267939 Marionette TRACE 385 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:04:27 INFO - TEST-START: test_click.py TestClick.test_input_file1501002267948 Marionette TRACE 385 <- [1,5,null,{"value":null}]
10:04:27 INFO - 1501002267950 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267955 Marionette TRACE 385 <- [1,6,null,{}]
10:04:27 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:27 INFO - 1501002267960 Marionette DEBUG Closed connection 385
10:04:27 INFO - 1501002267962 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49814
10:04:27 INFO - 1501002267964 Marionette DEBUG Closed connection 386
10:04:27 INFO - 1501002267966 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49815
10:04:27 INFO - 1501002267969 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:27 INFO - 1501002267972 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:27 INFO - 1501002267993 Marionette DEBUG Register listener.js for window 12
10:04:28 INFO - 1501002268005 Marionette TRACE 387 <- [1,1,null,{"sessionId":"20b28acf-86b5-4706-b468-7d5c3928a90b","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:28 INFO - 1501002268011 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268015 Marionette TRACE 387 <- [1,2,null,{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268021 Marionette DEBUG Closed connection 387
10:04:28 INFO - 1501002268023 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49816
10:04:28 INFO - 1501002268024 Marionette DEBUG Closed connection 388
10:04:28 INFO - 1501002268026 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49817
10:04:28 INFO - 1501002268028 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:28 INFO - 1501002268031 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:28 INFO - 1501002268052 Marionette DEBUG Register listener.js for window 12
10:04:28 INFO - 1501002268063 Marionette TRACE 389 <- [1,1,null,{"sessionId":"8d8288fd-4cea-421d-8ea4-6585703f605f","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:28 INFO - 1501002268070 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:04:28 INFO - 1501002268074 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:28 INFO - 1501002268080 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:28 INFO - 1501002268082 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:04:28 INFO - ++DOMWINDOW == 23 (000000FA61FB3000) [pid = 3308] [serial = 47] [outer = 000000FA5BF10800]
10:04:28 INFO - 1501002268134 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:04:28 INFO - 1501002268146 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:04:28 INFO - 1501002268156 Marionette TRACE 389 <- [1,2,null,{}]
10:04:28 INFO - 1501002268166 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:04:28 INFO - 1501002268176 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dbfa61d4-830c-43d7-abc0-7787e4fdcdce","ELEMENT":"dbfa61d4-830c-43d7-abc0-7787e4fdcdce"}}]
10:04:28 INFO - 1501002268178 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"dbfa61d4-830c-43d7-abc0-7787e4fdcdce"}]
10:04:28 INFO - 1501002268314 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:04:28 INFO - 1501002268317 Marionette TRACE 389 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:04:28 INFO - TEST-END: test_click.py TestClick.test_input_file1501002268325 Marionette TRACE 389 <- [1,5,null,{"value":null}]
10:04:28 INFO - 1501002268327 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268331 Marionette TRACE 389 <- [1,6,null,{}]
10:04:28 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 460ms
10:04:28 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268337 Marionette DEBUG Closed connection 389
10:04:28 INFO - 1501002268339 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49818
10:04:28 INFO - 1501002268341 Marionette DEBUG Closed connection 390
10:04:28 INFO - 1501002268342 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49819
10:04:28 INFO - 1501002268344 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:28 INFO - 1501002268347 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:28 INFO - 1501002268368 Marionette DEBUG Register listener.js for window 12
10:04:28 INFO - 1501002268380 Marionette TRACE 391 <- [1,1,null,{"sessionId":"413af527-78fb-4155-a278-64568b4599e2","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:28 INFO - 1501002268386 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
10:04:28 INFO - 1501002268388 Marionette TRACE 391 <- [1,2,null,{}]
10:04:28 INFO - 1501002268390 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:28 INFO - 1501002268392 Marionette TRACE 391 <- [1,3,null,{}]
10:04:28 INFO - 1501002268394 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:28 INFO - 1501002268395 Marionette TRACE 391 <- [1,4,null,{}]
10:04:28 INFO - 1501002268398 Marionette TRACE 391 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:04:28 INFO - TEST-START: test_click.py TestClick.test_obscured_element1501002268406 Marionette TRACE 391 <- [1,5,null,{"value":null}]
10:04:28 INFO - 1501002268408 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268412 Marionette TRACE 391 <- [1,6,null,{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268419 Marionette DEBUG Closed connection 391
10:04:28 INFO - 1501002268420 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49820
10:04:28 INFO - 1501002268422 Marionette DEBUG Closed connection 392
10:04:28 INFO - 1501002268423 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49821
10:04:28 INFO - 1501002268426 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:28 INFO - 1501002268429 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:28 INFO - 1501002268455 Marionette DEBUG Register listener.js for window 12
10:04:28 INFO - 1501002268481 Marionette TRACE 393 <- [1,1,null,{"sessionId":"ddf4755d-c065-4299-b1f3-00d2711d1747","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:28 INFO - 1501002268488 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268492 Marionette TRACE 393 <- [1,2,null,{}]
10:04:28 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:28 INFO - 1501002268498 Marionette DEBUG Closed connection 393
10:04:28 INFO - 1501002268499 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49822
10:04:28 INFO - 1501002268501 Marionette DEBUG Closed connection 394
10:04:28 INFO - 1501002268502 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49823
10:04:28 INFO - 1501002268504 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:28 INFO - 1501002268507 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:28 INFO - 1501002268528 Marionette DEBUG Register listener.js for window 12
10:04:28 INFO - 1501002268539 Marionette TRACE 395 <- [1,1,null,{"sessionId":"c4c4236a-94fb-4703-b4af-70c3aac13517","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:28 INFO - 1501002268546 Marionette TRACE 395 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:04:28 INFO - 1501002268550 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:04:28 INFO - 1501002268559 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:04:28 INFO - 1501002268560 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:04:28 INFO - ++DOMWINDOW == 24 (000000FA64213000) [pid = 3308] [serial = 48] [outer = 000000FA5BF10800]
10:04:28 INFO - 1501002268618 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:04:28 INFO - 1501002268623 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:04:28 INFO - 1501002268640 Marionette TRACE 395 <- [1,2,null,{}]
10:04:28 INFO - 1501002268642 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:04:28 INFO - 1501002268649 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5a4dbb5c-020e-487f-83b9-882c190dff37","ELEMENT":"5a4dbb5c-020e-487f-83b9-882c190dff37"}}]
10:04:28 INFO - 1501002268651 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:04:28 INFO - 1501002268659 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"547ee995-c148-4bb1-89f5-41bc59f07c25","ELEMENT":"547ee995-c148-4bb1-89f5-41bc59f07c25"}}]
10:04:28 INFO - 1501002268661 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"5a4dbb5c-020e-487f-83b9-882c190dff37"}]
10:04:29 INFO - 1501002269055 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:04:29 INFO - 1501002269057 Marionette TRACE 395 <- [1,5,null,{}]
10:04:29 INFO - 1501002269059 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"547ee995-c148-4bb1-89f5-41bc59f07c25"}]
10:04:29 INFO - 1501002269171 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:04:29 INFO - 1501002269176 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:04:29 INFO - 1501002269184 Marionette TRACE 395 <- [1,7,null,{"value":false}]
10:04:29 INFO - 1501002269186 Marionette TRACE 395 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:04:29 INFO - TEST-END: test_click.py TestClick.test_obscured_element1501002269193 Marionette TRACE 395 <- [1,8,null,{"value":null}]
10:04:29 INFO - 1501002269195 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269199 Marionette TRACE 395 <- [1,9,null,{}]
10:04:29 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 867ms
10:04:29 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269206 Marionette DEBUG Closed connection 395
10:04:29 INFO - 1501002269207 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49824
10:04:29 INFO - 1501002269209 Marionette DEBUG Closed connection 396
10:04:29 INFO - 1501002269210 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49825
10:04:29 INFO - 1501002269212 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:29 INFO - 1501002269214 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:29 INFO - 1501002269236 Marionette DEBUG Register listener.js for window 12
10:04:29 INFO - 1501002269247 Marionette TRACE 397 <- [1,1,null,{"sessionId":"fe27b84b-f610-4293-b684-e5ef2416ea1e","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:29 INFO - 1501002269253 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
10:04:29 INFO - 1501002269254 Marionette TRACE 397 <- [1,2,null,{}]
10:04:29 INFO - 1501002269257 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:04:29 INFO - 1501002269258 Marionette TRACE 397 <- [1,3,null,{}]
10:04:29 INFO - 1501002269260 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
10:04:29 INFO - 1501002269262 Marionette TRACE 397 <- [1,4,null,{}]
10:04:29 INFO - 1501002269264 Marionette TRACE 397 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:04:29 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1501002269274 Marionette TRACE 397 <- [1,5,null,{"value":null}]
10:04:29 INFO - 1501002269276 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269280 Marionette TRACE 397 <- [1,6,null,{}]
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269286 Marionette DEBUG Closed connection 397
10:04:29 INFO - 1501002269288 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49826
10:04:29 INFO - 1501002269289 Marionette DEBUG Closed connection 398
10:04:29 INFO - 1501002269291 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49827
10:04:29 INFO - 1501002269293 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:04:29 INFO - 1501002269295 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:29 INFO - 1501002269317 Marionette DEBUG Register listener.js for window 12
10:04:29 INFO - 1501002269327 Marionette TRACE 399 <- [1,1,null,{"sessionId":"1a727623-108f-4691-b692-944528e6fa31","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:29 INFO - 1501002269333 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269337 Marionette TRACE 399 <- [1,2,null,{}]
10:04:29 INFO - [Parent 3308] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:04:29 INFO - 1501002269343 Marionette DEBUG Closed connection 399
10:04:29 INFO - 1501002269344 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49828
10:04:29 INFO - 1501002269346 Marionette DEBUG Closed connection 400
10:04:29 INFO - 1501002269347 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49829
10:04:29 INFO - 1501002269350 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:04:29 INFO - 1501002269352 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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}
10:04:29 INFO - 1501002269374 Marionette DEBUG Register listener.js for window 12
10:04:29 INFO - 1501002269384 Marionette TRACE 401 <- [1,1,null,{"sessionId":"b5c3ae17-8354-4055-9b5f-241ce4754765","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":3308,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-031.001\\AppData\\Local\\Temp\\tmpbtnb9c.mozrunner","moz:accessibilityChecks":false}}]
10:04:29 INFO - 1501002269390 Marionette TRACE 401 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:04:29 INFO - 1501002269395 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:04:29 INFO - 1501002269401 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:04:29 INFO - 1501002269402 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:04:29 INFO - ++DOMWINDOW == 25 (000000FA553CB000) [pid = 3308] [serial = 49] [outer = 000000FA5BF10800]
10:04:29 INFO - 1501002269459 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:04:29 INFO - 1501002269465 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:04:29 INFO - 1501002269474 Marionette TRACE 401 <- [1,2,null,{}]
10:04:29 INFO - 1501002269486 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:04:29 INFO - 1501002269493 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"eded90e4-95b3-4a03-86ca-ccafaba09899","ELEMENT":"eded90e4-95b3-4a03-86ca-ccafaba09899"}}]
10:04:29 INFO - 1501002269496 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"eded90e4-95b3-4a03-86ca-ccafaba09899"}]
10:04:29 INFO - 1501002269623 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
10:04:30 INFO - 1501002270045 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"eded90e4-95b3-4a03-86ca-ccafaba09899"}]
10:04:30 INFO - 1501002270154 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element