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:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:04:22 INFO - 1500545062472 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
03:04:22 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500545062479 Marionette TRACE 352 <- [1,5,null,{"value":null}]
03:04:22 INFO - 1500545062481 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062485 Marionette TRACE 352 <- [1,6,null,{}]
03:04:22 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 471ms
03:04:22 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062490 Marionette DEBUG Closed connection 352
03:04:22 INFO - 1500545062491 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49794
03:04:22 INFO - 1500545062493 Marionette DEBUG Closed connection 353
03:04:22 INFO - 1500545062494 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49795
03:04:22 INFO - 1500545062496 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:22 INFO - 1500545062498 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:22 INFO - 1500545062519 Marionette DEBUG Register listener.js for window 6442450945
03:04:22 INFO - 1500545062530 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d9b647fb-2428-4385-bc6c-c0de90940a8f","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:22 INFO - 1500545062533 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
03:04:22 INFO - 1500545062534 Marionette TRACE 354 <- [1,2,null,{}]
03:04:22 INFO - 1500545062536 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:22 INFO - 1500545062538 Marionette TRACE 354 <- [1,3,null,{}]
03:04:22 INFO - 1500545062539 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:22 INFO - 1500545062541 Marionette TRACE 354 <- [1,4,null,{}]
03:04:22 INFO - 1500545062543 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
03:04:22 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500545062550 Marionette TRACE 354 <- [1,5,null,{"value":null}]
03:04:22 INFO - 1500545062552 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062556 Marionette TRACE 354 <- [1,6,null,{}]
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062560 Marionette DEBUG Closed connection 354
03:04:22 INFO - 1500545062562 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49796
03:04:22 INFO - 1500545062564 Marionette DEBUG Closed connection 355
03:04:22 INFO - 1500545062565 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49797
03:04:22 INFO - 1500545062567 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:22 INFO - 1500545062569 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:22 INFO - 1500545062590 Marionette DEBUG Register listener.js for window 6442450945
03:04:22 INFO - 1500545062601 Marionette TRACE 356 <- [1,1,null,{"sessionId":"57d9c019-dee7-409a-8524-d54d44c68eee","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:22 INFO - 1500545062604 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062608 Marionette TRACE 356 <- [1,2,null,{}]
03:04:22 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:22 INFO - 1500545062613 Marionette DEBUG Closed connection 356
03:04:22 INFO - 1500545062615 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49798
03:04:22 INFO - 1500545062616 Marionette DEBUG Closed connection 357
03:04:22 INFO - 1500545062618 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49799
03:04:22 INFO - 1500545062620 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:22 INFO - 1500545062623 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:22 INFO - 1500545062644 Marionette DEBUG Register listener.js for window 6442450945
03:04:22 INFO - 1500545062656 Marionette TRACE 358 <- [1,1,null,{"sessionId":"6d190bf1-e364-430a-a580-5fa800bf1eee","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:22 INFO - 1500545062658 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
03:04:22 INFO - 1500545062662 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
03:04:22 INFO - 1500545062681 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
03:04:22 INFO - 1500545062682 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
03:04:22 INFO - ++DOMWINDOW == 18 (000000DC9E828000) [pid = 1456] [serial = 24] [outer = 000000DC95A99800]
03:04:22 INFO - 1500545062706 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
03:04:22 INFO - 1500545062718 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
03:04:22 INFO - 1500545062725 Marionette TRACE 358 <- [1,2,null,{}]
03:04:22 INFO - 1500545062732 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
03:04:22 INFO - 1500545062742 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3a7bfd3e-190a-426c-aed3-5e00b1f55722","ELEMENT":"3a7bfd3e-190a-426c-aed3-5e00b1f55722"}}]
03:04:22 INFO - 1500545062745 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"3a7bfd3e-190a-426c-aed3-5e00b1f55722"}]
03:04:22 INFO - 1500545062961 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
03:04:22 INFO - 1500545062979 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
03:04:22 INFO - 1500545062980 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
03:04:22 INFO - ++DOMWINDOW == 19 (000000DCA2F3D000) [pid = 1456] [serial = 25] [outer = 000000DC95A99800]
03:04:23 INFO - 1500545063007 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
03:04:23 INFO - 1500545063011 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
03:04:23 INFO - 1500545063017 Marionette TRACE 358 <- [1,4,null,{}]
03:04:23 INFO - 1500545063030 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
03:04:23 INFO - 1500545063044 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bf1988d9-fcee-456d-8ce7-1b4f7f7b5e5f","ELEMENT":"bf1988d9-fcee-456d-8ce7-1b4f7f7b5e5f"}}]
03:04:23 INFO - 1500545063046 Marionette TRACE 358 -> [0,6,"getTitle",{}]
03:04:23 INFO - 1500545063047 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
03:04:23 INFO - 1500545063050 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
03:04:23 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500545063060 Marionette TRACE 358 <- [1,7,null,{"value":null}]
03:04:23 INFO - 1500545063062 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063067 Marionette TRACE 358 <- [1,8,null,{}]
03:04:23 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 580ms
03:04:23 INFO - TEST-START | test_click.py TestClick.test_container_element
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063071 Marionette DEBUG Closed connection 358
03:04:23 INFO - 1500545063074 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49802
03:04:23 INFO - 1500545063076 Marionette DEBUG Closed connection 359
03:04:23 INFO - 1500545063077 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49803
03:04:23 INFO - 1500545063079 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:23 INFO - 1500545063081 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063103 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063114 Marionette TRACE 360 <- [1,1,null,{"sessionId":"f80fc2d4-5906-4941-b345-cb2670fab585","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063116 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
03:04:23 INFO - 1500545063118 Marionette TRACE 360 <- [1,2,null,{}]
03:04:23 INFO - 1500545063120 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:23 INFO - 1500545063121 Marionette TRACE 360 <- [1,3,null,{}]
03:04:23 INFO - 1500545063123 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:23 INFO - 1500545063125 Marionette TRACE 360 <- [1,4,null,{}]
03:04:23 INFO - 1500545063127 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
03:04:23 INFO - TEST-START: test_click.py TestClick.test_container_element1500545063134 Marionette TRACE 360 <- [1,5,null,{"value":null}]
03:04:23 INFO - 1500545063136 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063140 Marionette TRACE 360 <- [1,6,null,{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063144 Marionette DEBUG Closed connection 360
03:04:23 INFO - 1500545063146 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49804
03:04:23 INFO - 1500545063147 Marionette DEBUG Closed connection 361
03:04:23 INFO - 1500545063149 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49805
03:04:23 INFO - 1500545063151 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:23 INFO - 1500545063153 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063174 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063199 Marionette TRACE 362 <- [1,1,null,{"sessionId":"2fe7a0ee-90d0-4771-ab01-7d17193f4dca","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063202 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063206 Marionette TRACE 362 <- [1,2,null,{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063210 Marionette DEBUG Closed connection 362
03:04:23 INFO - 1500545063211 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49806
03:04:23 INFO - 1500545063213 Marionette DEBUG Closed connection 363
03:04:23 INFO - 1500545063214 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49807
03:04:23 INFO - 1500545063216 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:23 INFO - 1500545063219 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063240 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063250 Marionette TRACE 364 <- [1,1,null,{"sessionId":"a3251639-cde1-4a55-81d5-5c41b531036b","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063253 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
03:04:23 INFO - 1500545063257 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
03:04:23 INFO - 1500545063261 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
03:04:23 INFO - 1500545063262 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
03:04:23 INFO - ++DOMWINDOW == 20 (000000DCA1E93800) [pid = 1456] [serial = 26] [outer = 000000DC95A99800]
03:04:23 INFO - 1500545063283 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"
03:04:23 INFO - 1500545063291 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"
03:04:23 INFO - 1500545063301 Marionette TRACE 364 <- [1,2,null,{}]
03:04:23 INFO - 1500545063309 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:04:23 INFO - 1500545063315 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e31e008e-f36a-4329-b2c7-a44f387fbb44","ELEMENT":"e31e008e-f36a-4329-b2c7-a44f387fbb44"}}]
03:04:23 INFO - 1500545063318 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"e31e008e-f36a-4329-b2c7-a44f387fbb44"}]
03:04:23 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:04:23 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:04:23 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:04:23 INFO - 1500545063751 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:04:23 INFO - 1500545063753 Marionette TRACE 364 <- [1,4,null,{}]
03:04:23 INFO - 1500545063755 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"e31e008e-f36a-4329-b2c7-a44f387fbb44","name":"selected"}]
03:04:23 INFO - 1500545063782 Marionette TRACE 364 <- [1,5,null,{"value":true}]
03:04:23 INFO - 1500545063785 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
03:04:23 INFO - TEST-END: test_click.py TestClick.test_container_element1500545063792 Marionette TRACE 364 <- [1,6,null,{"value":null}]
03:04:23 INFO - 1500545063794 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063798 Marionette TRACE 364 <- [1,7,null,{}]
03:04:23 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 732ms
03:04:23 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063803 Marionette DEBUG Closed connection 364
03:04:23 INFO - 1500545063804 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49808
03:04:23 INFO - 1500545063807 Marionette DEBUG Closed connection 365
03:04:23 INFO - 1500545063809 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49809
03:04:23 INFO - 1500545063812 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:23 INFO - 1500545063814 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063837 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063848 Marionette TRACE 366 <- [1,1,null,{"sessionId":"ac596862-431d-4f33-bf30-cb3f8f65bc22","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063851 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
03:04:23 INFO - 1500545063853 Marionette TRACE 366 <- [1,2,null,{}]
03:04:23 INFO - 1500545063854 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:23 INFO - 1500545063856 Marionette TRACE 366 <- [1,3,null,{}]
03:04:23 INFO - 1500545063858 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:23 INFO - 1500545063860 Marionette TRACE 366 <- [1,4,null,{}]
03:04:23 INFO - 1500545063862 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
03:04:23 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500545063870 Marionette TRACE 366 <- [1,5,null,{"value":null}]
03:04:23 INFO - 1500545063872 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063876 Marionette TRACE 366 <- [1,6,null,{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063880 Marionette DEBUG Closed connection 366
03:04:23 INFO - 1500545063881 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49810
03:04:23 INFO - 1500545063883 Marionette DEBUG Closed connection 367
03:04:23 INFO - 1500545063884 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49811
03:04:23 INFO - 1500545063887 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:23 INFO - 1500545063889 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063910 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063921 Marionette TRACE 368 <- [1,1,null,{"sessionId":"c462aec0-3dd4-468c-a25d-8d6788e62a9d","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063924 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063928 Marionette TRACE 368 <- [1,2,null,{}]
03:04:23 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:23 INFO - 1500545063932 Marionette DEBUG Closed connection 368
03:04:23 INFO - 1500545063933 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49812
03:04:23 INFO - 1500545063935 Marionette DEBUG Closed connection 369
03:04:23 INFO - 1500545063936 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49813
03:04:23 INFO - 1500545063938 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:23 INFO - 1500545063941 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:23 INFO - 1500545063963 Marionette DEBUG Register listener.js for window 6442450945
03:04:23 INFO - 1500545063974 Marionette TRACE 370 <- [1,1,null,{"sessionId":"d7df7507-1b31-4e92-90d6-d1fcb8102498","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:23 INFO - 1500545063977 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
03:04:23 INFO - 1500545063980 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"
03:04:23 INFO - 1500545063985 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"
03:04:23 INFO - 1500545063986 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"
03:04:23 INFO - ++DOMWINDOW == 21 (000000DCA1E84000) [pid = 1456] [serial = 27] [outer = 000000DC95A99800]
03:04:24 INFO - 1500545064007 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"
03:04:24 INFO - 1500545064014 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"
03:04:24 INFO - 1500545064033 Marionette TRACE 370 <- [1,2,null,{}]
03:04:24 INFO - 1500545064044 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
03:04:24 INFO - 1500545064050 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c7e0a1c6-135c-4dbe-a196-33c785a61b4c","ELEMENT":"c7e0a1c6-135c-4dbe-a196-33c785a61b4c"}}]
03:04:24 INFO - 1500545064052 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"c7e0a1c6-135c-4dbe-a196-33c785a61b4c"}]
03:04:24 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
03:04:24 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
03:04:24 INFO - [Child 1456] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
03:04:24 INFO - 1500545064561 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:04:24 INFO - 1500545064563 Marionette TRACE 370 <- [1,4,null,{}]
03:04:24 INFO - 1500545064565 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"c7e0a1c6-135c-4dbe-a196-33c785a61b4c","name":"selected"}]
03:04:24 INFO - 1500545064592 Marionette TRACE 370 <- [1,5,null,{"value":true}]
03:04:24 INFO - 1500545064595 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
03:04:24 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500545064602 Marionette TRACE 370 <- [1,6,null,{"value":null}]
03:04:24 INFO - 1500545064603 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064608 Marionette TRACE 370 <- [1,7,null,{}]
03:04:24 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 808ms
03:04:24 INFO - TEST-START | test_click.py TestClick.test_css_transforms
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064612 Marionette DEBUG Closed connection 370
03:04:24 INFO - 1500545064614 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49814
03:04:24 INFO - 1500545064615 Marionette DEBUG Closed connection 371
03:04:24 INFO - 1500545064616 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49815
03:04:24 INFO - 1500545064618 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:24 INFO - 1500545064621 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:24 INFO - 1500545064643 Marionette DEBUG Register listener.js for window 6442450945
03:04:24 INFO - 1500545064654 Marionette TRACE 372 <- [1,1,null,{"sessionId":"fd6452a9-b21a-4910-b9c3-65e32db04f93","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:24 INFO - 1500545064657 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
03:04:24 INFO - 1500545064658 Marionette TRACE 372 <- [1,2,null,{}]
03:04:24 INFO - 1500545064660 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:24 INFO - 1500545064661 Marionette TRACE 372 <- [1,3,null,{}]
03:04:24 INFO - 1500545064663 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:24 INFO - 1500545064664 Marionette TRACE 372 <- [1,4,null,{}]
03:04:24 INFO - 1500545064667 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
03:04:24 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500545064674 Marionette TRACE 372 <- [1,5,null,{"value":null}]
03:04:24 INFO - 1500545064676 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064680 Marionette TRACE 372 <- [1,6,null,{}]
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064684 Marionette DEBUG Closed connection 372
03:04:24 INFO - 1500545064685 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49816
03:04:24 INFO - 1500545064687 Marionette DEBUG Closed connection 373
03:04:24 INFO - 1500545064688 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49817
03:04:24 INFO - 1500545064690 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:24 INFO - 1500545064692 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:24 INFO - 1500545064714 Marionette DEBUG Register listener.js for window 6442450945
03:04:24 INFO - 1500545064725 Marionette TRACE 374 <- [1,1,null,{"sessionId":"989c7a1e-c29b-4d25-97f5-ee770860e241","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:24 INFO - 1500545064727 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064732 Marionette TRACE 374 <- [1,2,null,{}]
03:04:24 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:24 INFO - 1500545064736 Marionette DEBUG Closed connection 374
03:04:24 INFO - 1500545064737 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49818
03:04:24 INFO - 1500545064739 Marionette DEBUG Closed connection 375
03:04:24 INFO - 1500545064740 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49819
03:04:24 INFO - 1500545064742 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:24 INFO - 1500545064745 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:24 INFO - 1500545064766 Marionette DEBUG Register listener.js for window 6442450945
03:04:24 INFO - 1500545064777 Marionette TRACE 376 <- [1,1,null,{"sessionId":"5efc3d27-6e1b-4119-a9bf-8f821e170be3","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:24 INFO - 1500545064780 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
03:04:24 INFO - 1500545064784 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"
03:04:24 INFO - 1500545064788 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"
03:04:24 INFO - 1500545064789 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"
03:04:24 INFO - ++DOMWINDOW == 22 (000000DCA155E000) [pid = 1456] [serial = 28] [outer = 000000DC95A99800]
03:04:24 INFO - 1500545064812 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"
03:04:24 INFO - 1500545064818 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"
03:04:24 INFO - 1500545064831 Marionette TRACE 376 <- [1,2,null,{}]
03:04:24 INFO - 1500545064845 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
03:04:24 INFO - 1500545064851 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"db9c67be-4c37-45fe-85f0-9d5e3153efc0","ELEMENT":"db9c67be-4c37-45fe-85f0-9d5e3153efc0"}}]
03:04:24 INFO - 1500545064853 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"db9c67be-4c37-45fe-85f0-9d5e3153efc0"}]
03:04:25 INFO - 1500545065273 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:04:25 INFO - 1500545065275 Marionette TRACE 376 <- [1,4,null,{}]
03:04:25 INFO - 1500545065278 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
03:04:25 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500545065285 Marionette TRACE 376 <- [1,5,null,{"value":null}]
03:04:25 INFO - 1500545065287 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
03:04:25 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:25 INFO - 1500545065292 Marionette TRACE 376 <- [1,6,null,{}]
03:04:25 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 685ms
03:04:25 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
03:04:25 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:25 INFO - 1500545065296 Marionette DEBUG Closed connection 376
03:04:25 INFO - 1500545065298 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49820
03:04:25 INFO - 1500545065299 Marionette DEBUG Closed connection 377
03:04:25 INFO - 1500545065301 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49821
03:04:25 INFO - 1500545065303 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:25 INFO - 1500545065305 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:25 INFO - 1500545065778 Marionette DEBUG Register listener.js for window 6442450945
03:04:25 INFO - 1500545065910 Marionette TRACE 378 <- [1,1,null,{"sessionId":"c9a6527b-f5ab-4167-b173-daf9f512ae15","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:25 INFO - 1500545065912 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
03:04:25 INFO - 1500545065914 Marionette TRACE 378 <- [1,2,null,{}]
03:04:25 INFO - 1500545065916 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:25 INFO - 1500545065917 Marionette TRACE 378 <- [1,3,null,{}]
03:04:25 INFO - 1500545065919 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:25 INFO - 1500545065920 Marionette TRACE 378 <- [1,4,null,{}]
03:04:25 INFO - 1500545065923 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
03:04:25 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500545065948 Marionette TRACE 378 <- [1,5,null,{"value":null}]
03:04:25 INFO - 1500545065950 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
03:04:25 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:25 INFO - 1500545065955 Marionette TRACE 378 <- [1,6,null,{}]
03:04:25 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:25 INFO - 1500545065960 Marionette DEBUG Closed connection 378
03:04:25 INFO - 1500545065962 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49822
03:04:25 INFO - 1500545065970 Marionette DEBUG Closed connection 379
03:04:25 INFO - 1500545065971 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49823
03:04:25 INFO - 1500545065974 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:25 INFO - 1500545065977 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:26 INFO - 1500545066006 Marionette DEBUG Register listener.js for window 6442450945
03:04:26 INFO - 1500545066019 Marionette TRACE 380 <- [1,1,null,{"sessionId":"d9b4b776-9c65-4e42-aa6d-36ce84a75a68","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:26 INFO - 1500545066022 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066027 Marionette TRACE 380 <- [1,2,null,{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066031 Marionette DEBUG Closed connection 380
03:04:26 INFO - 1500545066033 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49824
03:04:26 INFO - 1500545066034 Marionette DEBUG Closed connection 381
03:04:26 INFO - 1500545066036 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49825
03:04:26 INFO - 1500545066044 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:26 INFO - 1500545066046 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:26 INFO - 1500545066075 Marionette DEBUG Register listener.js for window 6442450945
03:04:26 INFO - 1500545066085 Marionette TRACE 382 <- [1,1,null,{"sessionId":"a04be124-a564-4ad7-ae55-154f392745d8","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:26 INFO - 1500545066089 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
03:04:26 INFO - 1500545066132 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"
03:04:26 INFO - 1500545066137 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"
03:04:26 INFO - 1500545066137 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"
03:04:26 INFO - ++DOMWINDOW == 23 (000000DCA3326800) [pid = 1456] [serial = 29] [outer = 000000DC95A99800]
03:04:26 INFO - 1500545066160 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"
03:04:26 INFO - 1500545066167 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"
03:04:26 INFO - 1500545066174 Marionette TRACE 382 <- [1,2,null,{}]
03:04:26 INFO - 1500545066181 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
03:04:26 INFO - 1500545066224 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"19de5528-6786-4f2d-bcba-d282168df761","ELEMENT":"19de5528-6786-4f2d-bcba-d282168df761"}}]
03:04:26 INFO - 1500545066226 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"19de5528-6786-4f2d-bcba-d282168df761"}]
03:04:26 INFO - 1500545066668 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:04:26 INFO - 1500545066670 Marionette TRACE 382 <- [1,4,null,{}]
03:04:26 INFO - 1500545066672 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
03:04:26 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500545066680 Marionette TRACE 382 <- [1,5,null,{"value":null}]
03:04:26 INFO - 1500545066682 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
03:04:26 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1392ms
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - TEST-START | test_click.py TestClick.test_input_file
03:04:26 INFO - 1500545066686 Marionette TRACE 382 <- [1,6,null,{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066690 Marionette DEBUG Closed connection 382
03:04:26 INFO - 1500545066692 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49826
03:04:26 INFO - 1500545066693 Marionette DEBUG Closed connection 383
03:04:26 INFO - 1500545066694 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49827
03:04:26 INFO - 1500545066696 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:26 INFO - 1500545066699 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:26 INFO - 1500545066721 Marionette DEBUG Register listener.js for window 6442450945
03:04:26 INFO - 1500545066732 Marionette TRACE 384 <- [1,1,null,{"sessionId":"4887f2ac-49e7-4966-a6e7-a8c3b11c1a64","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:26 INFO - 1500545066735 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
03:04:26 INFO - 1500545066736 Marionette TRACE 384 <- [1,2,null,{}]
03:04:26 INFO - 1500545066738 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:26 INFO - 1500545066739 Marionette TRACE 384 <- [1,3,null,{}]
03:04:26 INFO - 1500545066741 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:26 INFO - 1500545066742 Marionette TRACE 384 <- [1,4,null,{}]
03:04:26 INFO - 1500545066745 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
03:04:26 INFO - TEST-START: test_click.py TestClick.test_input_file1500545066752 Marionette TRACE 384 <- [1,5,null,{"value":null}]
03:04:26 INFO - 1500545066754 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066758 Marionette TRACE 384 <- [1,6,null,{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066762 Marionette DEBUG Closed connection 384
03:04:26 INFO - 1500545066763 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49828
03:04:26 INFO - 1500545066765 Marionette DEBUG Closed connection 385
03:04:26 INFO - 1500545066766 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49829
03:04:26 INFO - 1500545066768 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:26 INFO - 1500545066770 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:26 INFO - 1500545066799 Marionette DEBUG Register listener.js for window 6442450945
03:04:26 INFO - 1500545066810 Marionette TRACE 386 <- [1,1,null,{"sessionId":"6dff006e-5d14-43d0-af91-20ec975e3af7","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:26 INFO - 1500545066812 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066817 Marionette TRACE 386 <- [1,2,null,{}]
03:04:26 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:26 INFO - 1500545066820 Marionette DEBUG Closed connection 386
03:04:26 INFO - 1500545066822 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49830
03:04:26 INFO - 1500545066823 Marionette DEBUG Closed connection 387
03:04:26 INFO - 1500545066825 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49831
03:04:26 INFO - 1500545066827 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:26 INFO - 1500545066829 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:26 INFO - 1500545066851 Marionette DEBUG Register listener.js for window 6442450945
03:04:27 INFO - --DOMWINDOW == 22 (000000DC9B9D5800) [pid = 1456] [serial = 15] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 21 (000000DC97F6F000) [pid = 1456] [serial = 9] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 20 (000000DC9E561000) [pid = 1456] [serial = 10] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 19 (000000DC9EB62000) [pid = 1456] [serial = 12] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 18 (000000DC9E7B0800) [pid = 1456] [serial = 11] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 17 (000000DCA154D000) [pid = 1456] [serial = 13] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 16 (000000DCA0193800) [pid = 1456] [serial = 8] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - --DOMWINDOW == 15 (000000DCA155E800) [pid = 1456] [serial = 14] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
03:04:27 INFO - 1500545067244 Marionette TRACE 388 <- [1,1,null,{"sessionId":"906607f6-c6fc-4ad0-b86b-edca03dc9eed","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:27 INFO - 1500545067253 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
03:04:27 INFO - 1500545067625 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"
03:04:27 INFO - 1500545067629 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"
03:04:27 INFO - 1500545067631 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"
03:04:27 INFO - ++DOMWINDOW == 16 (000000DC97DC2000) [pid = 1456] [serial = 30] [outer = 000000DC95A99800]
03:04:27 INFO - 1500545067653 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:04:27 INFO - 1500545067662 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:04:27 INFO - 1500545067666 Marionette TRACE 388 <- [1,2,null,{}]
03:04:27 INFO - 1500545067680 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
03:04:27 INFO - 1500545067706 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"36428fc5-9f0f-433d-b3b2-c1f5a03e2fab","ELEMENT":"36428fc5-9f0f-433d-b3b2-c1f5a03e2fab"}}]
03:04:27 INFO - 1500545067708 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"36428fc5-9f0f-433d-b3b2-c1f5a03e2fab"}]
03:04:27 INFO - 1500545067865 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:04:27 INFO - 1500545067867 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
03:04:27 INFO - TEST-END: test_click.py TestClick.test_input_file1500545067907 Marionette TRACE 388 <- [1,5,null,{"value":null}]
03:04:27 INFO - 1500545067909 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
03:04:27 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:27 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 1227ms
03:04:27 INFO - 1500545067913 Marionette TRACE 388 <- [1,6,null,{}]
03:04:27 INFO - TEST-START | test_click.py TestClick.test_obscured_element
03:04:27 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:27 INFO - 1500545067918 Marionette DEBUG Closed connection 388
03:04:27 INFO - 1500545067920 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49832
03:04:27 INFO - 1500545067921 Marionette DEBUG Closed connection 389
03:04:27 INFO - 1500545067923 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49833
03:04:27 INFO - 1500545067925 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:27 INFO - 1500545067927 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:27 INFO - 1500545067965 Marionette DEBUG Register listener.js for window 6442450945
03:04:27 INFO - 1500545067989 Marionette TRACE 390 <- [1,1,null,{"sessionId":"73c22d3f-97d7-45ef-93cc-368293b2d1fa","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:27 INFO - 1500545067992 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
03:04:27 INFO - 1500545067993 Marionette TRACE 390 <- [1,2,null,{}]
03:04:27 INFO - 1500545067995 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:28 INFO - 1500545067997 Marionette TRACE 390 <- [1,3,null,{}]
03:04:28 INFO - 1500545067999 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:28 INFO - 1500545068000 Marionette TRACE 390 <- [1,4,null,{}]
03:04:28 INFO - 1500545068003 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
03:04:28 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500545068030 Marionette TRACE 390 <- [1,5,null,{"value":null}]
03:04:28 INFO - 1500545068032 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068037 Marionette TRACE 390 <- [1,6,null,{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068041 Marionette DEBUG Closed connection 390
03:04:28 INFO - 1500545068042 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49834
03:04:28 INFO - 1500545068044 Marionette DEBUG Closed connection 391
03:04:28 INFO - 1500545068045 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49835
03:04:28 INFO - 1500545068049 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:28 INFO - 1500545068051 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:28 INFO - 1500545068086 Marionette DEBUG Register listener.js for window 6442450945
03:04:28 INFO - 1500545068097 Marionette TRACE 392 <- [1,1,null,{"sessionId":"7da07134-2686-441c-8e89-881019713e98","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:28 INFO - 1500545068100 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068104 Marionette TRACE 392 <- [1,2,null,{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068109 Marionette DEBUG Closed connection 392
03:04:28 INFO - 1500545068111 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49836
03:04:28 INFO - 1500545068114 Marionette DEBUG Closed connection 393
03:04:28 INFO - 1500545068115 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49837
03:04:28 INFO - 1500545068118 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:28 INFO - 1500545068120 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:28 INFO - 1500545068153 Marionette DEBUG Register listener.js for window 6442450945
03:04:28 INFO - 1500545068164 Marionette TRACE 394 <- [1,1,null,{"sessionId":"3778177b-8258-4c63-8bd4-0d51efc81a00","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:28 INFO - 1500545068167 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
03:04:28 INFO - 1500545068213 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:04:28 INFO - 1500545068217 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:04:28 INFO - 1500545068217 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
03:04:28 INFO - ++DOMWINDOW == 17 (000000DC9E7B1000) [pid = 1456] [serial = 31] [outer = 000000DC95A99800]
03:04:28 INFO - 1500545068240 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"
03:04:28 INFO - 1500545068246 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"
03:04:28 INFO - 1500545068255 Marionette TRACE 394 <- [1,2,null,{}]
03:04:28 INFO - 1500545068269 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
03:04:28 INFO - 1500545068288 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"11a17e29-f7be-425c-be5d-c202bc08d6a4","ELEMENT":"11a17e29-f7be-425c-be5d-c202bc08d6a4"}}]
03:04:28 INFO - 1500545068290 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
03:04:28 INFO - 1500545068296 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"18d75bb3-6bbc-4eda-b47d-b94ef58bfc63","ELEMENT":"18d75bb3-6bbc-4eda-b47d-b94ef58bfc63"}}]
03:04:28 INFO - 1500545068298 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"11a17e29-f7be-425c-be5d-c202bc08d6a4"}]
03:04:28 INFO - 1500545068722 Marionette DEBUG Canceled page load listener because no navigation has been detected
03:04:28 INFO - 1500545068724 Marionette TRACE 394 <- [1,5,null,{}]
03:04:28 INFO - 1500545068726 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"18d75bb3-6bbc-4eda-b47d-b94ef58bfc63"}]
03:04:28 INFO - 1500545068851 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
03:04:28 INFO - 1500545068853 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
03:04:28 INFO - 1500545068868 Marionette TRACE 394 <- [1,7,null,{"value":false}]
03:04:28 INFO - 1500545068871 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
03:04:28 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500545068878 Marionette TRACE 394 <- [1,8,null,{"value":null}]
03:04:28 INFO - 1500545068880 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
03:04:28 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 970ms
03:04:28 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068884 Marionette TRACE 394 <- [1,9,null,{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068888 Marionette DEBUG Closed connection 394
03:04:28 INFO - 1500545068890 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49838
03:04:28 INFO - 1500545068891 Marionette DEBUG Closed connection 395
03:04:28 INFO - 1500545068893 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49839
03:04:28 INFO - 1500545068895 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:28 INFO - 1500545068897 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:28 INFO - 1500545068920 Marionette DEBUG Register listener.js for window 6442450945
03:04:28 INFO - 1500545068931 Marionette TRACE 396 <- [1,1,null,{"sessionId":"6ed63a86-8c29-46d1-a7db-0b3d1492b29d","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:28 INFO - 1500545068934 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
03:04:28 INFO - 1500545068935 Marionette TRACE 396 <- [1,2,null,{}]
03:04:28 INFO - 1500545068937 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
03:04:28 INFO - 1500545068938 Marionette TRACE 396 <- [1,3,null,{}]
03:04:28 INFO - 1500545068940 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
03:04:28 INFO - 1500545068942 Marionette TRACE 396 <- [1,4,null,{}]
03:04:28 INFO - 1500545068944 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
03:04:28 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500545068951 Marionette TRACE 396 <- [1,5,null,{"value":null}]
03:04:28 INFO - 1500545068953 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068957 Marionette TRACE 396 <- [1,6,null,{}]
03:04:28 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:28 INFO - 1500545068961 Marionette DEBUG Closed connection 396
03:04:28 INFO - 1500545068963 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49840
03:04:28 INFO - 1500545068964 Marionette DEBUG Closed connection 397
03:04:28 INFO - 1500545068965 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49841
03:04:28 INFO - 1500545068967 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
03:04:28 INFO - 1500545068969 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:28 INFO - 1500545068992 Marionette DEBUG Register listener.js for window 6442450945
03:04:29 INFO - 1500545069003 Marionette TRACE 398 <- [1,1,null,{"sessionId":"44d5844e-01fc-425d-847c-39ca76b4ad88","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:29 INFO - 1500545069006 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
03:04:29 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:29 INFO - 1500545069010 Marionette TRACE 398 <- [1,2,null,{}]
03:04:29 INFO - [Parent 2500] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
03:04:29 INFO - 1500545069014 Marionette DEBUG Closed connection 398
03:04:29 INFO - 1500545069015 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49842
03:04:29 INFO - 1500545069017 Marionette DEBUG Closed connection 399
03:04:29 INFO - 1500545069018 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49843
03:04:29 INFO - 1500545069020 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
03:04:29 INFO - 1500545069022 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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}
03:04:29 INFO - 1500545069045 Marionette DEBUG Register listener.js for window 6442450945
03:04:29 INFO - 1500545069056 Marionette TRACE 400 <- [1,1,null,{"sessionId":"e6f8e4c4-1606-4bce-b1cb-e47c324212b3","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":2500,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-039.001\\AppData\\Local\\Temp\\tmpiz81dl.mozrunner","moz:accessibilityChecks":false}}]
03:04:29 INFO - 1500545069059 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
03:04:29 INFO - 1500545069063 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"
03:04:29 INFO - 1500545069068 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"
03:04:29 INFO - 1500545069069 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"
03:04:29 INFO - ++DOMWINDOW == 18 (000000DCA15E5800) [pid = 1456] [serial = 32] [outer = 000000DC95A99800]
03:04:29 INFO - 1500545069091 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"
03:04:29 INFO - 1500545069097 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"
03:04:29 INFO - 1500545069105 Marionette TRACE 400 <- [1,2,null,{}]
03:04:29 INFO - 1500545069117 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
03:04:29 INFO - 1500545069138 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"109172cc-a7c1-495a-8c12-7a001d685a81","ELEMENT":"109172cc-a7c1-495a-8c12-7a001d685a81"}}]
03:04:29 INFO - 1500545069140 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"109172cc-a7c1-495a-8c12-7a001d685a81"}]
03:04:29 INFO - 1500545069274 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
03:04:29 INFO - 1500545069276 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"109172cc-a7c1-495a-8c12-7a001d685a81"}]
03:04:29 INFO - 1500545069406 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element