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]
10:43:27 INFO - 1500054207067 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:43:27 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500054207074 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:43:27 INFO - 1500054207076 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207080 Marionette TRACE 352 <- [1,6,null,{}]
10:43:27 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1695ms
10:43:27 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207086 Marionette DEBUG Closed connection 352
10:43:27 INFO - 1500054207088 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49798
10:43:27 INFO - 1500054207089 Marionette DEBUG Closed connection 353
10:43:27 INFO - 1500054207091 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49799
10:43:27 INFO - 1500054207093 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:27 INFO - 1500054207095 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:27 INFO - 1500054207120 Marionette DEBUG Register listener.js for window 15
10:43:27 INFO - 1500054207131 Marionette TRACE 354 <- [1,1,null,{"sessionId":"637b8b08-1676-4233-b8ac-a97503cad655","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:27 INFO - 1500054207174 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:43:27 INFO - 1500054207175 Marionette TRACE 354 <- [1,2,null,{}]
10:43:27 INFO - 1500054207181 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:27 INFO - 1500054207182 Marionette TRACE 354 <- [1,3,null,{}]
10:43:27 INFO - 1500054207201 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:27 INFO - 1500054207206 Marionette TRACE 354 <- [1,4,null,{}]
10:43:27 INFO - 1500054207212 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:43:27 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500054207226 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:43:27 INFO - 1500054207232 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207242 Marionette TRACE 354 <- [1,6,null,{}]
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207254 Marionette DEBUG Closed connection 354
10:43:27 INFO - 1500054207256 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49800
10:43:27 INFO - 1500054207260 Marionette DEBUG Closed connection 355
10:43:27 INFO - 1500054207262 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49801
10:43:27 INFO - 1500054207269 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:27 INFO - 1500054207280 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:27 INFO - 1500054207328 Marionette DEBUG Register listener.js for window 15
10:43:27 INFO - 1500054207360 Marionette TRACE 356 <- [1,1,null,{"sessionId":"e0ebd7df-d794-453f-b4a5-a3cdbf44db5c","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:27 INFO - 1500054207395 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207402 Marionette TRACE 356 <- [1,2,null,{}]
10:43:27 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:27 INFO - 1500054207462 Marionette DEBUG Closed connection 356
10:43:27 INFO - 1500054207465 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49802
10:43:27 INFO - 1500054207486 Marionette DEBUG Closed connection 357
10:43:27 INFO - 1500054207488 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49803
10:43:27 INFO - 1500054207493 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:27 INFO - 1500054207499 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:27 INFO - 1500054207548 Marionette DEBUG Register listener.js for window 15
10:43:27 INFO - 1500054207580 Marionette TRACE 358 <- [1,1,null,{"sessionId":"aba11ad5-4393-474b-923c-280ac1e3480a","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:27 INFO - 1500054207604 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
10:43:27 INFO - 1500054207611 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
10:43:27 INFO - 1500054207629 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
10:43:27 INFO - 1500054207630 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
10:43:27 INFO - ++DOMWINDOW == 29 (00000030D62B8800) [pid = 3012] [serial = 40] [outer = 00000030E14D9000]
10:43:27 INFO - 1500054207710 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
10:43:27 INFO - 1500054207718 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
10:43:27 INFO - 1500054207743 Marionette TRACE 358 <- [1,2,null,{}]
10:43:27 INFO - 1500054207763 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:43:27 INFO - 1500054207773 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4342e180-7047-4dc6-82ba-3f630c0f0af1","ELEMENT":"4342e180-7047-4dc6-82ba-3f630c0f0af1"}}]
10:43:27 INFO - 1500054207776 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"4342e180-7047-4dc6-82ba-3f630c0f0af1"}]
10:43:28 INFO - 1500054208185 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
10:43:28 INFO - [Parent 3012] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
10:43:28 INFO - 1500054208199 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
10:43:28 INFO - 1500054208201 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
10:43:28 INFO - ++DOMWINDOW == 30 (00000030DB511000) [pid = 3012] [serial = 41] [outer = 00000030E14D9000]
10:43:28 INFO - 1500054208278 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
10:43:28 INFO - 1500054208284 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
10:43:28 INFO - 1500054208305 Marionette TRACE 358 <- [1,4,null,{}]
10:43:28 INFO - 1500054208308 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:43:28 INFO - 1500054208322 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"14bad40f-7120-4f6c-973d-342ac98c03bd","ELEMENT":"14bad40f-7120-4f6c-973d-342ac98c03bd"}}]
10:43:28 INFO - 1500054208327 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:43:28 INFO - 1500054208333 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:43:28 INFO - 1500054208349 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:43:28 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500054208360 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:43:28 INFO - 1500054208408 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208415 Marionette TRACE 358 <- [1,8,null,{}]
10:43:28 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1334ms
10:43:28 INFO - TEST-START | test_click.py TestClick.test_container_element
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208424 Marionette DEBUG Closed connection 358
10:43:28 INFO - 1500054208426 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49806
10:43:28 INFO - 1500054208429 Marionette DEBUG Closed connection 359
10:43:28 INFO - 1500054208431 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49807
10:43:28 INFO - 1500054208434 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:28 INFO - 1500054208438 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - 1500054208486 Marionette DEBUG Register listener.js for window 15
10:43:28 INFO - 1500054208536 Marionette TRACE 360 <- [1,1,null,{"sessionId":"9c281d83-b51a-4715-83cb-e55a31744124","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500054208545 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:43:28 INFO - 1500054208548 Marionette TRACE 360 <- [1,2,null,{}]
10:43:28 INFO - 1500054208573 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:28 INFO - 1500054208575 Marionette TRACE 360 <- [1,3,null,{}]
10:43:28 INFO - 1500054208636 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:28 INFO - 1500054208639 Marionette TRACE 360 <- [1,4,null,{}]
10:43:28 INFO - 1500054208645 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:43:28 INFO - TEST-START: test_click.py TestClick.test_container_element1500054208655 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:43:28 INFO - 1500054208707 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208713 Marionette TRACE 360 <- [1,6,null,{}]
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208738 Marionette DEBUG Closed connection 360
10:43:28 INFO - 1500054208741 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49808
10:43:28 INFO - 1500054208745 Marionette DEBUG Closed connection 361
10:43:28 INFO - 1500054208748 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49809
10:43:28 INFO - 1500054208751 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:28 INFO - 1500054208755 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - 1500054208805 Marionette DEBUG Register listener.js for window 15
10:43:28 INFO - 1500054208823 Marionette TRACE 362 <- [1,1,null,{"sessionId":"341bc306-ccb2-42b4-99f3-dc6a8bf49da3","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500054208842 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208848 Marionette TRACE 362 <- [1,2,null,{}]
10:43:28 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500054208855 Marionette DEBUG Closed connection 362
10:43:28 INFO - 1500054208857 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49810
10:43:28 INFO - 1500054208859 Marionette DEBUG Closed connection 363
10:43:28 INFO - 1500054208861 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49811
10:43:28 INFO - 1500054208864 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:28 INFO - 1500054208871 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - 1500054208920 Marionette DEBUG Register listener.js for window 15
10:43:28 INFO - 1500054208936 Marionette TRACE 364 <- [1,1,null,{"sessionId":"877d07c8-c0eb-4877-946a-17de0ef60f07","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500054208980 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:28 INFO - 1500054208986 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
10:43:28 INFO - 1500054208994 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
10:43:28 INFO - 1500054208995 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
10:43:28 INFO - ++DOMWINDOW == 31 (00000030E1943000) [pid = 3012] [serial = 42] [outer = 00000030E14D9000]
10:43:29 INFO - 1500054209064 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:29 INFO - 1500054209071 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:29 INFO - 1500054209090 Marionette TRACE 364 <- [1,2,null,{}]
10:43:29 INFO - 1500054209093 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:43:29 INFO - 1500054209104 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"08a5383d-8305-453b-b0cd-540be35d621c","ELEMENT":"08a5383d-8305-453b-b0cd-540be35d621c"}}]
10:43:29 INFO - 1500054209112 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"08a5383d-8305-453b-b0cd-540be35d621c"}]
10:43:29 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:43:29 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:43:29 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:43:29 INFO - 1500054209722 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:29 INFO - 1500054209724 Marionette TRACE 364 <- [1,4,null,{}]
10:43:29 INFO - 1500054209906 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"08a5383d-8305-453b-b0cd-540be35d621c","name":"selected"}]
10:43:29 INFO - 1500054209951 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:43:29 INFO - 1500054209962 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:43:29 INFO - TEST-END: test_click.py TestClick.test_container_element1500054209977 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:43:29 INFO - 1500054209980 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:43:29 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500054209991 Marionette TRACE 364 <- [1,7,null,{}]
10:43:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1593ms
10:43:30 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500054210021 Marionette DEBUG Closed connection 364
10:43:30 INFO - 1500054210024 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49812
10:43:30 INFO - 1500054210046 Marionette DEBUG Closed connection 365
10:43:30 INFO - 1500054210049 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49813
10:43:30 INFO - 1500054210066 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500054210080 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500054210110 Marionette DEBUG Register listener.js for window 15
10:43:30 INFO - 1500054210131 Marionette TRACE 366 <- [1,1,null,{"sessionId":"ad678283-3a0b-46d4-b6fc-9d98939f041c","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500054210148 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:43:30 INFO - 1500054210151 Marionette TRACE 366 <- [1,2,null,{}]
10:43:30 INFO - 1500054210200 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:30 INFO - 1500054210203 Marionette TRACE 366 <- [1,3,null,{}]
10:43:30 INFO - 1500054210209 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:30 INFO - 1500054210212 Marionette TRACE 366 <- [1,4,null,{}]
10:43:30 INFO - 1500054210216 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:43:30 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500054210227 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:43:30 INFO - 1500054210270 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500054210276 Marionette TRACE 366 <- [1,6,null,{}]
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500054210287 Marionette DEBUG Closed connection 366
10:43:30 INFO - 1500054210290 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49814
10:43:30 INFO - 1500054210314 Marionette DEBUG Closed connection 367
10:43:30 INFO - 1500054210316 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49815
10:43:30 INFO - 1500054210320 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500054210324 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500054210352 Marionette DEBUG Register listener.js for window 15
10:43:30 INFO - 1500054210368 Marionette TRACE 368 <- [1,1,null,{"sessionId":"35904b57-a1e2-44db-9ac7-b15f2be7ee1e","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500054210385 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500054210394 Marionette TRACE 368 <- [1,2,null,{}]
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500054210404 Marionette DEBUG Closed connection 368
10:43:30 INFO - 1500054210406 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49816
10:43:30 INFO - 1500054210428 Marionette DEBUG Closed connection 369
10:43:30 INFO - 1500054210430 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49817
10:43:30 INFO - 1500054210434 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:30 INFO - 1500054210437 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500054210465 Marionette DEBUG Register listener.js for window 15
10:43:30 INFO - 1500054210479 Marionette TRACE 370 <- [1,1,null,{"sessionId":"00fc4850-c533-4688-a553-964edad759f9","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500054210494 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:30 INFO - 1500054210499 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500054210509 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500054210510 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - ++DOMWINDOW == 32 (00000030D4B8B800) [pid = 3012] [serial = 43] [outer = 00000030E14D9000]
10:43:30 INFO - 1500054210571 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500054210578 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500054210599 Marionette TRACE 370 <- [1,2,null,{}]
10:43:30 INFO - --DOMWINDOW == 31 (00000030E8D82800) [pid = 3012] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 30 (00000030E1049800) [pid = 3012] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 29 (00000030DF211800) [pid = 3012] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 28 (00000030D477F800) [pid = 3012] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 27 (00000030D6B67800) [pid = 3012] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 26 (00000030D8E5D800) [pid = 3012] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 25 (00000030D8E5D000) [pid = 3012] [serial = 21] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - --DOMWINDOW == 24 (00000030EA0A8000) [pid = 3012] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:43:30 INFO - 1500054210615 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:43:30 INFO - 1500054210626 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"84668560-b23d-45e9-9e5b-2066c17334d1","ELEMENT":"84668560-b23d-45e9-9e5b-2066c17334d1"}}]
10:43:30 INFO - 1500054210628 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"84668560-b23d-45e9-9e5b-2066c17334d1"}]
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:43:30 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:43:31 INFO - 1500054211777 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:31 INFO - 1500054211801 Marionette TRACE 370 <- [1,4,null,{}]
10:43:31 INFO - 1500054211806 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"84668560-b23d-45e9-9e5b-2066c17334d1","name":"selected"}]
10:43:31 INFO - 1500054211838 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:43:31 INFO - 1500054211841 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:43:31 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500054211894 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:43:31 INFO - 1500054211942 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:43:31 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500054211947 Marionette TRACE 370 <- [1,7,null,{}]
10:43:31 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1937ms
10:43:31 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:43:32 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500054212003 Marionette DEBUG Closed connection 370
10:43:32 INFO - 1500054212005 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49818
10:43:32 INFO - 1500054212056 Marionette DEBUG Closed connection 371
10:43:32 INFO - 1500054212059 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49819
10:43:32 INFO - 1500054212062 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:32 INFO - 1500054212064 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500054212092 Marionette DEBUG Register listener.js for window 15
10:43:32 INFO - 1500054212119 Marionette TRACE 372 <- [1,1,null,{"sessionId":"2f4b1a4d-e8d0-4402-8c31-713fbc702a07","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500054212219 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:43:32 INFO - 1500054212221 Marionette TRACE 372 <- [1,2,null,{}]
10:43:32 INFO - 1500054212243 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:32 INFO - 1500054212245 Marionette TRACE 372 <- [1,3,null,{}]
10:43:32 INFO - 1500054212247 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:32 INFO - 1500054212248 Marionette TRACE 372 <- [1,4,null,{}]
10:43:32 INFO - 1500054212252 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:43:32 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500054212261 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:43:32 INFO - 1500054212264 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:43:32 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500054212269 Marionette TRACE 372 <- [1,6,null,{}]
10:43:32 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500054212291 Marionette DEBUG Closed connection 372
10:43:32 INFO - 1500054212293 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49820
10:43:32 INFO - 1500054212297 Marionette DEBUG Closed connection 373
10:43:32 INFO - 1500054212299 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49821
10:43:32 INFO - 1500054212301 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:32 INFO - 1500054212306 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500054212333 Marionette DEBUG Register listener.js for window 15
10:43:32 INFO - 1500054212348 Marionette TRACE 374 <- [1,1,null,{"sessionId":"57c8ac0b-418c-44c2-a891-3e8ac9b0898a","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500054212359 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:43:32 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500054212364 Marionette TRACE 374 <- [1,2,null,{}]
10:43:32 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500054212388 Marionette DEBUG Closed connection 374
10:43:32 INFO - 1500054212393 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49822
10:43:32 INFO - 1500054212398 Marionette DEBUG Closed connection 375
10:43:32 INFO - 1500054212400 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49823
10:43:32 INFO - 1500054212403 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:32 INFO - 1500054212406 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500054212434 Marionette DEBUG Register listener.js for window 15
10:43:32 INFO - 1500054212448 Marionette TRACE 376 <- [1,1,null,{"sessionId":"cdc99c22-971b-473a-b70e-7fb9b955f355","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500054212459 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:43:32 INFO - 1500054212464 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - 1500054212472 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - 1500054212473 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - ++DOMWINDOW == 25 (00000030DB216800) [pid = 3012] [serial = 44] [outer = 00000030E14D9000]
10:43:32 INFO - 1500054212535 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:32 INFO - 1500054212541 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:32 INFO - 1500054212571 Marionette TRACE 376 <- [1,2,null,{}]
10:43:32 INFO - 1500054212575 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:43:32 INFO - 1500054212587 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7b714741-2965-4eb4-9bf8-723f1f78d93d","ELEMENT":"7b714741-2965-4eb4-9bf8-723f1f78d93d"}}]
10:43:32 INFO - 1500054212589 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"7b714741-2965-4eb4-9bf8-723f1f78d93d"}]
10:43:33 INFO - 1500054213077 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:33 INFO - 1500054213079 Marionette TRACE 376 <- [1,4,null,{}]
10:43:33 INFO - 1500054213082 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:43:33 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500054213090 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:43:33 INFO - 1500054213092 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213097 Marionette TRACE 376 <- [1,6,null,{}]
10:43:33 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1149ms
10:43:33 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213103 Marionette DEBUG Closed connection 376
10:43:33 INFO - 1500054213104 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49824
10:43:33 INFO - 1500054213106 Marionette DEBUG Closed connection 377
10:43:33 INFO - 1500054213107 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49825
10:43:33 INFO - 1500054213110 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:33 INFO - 1500054213112 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500054213138 Marionette DEBUG Register listener.js for window 15
10:43:33 INFO - 1500054213174 Marionette TRACE 378 <- [1,1,null,{"sessionId":"8b0c43eb-ae3c-4b57-b366-bf348618db86","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500054213183 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:43:33 INFO - 1500054213185 Marionette TRACE 378 <- [1,2,null,{}]
10:43:33 INFO - 1500054213187 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:33 INFO - 1500054213189 Marionette TRACE 378 <- [1,3,null,{}]
10:43:33 INFO - 1500054213191 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:33 INFO - 1500054213192 Marionette TRACE 378 <- [1,4,null,{}]
10:43:33 INFO - 1500054213195 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:43:33 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500054213204 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:43:33 INFO - 1500054213206 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213211 Marionette TRACE 378 <- [1,6,null,{}]
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213217 Marionette DEBUG Closed connection 378
10:43:33 INFO - 1500054213218 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49826
10:43:33 INFO - 1500054213220 Marionette DEBUG Closed connection 379
10:43:33 INFO - 1500054213223 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49827
10:43:33 INFO - 1500054213225 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:33 INFO - 1500054213228 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500054213254 Marionette DEBUG Register listener.js for window 15
10:43:33 INFO - 1500054213266 Marionette TRACE 380 <- [1,1,null,{"sessionId":"c44c3044-aa0e-4e17-8adc-314a56d38042","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500054213272 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213276 Marionette TRACE 380 <- [1,2,null,{}]
10:43:33 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500054213282 Marionette DEBUG Closed connection 380
10:43:33 INFO - 1500054213284 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49828
10:43:33 INFO - 1500054213285 Marionette DEBUG Closed connection 381
10:43:33 INFO - 1500054213287 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49829
10:43:33 INFO - 1500054213289 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:33 INFO - 1500054213292 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500054213319 Marionette DEBUG Register listener.js for window 15
10:43:33 INFO - 1500054213331 Marionette TRACE 382 <- [1,1,null,{"sessionId":"9134316e-8271-43f3-a3fb-ae34a57781cf","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500054213337 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:33 INFO - 1500054213341 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:33 INFO - 1500054213348 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:33 INFO - 1500054213349 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:33 INFO - ++DOMWINDOW == 26 (00000030DB7BB000) [pid = 3012] [serial = 45] [outer = 00000030E14D9000]
10:43:33 INFO - 1500054213407 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:33 INFO - 1500054213413 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:33 INFO - 1500054213430 Marionette TRACE 382 <- [1,2,null,{}]
10:43:33 INFO - 1500054213433 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:43:33 INFO - 1500054213441 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1fe2c096-213c-4aa2-a48d-397939d589a6","ELEMENT":"1fe2c096-213c-4aa2-a48d-397939d589a6"}}]
10:43:33 INFO - 1500054213444 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"1fe2c096-213c-4aa2-a48d-397939d589a6"}]
10:43:33 INFO - 1500054213992 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:33 INFO - 1500054213994 Marionette TRACE 382 <- [1,4,null,{}]
10:43:34 INFO - 1500054213997 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:43:34 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500054214006 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:43:34 INFO - 1500054214008 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214012 Marionette TRACE 382 <- [1,6,null,{}]
10:43:34 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 914ms
10:43:34 INFO - TEST-START | test_click.py TestClick.test_input_file
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214018 Marionette DEBUG Closed connection 382
10:43:34 INFO - 1500054214020 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49830
10:43:34 INFO - 1500054214021 Marionette DEBUG Closed connection 383
10:43:34 INFO - 1500054214023 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49831
10:43:34 INFO - 1500054214025 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:34 INFO - 1500054214027 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214054 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214066 Marionette TRACE 384 <- [1,1,null,{"sessionId":"b21c11cd-019a-40b5-8c9b-c0b4ab19e51e","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214097 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:43:34 INFO - 1500054214098 Marionette TRACE 384 <- [1,2,null,{}]
10:43:34 INFO - 1500054214101 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:34 INFO - 1500054214103 Marionette TRACE 384 <- [1,3,null,{}]
10:43:34 INFO - 1500054214104 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:34 INFO - 1500054214106 Marionette TRACE 384 <- [1,4,null,{}]
10:43:34 INFO - 1500054214110 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:43:34 INFO - TEST-START: test_click.py TestClick.test_input_file1500054214118 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:43:34 INFO - 1500054214120 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214124 Marionette TRACE 384 <- [1,6,null,{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214149 Marionette DEBUG Closed connection 384
10:43:34 INFO - 1500054214150 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49832
10:43:34 INFO - 1500054214152 Marionette DEBUG Closed connection 385
10:43:34 INFO - 1500054214153 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49833
10:43:34 INFO - 1500054214155 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:34 INFO - 1500054214159 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214190 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214204 Marionette TRACE 386 <- [1,1,null,{"sessionId":"d2ac2ddf-dfd7-4404-9db4-d3974f9d4976","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214216 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214220 Marionette TRACE 386 <- [1,2,null,{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214227 Marionette DEBUG Closed connection 386
10:43:34 INFO - 1500054214228 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49834
10:43:34 INFO - 1500054214230 Marionette DEBUG Closed connection 387
10:43:34 INFO - 1500054214231 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49835
10:43:34 INFO - 1500054214234 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:34 INFO - 1500054214236 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214263 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214274 Marionette TRACE 388 <- [1,1,null,{"sessionId":"15981277-4ff6-419e-a7dc-4ede010c071c","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214281 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:43:34 INFO - 1500054214285 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:34 INFO - 1500054214294 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:34 INFO - 1500054214296 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:34 INFO - ++DOMWINDOW == 27 (00000030DB974800) [pid = 3012] [serial = 46] [outer = 00000030E14D9000]
10:43:34 INFO - 1500054214353 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:34 INFO - 1500054214359 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:34 INFO - 1500054214377 Marionette TRACE 388 <- [1,2,null,{}]
10:43:34 INFO - 1500054214408 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:43:34 INFO - 1500054214416 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1b220d67-4057-44ad-a3af-05168a689c26","ELEMENT":"1b220d67-4057-44ad-a3af-05168a689c26"}}]
10:43:34 INFO - 1500054214418 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"1b220d67-4057-44ad-a3af-05168a689c26"}]
10:43:34 INFO - 1500054214588 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]
10:43:34 INFO - 1500054214603 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:43:34 INFO - TEST-END: test_click.py TestClick.test_input_file1500054214611 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:43:34 INFO - 1500054214613 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214617 Marionette TRACE 388 <- [1,6,null,{}]
10:43:34 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 604ms
10:43:34 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214623 Marionette DEBUG Closed connection 388
10:43:34 INFO - 1500054214625 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49836
10:43:34 INFO - 1500054214626 Marionette DEBUG Closed connection 389
10:43:34 INFO - 1500054214628 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49837
10:43:34 INFO - 1500054214630 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:34 INFO - 1500054214632 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214659 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214694 Marionette TRACE 390 <- [1,1,null,{"sessionId":"c6bf3664-dfe0-4c74-8d68-2635ab42f3a7","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214700 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:43:34 INFO - 1500054214702 Marionette TRACE 390 <- [1,2,null,{}]
10:43:34 INFO - 1500054214703 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:34 INFO - 1500054214705 Marionette TRACE 390 <- [1,3,null,{}]
10:43:34 INFO - 1500054214707 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:34 INFO - 1500054214708 Marionette TRACE 390 <- [1,4,null,{}]
10:43:34 INFO - 1500054214711 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:43:34 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500054214718 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:43:34 INFO - 1500054214720 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214724 Marionette TRACE 390 <- [1,6,null,{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214730 Marionette DEBUG Closed connection 390
10:43:34 INFO - 1500054214732 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49838
10:43:34 INFO - 1500054214733 Marionette DEBUG Closed connection 391
10:43:34 INFO - 1500054214735 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49839
10:43:34 INFO - 1500054214737 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:34 INFO - 1500054214739 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214766 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214777 Marionette TRACE 392 <- [1,1,null,{"sessionId":"7af8461c-d73e-42c2-8693-883992286c06","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214808 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214812 Marionette TRACE 392 <- [1,2,null,{}]
10:43:34 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500054214818 Marionette DEBUG Closed connection 392
10:43:34 INFO - 1500054214820 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49840
10:43:34 INFO - 1500054214821 Marionette DEBUG Closed connection 393
10:43:34 INFO - 1500054214823 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49841
10:43:34 INFO - 1500054214847 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:34 INFO - 1500054214849 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500054214878 Marionette DEBUG Register listener.js for window 15
10:43:34 INFO - 1500054214889 Marionette TRACE 394 <- [1,1,null,{"sessionId":"741b6451-0e67-4c6f-b8df-0f19f4ac99c0","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500054214899 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:43:34 INFO - 1500054214903 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:34 INFO - 1500054214910 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:34 INFO - 1500054214911 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:34 INFO - ++DOMWINDOW == 28 (00000030DCDB8800) [pid = 3012] [serial = 47] [outer = 00000030E14D9000]
10:43:34 INFO - 1500054214968 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:34 INFO - 1500054214975 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:34 INFO - 1500054214990 Marionette TRACE 394 <- [1,2,null,{}]
10:43:34 INFO - 1500054214993 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:43:35 INFO - 1500054215002 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bdf8c448-be86-48d5-966d-d312cf42542f","ELEMENT":"bdf8c448-be86-48d5-966d-d312cf42542f"}}]
10:43:35 INFO - 1500054215004 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:43:35 INFO - 1500054215011 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0e85681f-e4d0-4437-ba39-99328e541095","ELEMENT":"0e85681f-e4d0-4437-ba39-99328e541095"}}]
10:43:35 INFO - 1500054215013 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"bdf8c448-be86-48d5-966d-d312cf42542f"}]
10:43:36 INFO - 1500054216097 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:36 INFO - 1500054216102 Marionette TRACE 394 <- [1,5,null,{}]
10:43:36 INFO - 1500054216108 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"0e85681f-e4d0-4437-ba39-99328e541095"}]
10:43:36 INFO - 1500054216426 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]
10:43:36 INFO - 1500054216454 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:43:36 INFO - 1500054216469 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:43:36 INFO - 1500054216474 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:43:36 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500054216487 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:43:36 INFO - 1500054216521 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:43:36 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:36 INFO - 1500054216530 Marionette TRACE 394 <- [1,9,null,{}]
10:43:36 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1913ms
10:43:36 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:43:36 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:36 INFO - 1500054216558 Marionette DEBUG Closed connection 394
10:43:36 INFO - 1500054216562 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49842
10:43:36 INFO - 1500054216569 Marionette DEBUG Closed connection 395
10:43:36 INFO - 1500054216572 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49843
10:43:36 INFO - 1500054216625 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:36 INFO - 1500054216634 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:36 INFO - 1500054216687 Marionette DEBUG Register listener.js for window 15
10:43:36 INFO - 1500054216708 Marionette TRACE 396 <- [1,1,null,{"sessionId":"9958f894-f699-4125-a3f9-01b38421f954","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:36 INFO - 1500054216726 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:43:36 INFO - 1500054216729 Marionette TRACE 396 <- [1,2,null,{}]
10:43:36 INFO - 1500054216781 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:36 INFO - 1500054216784 Marionette TRACE 396 <- [1,3,null,{}]
10:43:36 INFO - 1500054216787 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:36 INFO - 1500054216790 Marionette TRACE 396 <- [1,4,null,{}]
10:43:36 INFO - 1500054216795 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:43:36 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500054216807 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:43:36 INFO - 1500054216859 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:43:36 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:36 INFO - 1500054216866 Marionette TRACE 396 <- [1,6,null,{}]
10:43:36 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:36 INFO - 1500054216893 Marionette DEBUG Closed connection 396
10:43:36 INFO - 1500054216896 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49844
10:43:36 INFO - 1500054216901 Marionette DEBUG Closed connection 397
10:43:36 INFO - 1500054216904 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49845
10:43:36 INFO - 1500054216942 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:36 INFO - 1500054216948 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:37 INFO - 1500054217003 Marionette DEBUG Register listener.js for window 15
10:43:37 INFO - 1500054217020 Marionette TRACE 398 <- [1,1,null,{"sessionId":"e7b7cb48-02c9-4754-9124-046da190e5d5","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:37 INFO - 1500054217033 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:43:37 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:37 INFO - 1500054217040 Marionette TRACE 398 <- [1,2,null,{}]
10:43:37 INFO - [Parent 3012] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:37 INFO - 1500054217217 Marionette DEBUG Closed connection 398
10:43:37 INFO - 1500054217220 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49846
10:43:37 INFO - 1500054217249 Marionette DEBUG Closed connection 399
10:43:37 INFO - 1500054217252 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49847
10:43:37 INFO - 1500054217318 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:37 INFO - 1500054217328 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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}
10:43:37 INFO - 1500054217361 Marionette DEBUG Register listener.js for window 15
10:43:37 INFO - 1500054217381 Marionette TRACE 400 <- [1,1,null,{"sessionId":"72c465c6-8cff-4b1b-86c4-4eb7b488f132","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":3012,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-277.001\\AppData\\Local\\Temp\\tmpu4or1n.mozrunner","moz:accessibilityChecks":false}}]
10:43:37 INFO - 1500054217403 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:43:37 INFO - 1500054217414 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:37 INFO - 1500054217426 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:37 INFO - 1500054217428 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:37 INFO - ++DOMWINDOW == 29 (00000030D92A1000) [pid = 3012] [serial = 48] [outer = 00000030E14D9000]
10:43:37 INFO - 1500054217524 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:43:37 INFO - 1500054217532 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:43:37 INFO - 1500054217551 Marionette TRACE 400 <- [1,2,null,{}]
10:43:37 INFO - 1500054217577 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:43:37 INFO - 1500054217591 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3d9b98af-dcaf-4663-aed7-3f3b5a692721","ELEMENT":"3d9b98af-dcaf-4663-aed7-3f3b5a692721"}}]
10:43:37 INFO - 1500054217607 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"3d9b98af-dcaf-4663-aed7-3f3b5a692721"}]
10:43:37 INFO - 1500054217764 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:43:37 INFO - 1500054217768 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"3d9b98af-dcaf-4663-aed7-3f3b5a692721"}]
10:43:37 INFO - 1500054217968 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element