could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
16:06:18 INFO - 1500937578977 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}]
16:06:18 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500937578985 Marionette TRACE 352 <- [1,5,null,{"value":null}]
16:06:18 INFO - 1500937578988 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
16:06:18 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:18 INFO - 1500937578992 Marionette TRACE 352 <- [1,6,null,{}]
16:06:18 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 628ms
16:06:18 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
16:06:19 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:19 INFO - 1500937579022 Marionette DEBUG Closed connection 352
16:06:19 INFO - 1500937579023 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49779
16:06:19 INFO - 1500937579027 Marionette DEBUG Closed connection 353
16:06:19 INFO - 1500937579029 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49780
16:06:19 INFO - 1500937579846 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:19 INFO - 1500937579848 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:19 INFO - 1500937579869 Marionette DEBUG Register listener.js for window 12
16:06:19 INFO - 1500937579880 Marionette TRACE 354 <- [1,1,null,{"sessionId":"168832ea-1fb8-4e2c-8e9b-74e2cc85785e","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:19 INFO - 1500937579929 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
16:06:19 INFO - 1500937579931 Marionette TRACE 354 <- [1,2,null,{}]
16:06:19 INFO - 1500937579983 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:19 INFO - 1500937579985 Marionette TRACE 354 <- [1,3,null,{}]
16:06:20 INFO - 1500937580037 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:20 INFO - 1500937580038 Marionette TRACE 354 <- [1,4,null,{}]
16:06:20 INFO - 1500937580041 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}]
16:06:20 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500937580049 Marionette TRACE 354 <- [1,5,null,{"value":null}]
16:06:20 INFO - 1500937580101 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
16:06:20 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:20 INFO - 1500937580106 Marionette TRACE 354 <- [1,6,null,{}]
16:06:20 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:20 INFO - 1500937580142 Marionette DEBUG Closed connection 354
16:06:20 INFO - 1500937580143 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49781
16:06:20 INFO - 1500937580168 Marionette DEBUG Closed connection 355
16:06:20 INFO - 1500937580169 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49782
16:06:20 INFO - 1500937580172 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:20 INFO - 1500937580174 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:20 INFO - 1500937580196 Marionette DEBUG Register listener.js for window 12
16:06:20 INFO - 1500937580207 Marionette TRACE 356 <- [1,1,null,{"sessionId":"502202e1-3c6c-45f4-b281-8d281164ae61","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:20 INFO - 1500937580218 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
16:06:20 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:20 INFO - 1500937580222 Marionette TRACE 356 <- [1,2,null,{}]
16:06:20 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:20 INFO - 1500937580277 Marionette DEBUG Closed connection 356
16:06:20 INFO - 1500937580280 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49783
16:06:20 INFO - 1500937580304 Marionette DEBUG Closed connection 357
16:06:20 INFO - 1500937580308 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49784
16:06:20 INFO - 1500937580313 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:20 INFO - 1500937580324 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:20 INFO - 1500937580369 Marionette DEBUG Register listener.js for window 12
16:06:20 INFO - 1500937580392 Marionette TRACE 358 <- [1,1,null,{"sessionId":"ff8f66d0-a132-4d9d-ba12-b8db58eeed32","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:20 INFO - 1500937580407 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49330/clicks.html"}]
16:06:20 INFO - 1500937580425 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/hidden.html"
16:06:20 INFO - 1500937580443 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/hidden.html"
16:06:20 INFO - 1500937580445 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/hidden.html"
16:06:20 INFO - ++DOMWINDOW == 28 (00000067E3D9E800) [pid = 3212] [serial = 40] [outer = 00000067EF70B800]
16:06:20 INFO - 1500937580527 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/clicks.html"
16:06:20 INFO - 1500937580534 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/clicks.html"
16:06:20 INFO - 1500937580559 Marionette TRACE 358 <- [1,2,null,{}]
16:06:20 INFO - 1500937580578 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
16:06:20 INFO - 1500937580602 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"92800f0e-e0e2-4011-997c-75fcfc2d033f","ELEMENT":"92800f0e-e0e2-4011-997c-75fcfc2d033f"}}]
16:06:20 INFO - 1500937580607 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"92800f0e-e0e2-4011-997c-75fcfc2d033f"}]
16:06:21 INFO - 1500937581006 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/clicks.html"
16:06:21 INFO - [Parent 3212] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
16:06:21 INFO - 1500937581026 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/clicks.html"
16:06:21 INFO - 1500937581028 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/clicks.html"
16:06:21 INFO - ++DOMWINDOW == 29 (00000067E9DBE000) [pid = 3212] [serial = 41] [outer = 00000067EF70B800]
16:06:21 INFO - 1500937581109 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/test.html"
16:06:21 INFO - 1500937581116 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/test.html"
16:06:21 INFO - 1500937581138 Marionette TRACE 358 <- [1,4,null,{}]
16:06:21 INFO - 1500937581142 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
16:06:21 INFO - 1500937581156 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"56bfc8f7-e518-4970-a425-07cce43f78e9","ELEMENT":"56bfc8f7-e518-4970-a425-07cce43f78e9"}}]
16:06:21 INFO - 1500937581159 Marionette TRACE 358 -> [0,6,"getTitle",{}]
16:06:21 INFO - 1500937581162 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
16:06:21 INFO - 1500937581166 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}]
16:06:21 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500937581190 Marionette TRACE 358 <- [1,7,null,{"value":null}]
16:06:21 INFO - 1500937581193 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581200 Marionette TRACE 358 <- [1,8,null,{}]
16:06:21 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 2209ms
16:06:21 INFO - TEST-START | test_click.py TestClick.test_container_element
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581209 Marionette DEBUG Closed connection 358
16:06:21 INFO - 1500937581213 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49787
16:06:21 INFO - 1500937581217 Marionette DEBUG Closed connection 359
16:06:21 INFO - 1500937581220 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49788
16:06:21 INFO - 1500937581278 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:21 INFO - 1500937581281 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:21 INFO - 1500937581325 Marionette DEBUG Register listener.js for window 12
16:06:21 INFO - 1500937581353 Marionette TRACE 360 <- [1,1,null,{"sessionId":"b2bdc4d4-23ba-4080-9d14-25d9acc9be4e","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:21 INFO - 1500937581363 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
16:06:21 INFO - 1500937581365 Marionette TRACE 360 <- [1,2,null,{}]
16:06:21 INFO - 1500937581377 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:21 INFO - 1500937581383 Marionette TRACE 360 <- [1,3,null,{}]
16:06:21 INFO - 1500937581446 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:21 INFO - 1500937581448 Marionette TRACE 360 <- [1,4,null,{}]
16:06:21 INFO - 1500937581455 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}]
16:06:21 INFO - TEST-START: test_click.py TestClick.test_container_element1500937581466 Marionette TRACE 360 <- [1,5,null,{"value":null}]
16:06:21 INFO - 1500937581518 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581523 Marionette TRACE 360 <- [1,6,null,{}]
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581550 Marionette DEBUG Closed connection 360
16:06:21 INFO - 1500937581553 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49789
16:06:21 INFO - 1500937581555 Marionette DEBUG Closed connection 361
16:06:21 INFO - 1500937581557 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49790
16:06:21 INFO - 1500937581560 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:21 INFO - 1500937581563 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:21 INFO - 1500937581607 Marionette DEBUG Register listener.js for window 12
16:06:21 INFO - 1500937581626 Marionette TRACE 362 <- [1,1,null,{"sessionId":"4729a1fb-808c-4375-b48d-8f79fb1191d4","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:21 INFO - 1500937581642 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581647 Marionette TRACE 362 <- [1,2,null,{}]
16:06:21 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:21 INFO - 1500937581654 Marionette DEBUG Closed connection 362
16:06:21 INFO - 1500937581656 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49791
16:06:21 INFO - 1500937581670 Marionette DEBUG Closed connection 363
16:06:21 INFO - 1500937581672 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49792
16:06:21 INFO - 1500937581675 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:21 INFO - 1500937581679 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:21 INFO - 1500937581723 Marionette DEBUG Register listener.js for window 12
16:06:21 INFO - 1500937581739 Marionette TRACE 364 <- [1,1,null,{"sessionId":"f053b76d-fefb-4816-8af2-3fd66dc219e1","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:21 INFO - 1500937581781 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"}]
16:06:21 INFO - 1500937581788 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/test.html"
16:06:21 INFO - 1500937581796 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/test.html"
16:06:21 INFO - 1500937581797 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/test.html"
16:06:21 INFO - ++DOMWINDOW == 30 (00000067F65DC800) [pid = 3212] [serial = 42] [outer = 00000067EF70B800]
16:06:21 INFO - 1500937581862 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"
16:06:21 INFO - 1500937581875 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"
16:06:21 INFO - 1500937581885 Marionette TRACE 364 <- [1,2,null,{}]
16:06:21 INFO - 1500937581896 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
16:06:21 INFO - 1500937581905 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0d7eb7a6-a496-4e32-8e6b-f63374ae3407","ELEMENT":"0d7eb7a6-a496-4e32-8e6b-f63374ae3407"}}]
16:06:21 INFO - 1500937581908 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"0d7eb7a6-a496-4e32-8e6b-f63374ae3407"}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
16:06:22 INFO - 1500937582530 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:06:22 INFO - 1500937582532 Marionette TRACE 364 <- [1,4,null,{}]
16:06:22 INFO - 1500937582536 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"0d7eb7a6-a496-4e32-8e6b-f63374ae3407","name":"selected"}]
16:06:22 INFO - 1500937582594 Marionette TRACE 364 <- [1,5,null,{"value":true}]
16:06:22 INFO - 1500937582602 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}]
16:06:22 INFO - TEST-END: test_click.py TestClick.test_container_element1500937582617 Marionette TRACE 364 <- [1,6,null,{"value":null}]
16:06:22 INFO - 1500937582619 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582624 Marionette TRACE 364 <- [1,7,null,{}]
16:06:22 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1422ms
16:06:22 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582633 Marionette DEBUG Closed connection 364
16:06:22 INFO - 1500937582636 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49793
16:06:22 INFO - 1500937582638 Marionette DEBUG Closed connection 365
16:06:22 INFO - 1500937582640 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49794
16:06:22 INFO - 1500937582642 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:22 INFO - 1500937582649 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:22 INFO - 1500937582695 Marionette DEBUG Register listener.js for window 12
16:06:22 INFO - 1500937582723 Marionette TRACE 366 <- [1,1,null,{"sessionId":"2c12e050-9d9e-4f0e-9e16-ac8d54bef6a0","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:22 INFO - 1500937582731 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
16:06:22 INFO - 1500937582733 Marionette TRACE 366 <- [1,2,null,{}]
16:06:22 INFO - 1500937582735 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:22 INFO - 1500937582737 Marionette TRACE 366 <- [1,3,null,{}]
16:06:22 INFO - 1500937582739 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:22 INFO - 1500937582741 Marionette TRACE 366 <- [1,4,null,{}]
16:06:22 INFO - 1500937582770 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}]
16:06:22 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500937582780 Marionette TRACE 366 <- [1,5,null,{"value":null}]
16:06:22 INFO - 1500937582784 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582789 Marionette TRACE 366 <- [1,6,null,{}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582819 Marionette DEBUG Closed connection 366
16:06:22 INFO - 1500937582824 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49795
16:06:22 INFO - 1500937582860 Marionette DEBUG Closed connection 367
16:06:22 INFO - 1500937582862 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49796
16:06:22 INFO - 1500937582865 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:22 INFO - 1500937582868 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:22 INFO - 1500937582912 Marionette DEBUG Register listener.js for window 12
16:06:22 INFO - 1500937582928 Marionette TRACE 368 <- [1,1,null,{"sessionId":"5055dc99-5aae-4f02-ab0c-99534f9e0193","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:22 INFO - 1500937582942 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582947 Marionette TRACE 368 <- [1,2,null,{}]
16:06:22 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:22 INFO - 1500937582977 Marionette DEBUG Closed connection 368
16:06:22 INFO - 1500937582979 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49797
16:06:22 INFO - 1500937582983 Marionette DEBUG Closed connection 369
16:06:22 INFO - 1500937582985 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49798
16:06:23 INFO - 1500937583173 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:23 INFO - 1500937583191 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:23 INFO - 1500937583217 Marionette DEBUG Register listener.js for window 12
16:06:23 INFO - 1500937583238 Marionette TRACE 370 <- [1,1,null,{"sessionId":"39f2858a-8f04-483f-8f5b-a20edd37074e","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:23 INFO - 1500937583256 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"}]
16:06:23 INFO - 1500937583262 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"
16:06:23 INFO - 1500937583272 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"
16:06:23 INFO - 1500937583273 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"
16:06:23 INFO - ++DOMWINDOW == 31 (00000067E46F6000) [pid = 3212] [serial = 43] [outer = 00000067EF70B800]
16:06:23 INFO - 1500937583339 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"
16:06:23 INFO - 1500937583345 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"
16:06:23 INFO - 1500937583380 Marionette TRACE 370 <- [1,2,null,{}]
16:06:23 INFO - 1500937583392 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
16:06:23 INFO - 1500937583405 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3bd96b2d-42e8-402c-a6ff-2f98bfa19ac4","ELEMENT":"3bd96b2d-42e8-402c-a6ff-2f98bfa19ac4"}}]
16:06:23 INFO - 1500937583408 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"3bd96b2d-42e8-402c-a6ff-2f98bfa19ac4"}]
16:06:23 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
16:06:23 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
16:06:23 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
16:06:23 INFO - 1500937583872 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:06:23 INFO - 1500937583875 Marionette TRACE 370 <- [1,4,null,{}]
16:06:23 INFO - 1500937583880 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"3bd96b2d-42e8-402c-a6ff-2f98bfa19ac4","name":"selected"}]
16:06:23 INFO - 1500937583915 Marionette TRACE 370 <- [1,5,null,{"value":true}]
16:06:23 INFO - 1500937583928 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}]
16:06:23 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500937583940 Marionette TRACE 370 <- [1,6,null,{"value":null}]
16:06:23 INFO - 1500937583943 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
16:06:23 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:23 INFO - 1500937583949 Marionette TRACE 370 <- [1,7,null,{}]
16:06:23 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1324ms
16:06:23 INFO - TEST-START | test_click.py TestClick.test_css_transforms
16:06:23 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:23 INFO - 1500937583957 Marionette DEBUG Closed connection 370
16:06:23 INFO - 1500937583959 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49799
16:06:23 INFO - 1500937583984 Marionette DEBUG Closed connection 371
16:06:23 INFO - 1500937583986 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49800
16:06:23 INFO - 1500937583989 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:23 INFO - 1500937583993 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:24 INFO - 1500937584019 Marionette DEBUG Register listener.js for window 12
16:06:24 INFO - 1500937584049 Marionette TRACE 372 <- [1,1,null,{"sessionId":"a08ac4cf-f264-4703-9def-04ba85c231ab","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:24 INFO - 1500937584063 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
16:06:24 INFO - 1500937584065 Marionette TRACE 372 <- [1,2,null,{}]
16:06:24 INFO - 1500937584068 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:24 INFO - 1500937584071 Marionette TRACE 372 <- [1,3,null,{}]
16:06:24 INFO - 1500937584078 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:24 INFO - 1500937584084 Marionette TRACE 372 <- [1,4,null,{}]
16:06:24 INFO - 1500937584102 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}]
16:06:24 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500937584112 Marionette TRACE 372 <- [1,5,null,{"value":null}]
16:06:24 INFO - 1500937584117 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
16:06:24 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:24 INFO - 1500937584123 Marionette TRACE 372 <- [1,6,null,{}]
16:06:24 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:24 INFO - 1500937584150 Marionette DEBUG Closed connection 372
16:06:24 INFO - 1500937584152 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49801
16:06:24 INFO - 1500937584156 Marionette DEBUG Closed connection 373
16:06:24 INFO - 1500937584158 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49802
16:06:24 INFO - 1500937584164 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:24 INFO - 1500937584168 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:24 INFO - 1500937584190 Marionette DEBUG Register listener.js for window 12
16:06:24 INFO - 1500937584207 Marionette TRACE 374 <- [1,1,null,{"sessionId":"48a80702-38b6-4b02-b1a2-0f353c90de0d","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:24 INFO - 1500937584218 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
16:06:24 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:24 INFO - 1500937584222 Marionette TRACE 374 <- [1,2,null,{}]
16:06:24 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:24 INFO - 1500937584231 Marionette DEBUG Closed connection 374
16:06:24 INFO - 1500937584234 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49803
16:06:24 INFO - 1500937584255 Marionette DEBUG Closed connection 375
16:06:24 INFO - 1500937584257 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49804
16:06:24 INFO - 1500937584260 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:24 INFO - 1500937584263 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:24 INFO - 1500937584287 Marionette DEBUG Register listener.js for window 12
16:06:24 INFO - 1500937584317 Marionette TRACE 376 <- [1,1,null,{"sessionId":"d3aa2f51-8094-46a5-bf6e-998f12ee9c2a","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:24 INFO - 1500937584334 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"}]
16:06:24 INFO - 1500937584339 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"
16:06:24 INFO - 1500937584347 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"
16:06:24 INFO - 1500937584348 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"
16:06:24 INFO - ++DOMWINDOW == 32 (00000067E3D95000) [pid = 3212] [serial = 44] [outer = 00000067EF70B800]
16:06:24 INFO - 1500937584407 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"
16:06:24 INFO - 1500937584414 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"
16:06:24 INFO - 1500937584433 Marionette TRACE 376 <- [1,2,null,{}]
16:06:24 INFO - 1500937584443 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
16:06:24 INFO - 1500937584453 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fbd62607-e5ca-4667-8d24-69f3a7ba5b99","ELEMENT":"fbd62607-e5ca-4667-8d24-69f3a7ba5b99"}}]
16:06:24 INFO - 1500937584455 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"fbd62607-e5ca-4667-8d24-69f3a7ba5b99"}]
16:06:24 INFO - --DOMWINDOW == 31 (00000067EE921000) [pid = 3212] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 30 (00000067EE910000) [pid = 3212] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 29 (00000067F43AD800) [pid = 3212] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 28 (00000067E56A1000) [pid = 3212] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 27 (00000067F65D5800) [pid = 3212] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 26 (00000067F7F0F800) [pid = 3212] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:24 INFO - --DOMWINDOW == 25 (00000067EF1A9000) [pid = 3212] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
16:06:25 INFO - 1500937585648 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:06:25 INFO - 1500937585684 Marionette TRACE 376 <- [1,4,null,{}]
16:06:25 INFO - 1500937585732 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}]
16:06:25 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500937585740 Marionette TRACE 376 <- [1,5,null,{"value":null}]
16:06:25 INFO - 1500937585797 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
16:06:25 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:25 INFO - 1500937585802 Marionette TRACE 376 <- [1,6,null,{}]
16:06:25 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1853ms
16:06:25 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
16:06:25 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:25 INFO - 1500937585856 Marionette DEBUG Closed connection 376
16:06:25 INFO - 1500937585859 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49805
16:06:25 INFO - 1500937585912 Marionette DEBUG Closed connection 377
16:06:25 INFO - 1500937585914 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49806
16:06:25 INFO - 1500937585968 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:25 INFO - 1500937585973 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:26 INFO - 1500937585997 Marionette DEBUG Register listener.js for window 12
16:06:26 INFO - 1500937586013 Marionette TRACE 378 <- [1,1,null,{"sessionId":"0368b9a9-b9ad-4040-a6ce-20ebf1d3b78e","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:26 INFO - 1500937586064 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
16:06:26 INFO - 1500937586066 Marionette TRACE 378 <- [1,2,null,{}]
16:06:26 INFO - 1500937586095 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:26 INFO - 1500937586097 Marionette TRACE 378 <- [1,3,null,{}]
16:06:26 INFO - 1500937586099 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:26 INFO - 1500937586101 Marionette TRACE 378 <- [1,4,null,{}]
16:06:26 INFO - 1500937586105 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}]
16:06:26 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500937586118 Marionette TRACE 378 <- [1,5,null,{"value":null}]
16:06:26 INFO - 1500937586122 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586126 Marionette TRACE 378 <- [1,6,null,{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586150 Marionette DEBUG Closed connection 378
16:06:26 INFO - 1500937586152 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49807
16:06:26 INFO - 1500937586156 Marionette DEBUG Closed connection 379
16:06:26 INFO - 1500937586158 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49808
16:06:26 INFO - 1500937586160 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:26 INFO - 1500937586163 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:26 INFO - 1500937586186 Marionette DEBUG Register listener.js for window 12
16:06:26 INFO - 1500937586200 Marionette TRACE 380 <- [1,1,null,{"sessionId":"985e1502-0aa7-4f67-b295-fed822302f6b","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:26 INFO - 1500937586211 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586216 Marionette TRACE 380 <- [1,2,null,{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586240 Marionette DEBUG Closed connection 380
16:06:26 INFO - 1500937586245 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49809
16:06:26 INFO - 1500937586250 Marionette DEBUG Closed connection 381
16:06:26 INFO - 1500937586252 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49810
16:06:26 INFO - 1500937586254 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:26 INFO - 1500937586257 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:26 INFO - 1500937586280 Marionette DEBUG Register listener.js for window 12
16:06:26 INFO - 1500937586297 Marionette TRACE 382 <- [1,1,null,{"sessionId":"bfa612c1-d5c1-41b9-aaad-4d60a1c0b3d6","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:26 INFO - 1500937586308 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"}]
16:06:26 INFO - 1500937586312 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"
16:06:26 INFO - 1500937586319 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"
16:06:26 INFO - 1500937586320 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"
16:06:26 INFO - ++DOMWINDOW == 26 (00000067EE020000) [pid = 3212] [serial = 45] [outer = 00000067EF70B800]
16:06:26 INFO - 1500937586374 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"
16:06:26 INFO - 1500937586382 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"
16:06:26 INFO - 1500937586399 Marionette TRACE 382 <- [1,2,null,{}]
16:06:26 INFO - 1500937586405 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
16:06:26 INFO - 1500937586415 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3dd4c656-0e31-4a91-9252-a4d972e030e6","ELEMENT":"3dd4c656-0e31-4a91-9252-a4d972e030e6"}}]
16:06:26 INFO - 1500937586419 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"3dd4c656-0e31-4a91-9252-a4d972e030e6"}]
16:06:26 INFO - 1500937586853 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:06:26 INFO - 1500937586854 Marionette TRACE 382 <- [1,4,null,{}]
16:06:26 INFO - 1500937586857 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}]
16:06:26 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500937586865 Marionette TRACE 382 <- [1,5,null,{"value":null}]
16:06:26 INFO - 1500937586867 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586871 Marionette TRACE 382 <- [1,6,null,{}]
16:06:26 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1069ms
16:06:26 INFO - TEST-START | test_click.py TestClick.test_input_file
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586898 Marionette DEBUG Closed connection 382
16:06:26 INFO - 1500937586900 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49811
16:06:26 INFO - 1500937586904 Marionette DEBUG Closed connection 383
16:06:26 INFO - 1500937586905 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49812
16:06:26 INFO - 1500937586908 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:26 INFO - 1500937586911 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:26 INFO - 1500937586935 Marionette DEBUG Register listener.js for window 12
16:06:26 INFO - 1500937586947 Marionette TRACE 384 <- [1,1,null,{"sessionId":"9103913d-5704-452a-aaa5-2d68c76c4543","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:26 INFO - 1500937586958 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
16:06:26 INFO - 1500937586960 Marionette TRACE 384 <- [1,2,null,{}]
16:06:26 INFO - 1500937586964 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:26 INFO - 1500937586966 Marionette TRACE 384 <- [1,3,null,{}]
16:06:26 INFO - 1500937586968 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:26 INFO - 1500937586969 Marionette TRACE 384 <- [1,4,null,{}]
16:06:26 INFO - 1500937586972 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}]
16:06:26 INFO - TEST-START: test_click.py TestClick.test_input_file1500937586982 Marionette TRACE 384 <- [1,5,null,{"value":null}]
16:06:26 INFO - 1500937586984 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586990 Marionette TRACE 384 <- [1,6,null,{}]
16:06:26 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:26 INFO - 1500937586997 Marionette DEBUG Closed connection 384
16:06:27 INFO - 1500937586998 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49813
16:06:27 INFO - 1500937587000 Marionette DEBUG Closed connection 385
16:06:27 INFO - 1500937587001 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49814
16:06:27 INFO - 1500937587003 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:27 INFO - 1500937587006 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:27 INFO - 1500937587029 Marionette DEBUG Register listener.js for window 12
16:06:27 INFO - 1500937587040 Marionette TRACE 386 <- [1,1,null,{"sessionId":"3652d2df-1d77-41fc-aabb-253e37fb5fa4","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:27 INFO - 1500937587047 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
16:06:27 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:27 INFO - 1500937587051 Marionette TRACE 386 <- [1,2,null,{}]
16:06:27 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:27 INFO - 1500937587057 Marionette DEBUG Closed connection 386
16:06:27 INFO - 1500937587058 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49815
16:06:27 INFO - 1500937587060 Marionette DEBUG Closed connection 387
16:06:27 INFO - 1500937587062 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49816
16:06:27 INFO - 1500937587064 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:27 INFO - 1500937587067 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:27 INFO - 1500937587092 Marionette DEBUG Register listener.js for window 12
16:06:27 INFO - 1500937587104 Marionette TRACE 388 <- [1,1,null,{"sessionId":"4a024e55-388a-4cf1-a09c-b84ed66b19b1","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:27 INFO - 1500937587110 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
16:06:27 INFO - 1500937587115 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"
16:06:27 INFO - 1500937587124 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"
16:06:27 INFO - 1500937587126 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"
16:06:27 INFO - ++DOMWINDOW == 27 (00000067E3C2D800) [pid = 3212] [serial = 46] [outer = 00000067EF70B800]
16:06:27 INFO - 1500937587196 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:06:27 INFO - 1500937587201 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:06:27 INFO - 1500937587217 Marionette TRACE 388 <- [1,2,null,{}]
16:06:27 INFO - 1500937587221 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
16:06:27 INFO - 1500937587231 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"814a6184-d4e5-4cd7-975f-1a7ef4c5ed8f","ELEMENT":"814a6184-d4e5-4cd7-975f-1a7ef4c5ed8f"}}]
16:06:27 INFO - 1500937587288 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"814a6184-d4e5-4cd7-975f-1a7ef4c5ed8f"}]
16:06:27 INFO - 1500937587461 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
16:06:27 INFO - 1500937587478 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}]
16:06:27 INFO - TEST-END: test_click.py TestClick.test_input_file1500937587486 Marionette TRACE 388 <- [1,5,null,{"value":null}]
16:06:28 INFO - 1500937588110 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588115 Marionette TRACE 388 <- [1,6,null,{}]
16:06:28 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 1243ms
16:06:28 INFO - TEST-START | test_click.py TestClick.test_obscured_element
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588174 Marionette DEBUG Closed connection 388
16:06:28 INFO - 1500937588175 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49817
16:06:28 INFO - 1500937588211 Marionette DEBUG Closed connection 389
16:06:28 INFO - 1500937588213 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49818
16:06:28 INFO - 1500937588241 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:28 INFO - 1500937588245 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:28 INFO - 1500937588273 Marionette DEBUG Register listener.js for window 12
16:06:28 INFO - 1500937588287 Marionette TRACE 390 <- [1,1,null,{"sessionId":"5e716c2a-d78d-4454-a02a-11b3aaa4e0d8","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:28 INFO - 1500937588293 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
16:06:28 INFO - 1500937588295 Marionette TRACE 390 <- [1,2,null,{}]
16:06:28 INFO - 1500937588297 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:28 INFO - 1500937588299 Marionette TRACE 390 <- [1,3,null,{}]
16:06:28 INFO - 1500937588301 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:28 INFO - 1500937588302 Marionette TRACE 390 <- [1,4,null,{}]
16:06:28 INFO - 1500937588317 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}]
16:06:28 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500937588325 Marionette TRACE 390 <- [1,5,null,{"value":null}]
16:06:28 INFO - 1500937588330 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588334 Marionette TRACE 390 <- [1,6,null,{}]
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588357 Marionette DEBUG Closed connection 390
16:06:28 INFO - 1500937588358 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49819
16:06:28 INFO - 1500937588362 Marionette DEBUG Closed connection 391
16:06:28 INFO - 1500937588364 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49820
16:06:28 INFO - 1500937588367 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:28 INFO - 1500937588369 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:28 INFO - 1500937588393 Marionette DEBUG Register listener.js for window 12
16:06:28 INFO - 1500937588404 Marionette TRACE 392 <- [1,1,null,{"sessionId":"9665626c-29b4-4a48-aace-90c22674d73f","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:28 INFO - 1500937588414 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588418 Marionette TRACE 392 <- [1,2,null,{}]
16:06:28 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:28 INFO - 1500937588441 Marionette DEBUG Closed connection 392
16:06:28 INFO - 1500937588442 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49821
16:06:28 INFO - 1500937588446 Marionette DEBUG Closed connection 393
16:06:28 INFO - 1500937588447 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49822
16:06:28 INFO - 1500937588450 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:28 INFO - 1500937588452 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:28 INFO - 1500937588476 Marionette DEBUG Register listener.js for window 12
16:06:28 INFO - 1500937588488 Marionette TRACE 394 <- [1,1,null,{"sessionId":"8a31fec8-59b8-41b7-8fcb-3dff64e0bb45","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:28 INFO - 1500937588498 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"}]
16:06:28 INFO - 1500937588502 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:06:28 INFO - 1500937588509 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:06:28 INFO - 1500937588509 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
16:06:28 INFO - ++DOMWINDOW == 28 (00000067EEE6A800) [pid = 3212] [serial = 47] [outer = 00000067EF70B800]
16:06:28 INFO - 1500937588570 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"
16:06:28 INFO - 1500937588576 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"
16:06:28 INFO - 1500937588591 Marionette TRACE 394 <- [1,2,null,{}]
16:06:28 INFO - 1500937588595 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
16:06:28 INFO - 1500937588602 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"71d4dd94-ba3b-4cc7-8ddb-78b77203aef6","ELEMENT":"71d4dd94-ba3b-4cc7-8ddb-78b77203aef6"}}]
16:06:28 INFO - 1500937588610 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
16:06:28 INFO - 1500937588618 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8d3a8de5-0e85-4e23-b9c5-9884b40723a9","ELEMENT":"8d3a8de5-0e85-4e23-b9c5-9884b40723a9"}}]
16:06:28 INFO - 1500937588620 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"71d4dd94-ba3b-4cc7-8ddb-78b77203aef6"}]
16:06:29 INFO - 1500937589083 Marionette DEBUG Canceled page load listener because no navigation has been detected
16:06:29 INFO - 1500937589086 Marionette TRACE 394 <- [1,5,null,{}]
16:06:29 INFO - 1500937589092 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"8d3a8de5-0e85-4e23-b9c5-9884b40723a9"}]
16:06:29 INFO - 1500937589383 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
16:06:29 INFO - 1500937589414 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
16:06:29 INFO - 1500937589429 Marionette TRACE 394 <- [1,7,null,{"value":false}]
16:06:29 INFO - 1500937589433 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}]
16:06:29 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500937589448 Marionette TRACE 394 <- [1,8,null,{"value":null}]
16:06:29 INFO - 1500937589451 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589460 Marionette TRACE 394 <- [1,9,null,{}]
16:06:29 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1345ms
16:06:29 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589483 Marionette DEBUG Closed connection 394
16:06:29 INFO - 1500937589487 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49823
16:06:29 INFO - 1500937589513 Marionette DEBUG Closed connection 395
16:06:29 INFO - 1500937589516 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49824
16:06:29 INFO - 1500937589544 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:29 INFO - 1500937589553 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:29 INFO - 1500937589602 Marionette DEBUG Register listener.js for window 12
16:06:29 INFO - 1500937589624 Marionette TRACE 396 <- [1,1,null,{"sessionId":"ecd4232c-a00a-44ea-b624-6fe4902213e3","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:29 INFO - 1500937589653 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
16:06:29 INFO - 1500937589656 Marionette TRACE 396 <- [1,2,null,{}]
16:06:29 INFO - 1500937589659 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
16:06:29 INFO - 1500937589662 Marionette TRACE 396 <- [1,3,null,{}]
16:06:29 INFO - 1500937589714 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
16:06:29 INFO - 1500937589717 Marionette TRACE 396 <- [1,4,null,{}]
16:06:29 INFO - 1500937589723 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}]
16:06:29 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500937589735 Marionette TRACE 396 <- [1,5,null,{"value":null}]
16:06:29 INFO - 1500937589739 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589746 Marionette TRACE 396 <- [1,6,null,{}]
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589805 Marionette DEBUG Closed connection 396
16:06:29 INFO - 1500937589808 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49825
16:06:29 INFO - 1500937589830 Marionette DEBUG Closed connection 397
16:06:29 INFO - 1500937589832 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49826
16:06:29 INFO - 1500937589840 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
16:06:29 INFO - 1500937589846 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:29 INFO - 1500937589894 Marionette DEBUG Register listener.js for window 12
16:06:29 INFO - 1500937589912 Marionette TRACE 398 <- [1,1,null,{"sessionId":"3b4f48cf-1687-4ff2-b367-97e124ba1f7e","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:29 INFO - 1500937589934 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589941 Marionette TRACE 398 <- [1,2,null,{}]
16:06:29 INFO - [Parent 3212] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
16:06:29 INFO - 1500937589968 Marionette DEBUG Closed connection 398
16:06:29 INFO - 1500937589970 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49827
16:06:29 INFO - 1500937589976 Marionette DEBUG Closed connection 399
16:06:29 INFO - 1500937589978 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49828
16:06:30 INFO - 1500937590016 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
16:06:30 INFO - 1500937590020 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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}
16:06:30 INFO - 1500937590069 Marionette DEBUG Register listener.js for window 12
16:06:30 INFO - 1500937590085 Marionette TRACE 400 <- [1,1,null,{"sessionId":"4d07d111-636b-4e6d-85fe-77aeb8a30d95","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":3212,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-330.001\\AppData\\Local\\Temp\\tmpbduuhs.mozrunner","moz:accessibilityChecks":false}}]
16:06:30 INFO - 1500937590098 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"}]
16:06:30 INFO - 1500937590105 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"
16:06:30 INFO - 1500937590115 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"
16:06:30 INFO - 1500937590116 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"
16:06:30 INFO - ++DOMWINDOW == 29 (00000067EE35A800) [pid = 3212] [serial = 48] [outer = 00000067EF70B800]
16:06:30 INFO - 1500937590367 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"
16:06:30 INFO - 1500937590373 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"
16:06:30 INFO - 1500937590394 Marionette TRACE 400 <- [1,2,null,{}]
16:06:30 INFO - 1500937590405 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
16:06:30 INFO - 1500937590418 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b2175442-860c-427c-8e46-a80eec4652a3","ELEMENT":"b2175442-860c-427c-8e46-a80eec4652a3"}}]
16:06:30 INFO - 1500937590422 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"b2175442-860c-427c-8e46-a80eec4652a3"}]
16:06:30 INFO - 1500937590577 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
16:06:30 INFO - 1500937590581 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"b2175442-860c-427c-8e46-a80eec4652a3"}]
16:06:30 INFO - 1500937590746 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element