could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
15:45:50 INFO - 1499813150018 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}]
15:45:50 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499813150027 Marionette TRACE 352 <- [1,5,null,{"value":null}]
15:45:50 INFO - 1499813150029 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150034 Marionette TRACE 352 <- [1,6,null,{}]
15:45:50 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 864ms
15:45:50 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150040 Marionette DEBUG Closed connection 352
15:45:50 INFO - 1499813150042 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49785
15:45:50 INFO - 1499813150044 Marionette DEBUG Closed connection 353
15:45:50 INFO - 1499813150047 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49786
15:45:50 INFO - 1499813150049 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:50 INFO - 1499813150052 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:50 INFO - 1499813150075 Marionette DEBUG Register listener.js for window 12
15:45:50 INFO - 1499813150088 Marionette TRACE 354 <- [1,1,null,{"sessionId":"e8fe6403-239a-4b23-a449-9c8b34a87154","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:50 INFO - 1499813150160 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
15:45:50 INFO - 1499813150162 Marionette TRACE 354 <- [1,2,null,{}]
15:45:50 INFO - 1499813150165 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:50 INFO - 1499813150166 Marionette TRACE 354 <- [1,3,null,{}]
15:45:50 INFO - 1499813150169 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:50 INFO - 1499813150171 Marionette TRACE 354 <- [1,4,null,{}]
15:45:50 INFO - 1499813150174 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}]
15:45:50 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499813150186 Marionette TRACE 354 <- [1,5,null,{"value":null}]
15:45:50 INFO - 1499813150189 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150194 Marionette TRACE 354 <- [1,6,null,{}]
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150216 Marionette DEBUG Closed connection 354
15:45:50 INFO - 1499813150218 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49787
15:45:50 INFO - 1499813150222 Marionette DEBUG Closed connection 355
15:45:50 INFO - 1499813150224 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49788
15:45:50 INFO - 1499813150229 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:50 INFO - 1499813150234 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:50 INFO - 1499813150258 Marionette DEBUG Register listener.js for window 12
15:45:50 INFO - 1499813150273 Marionette TRACE 356 <- [1,1,null,{"sessionId":"f23387d8-e4fa-427d-96a5-0ed0422f999d","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:50 INFO - 1499813150284 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150290 Marionette TRACE 356 <- [1,2,null,{}]
15:45:50 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:50 INFO - 1499813150298 Marionette DEBUG Closed connection 356
15:45:50 INFO - 1499813150303 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49789
15:45:50 INFO - 1499813150305 Marionette DEBUG Closed connection 357
15:45:50 INFO - 1499813150307 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49790
15:45:50 INFO - 1499813150310 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:50 INFO - 1499813150312 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:50 INFO - 1499813150335 Marionette DEBUG Register listener.js for window 12
15:45:50 INFO - 1499813150349 Marionette TRACE 358 <- [1,1,null,{"sessionId":"d1765a83-538b-4507-8717-6a5ab986272c","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:51 INFO - 1499813151046 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
15:45:51 INFO - 1499813151053 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
15:45:51 INFO - 1499813151072 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
15:45:51 INFO - 1499813151073 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
15:45:51 INFO - ++DOMWINDOW == 19 (0000003E8BD77000) [pid = 2312] [serial = 41] [outer = 0000003E8A87E000]
15:45:51 INFO - 1499813151179 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
15:45:51 INFO - 1499813151184 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
15:45:51 INFO - 1499813151208 Marionette TRACE 358 <- [1,2,null,{}]
15:45:51 INFO - 1499813151214 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
15:45:51 INFO - 1499813151265 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dec82cf7-90fb-4d1c-8ce4-ae09ed465646","ELEMENT":"dec82cf7-90fb-4d1c-8ce4-ae09ed465646"}}]
15:45:51 INFO - 1499813151301 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"dec82cf7-90fb-4d1c-8ce4-ae09ed465646"}]
15:45:51 INFO - 1499813151586 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
15:45:51 INFO - [Parent 2312] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
15:45:51 INFO - 1499813151603 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
15:45:51 INFO - 1499813151604 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
15:45:51 INFO - ++DOMWINDOW == 20 (0000003E8DB07800) [pid = 2312] [serial = 42] [outer = 0000003E8A87E000]
15:45:51 INFO - 1499813151667 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
15:45:51 INFO - 1499813151672 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
15:45:51 INFO - 1499813151689 Marionette TRACE 358 <- [1,4,null,{}]
15:45:51 INFO - 1499813151692 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
15:45:51 INFO - 1499813151702 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8bb398e1-f152-4c5d-85a8-88f8b19ff056","ELEMENT":"8bb398e1-f152-4c5d-85a8-88f8b19ff056"}}]
15:45:51 INFO - 1499813151704 Marionette TRACE 358 -> [0,6,"getTitle",{}]
15:45:51 INFO - 1499813151706 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
15:45:51 INFO - 1499813151709 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}]
15:45:51 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499813151716 Marionette TRACE 358 <- [1,7,null,{"value":null}]
15:45:51 INFO - 1499813151724 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151728 Marionette TRACE 358 <- [1,8,null,{}]
15:45:51 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1694ms
15:45:51 INFO - TEST-START | test_click.py TestClick.test_container_element
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151735 Marionette DEBUG Closed connection 358
15:45:51 INFO - 1499813151736 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49793
15:45:51 INFO - 1499813151738 Marionette DEBUG Closed connection 359
15:45:51 INFO - 1499813151740 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49794
15:45:51 INFO - 1499813151742 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:51 INFO - 1499813151745 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:51 INFO - 1499813151769 Marionette DEBUG Register listener.js for window 12
15:45:51 INFO - 1499813151781 Marionette TRACE 360 <- [1,1,null,{"sessionId":"b3332943-c503-4a70-bf9a-87950d1a6a97","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:51 INFO - 1499813151788 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
15:45:51 INFO - 1499813151790 Marionette TRACE 360 <- [1,2,null,{}]
15:45:51 INFO - 1499813151815 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:51 INFO - 1499813151817 Marionette TRACE 360 <- [1,3,null,{}]
15:45:51 INFO - 1499813151819 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:51 INFO - 1499813151821 Marionette TRACE 360 <- [1,4,null,{}]
15:45:51 INFO - 1499813151823 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}]
15:45:51 INFO - TEST-START: test_click.py TestClick.test_container_element1499813151833 Marionette TRACE 360 <- [1,5,null,{"value":null}]
15:45:51 INFO - 1499813151835 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151839 Marionette TRACE 360 <- [1,6,null,{}]
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151863 Marionette DEBUG Closed connection 360
15:45:51 INFO - 1499813151864 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49795
15:45:51 INFO - 1499813151868 Marionette DEBUG Closed connection 361
15:45:51 INFO - 1499813151871 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49796
15:45:51 INFO - 1499813151873 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:51 INFO - 1499813151876 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:51 INFO - 1499813151900 Marionette DEBUG Register listener.js for window 12
15:45:51 INFO - 1499813151912 Marionette TRACE 362 <- [1,1,null,{"sessionId":"55520013-8d00-44c1-9abb-9becdd3d6ae4","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:51 INFO - 1499813151923 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151927 Marionette TRACE 362 <- [1,2,null,{}]
15:45:51 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:51 INFO - 1499813151950 Marionette DEBUG Closed connection 362
15:45:51 INFO - 1499813151951 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49797
15:45:51 INFO - 1499813151956 Marionette DEBUG Closed connection 363
15:45:51 INFO - 1499813151957 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49798
15:45:51 INFO - 1499813151960 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:51 INFO - 1499813151962 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:51 INFO - 1499813151986 Marionette DEBUG Register listener.js for window 12
15:45:52 INFO - 1499813151998 Marionette TRACE 364 <- [1,1,null,{"sessionId":"13aa0f83-fe60-43a0-9fa0-c1ccaffb69dd","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:52 INFO - 1499813152009 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"}]
15:45:52 INFO - 1499813152016 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
15:45:52 INFO - 1499813152025 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
15:45:52 INFO - 1499813152026 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
15:45:52 INFO - ++DOMWINDOW == 21 (0000003E91220000) [pid = 2312] [serial = 43] [outer = 0000003E8A87E000]
15:45:52 INFO - 1499813152106 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"
15:45:52 INFO - 1499813152113 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"
15:45:52 INFO - 1499813152131 Marionette TRACE 364 <- [1,2,null,{}]
15:45:52 INFO - 1499813152138 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:45:52 INFO - 1499813152146 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bc0b02a1-6e08-4cb0-b1f8-f854c5eed2da","ELEMENT":"bc0b02a1-6e08-4cb0-b1f8-f854c5eed2da"}}]
15:45:52 INFO - 1499813152148 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"bc0b02a1-6e08-4cb0-b1f8-f854c5eed2da"}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
15:45:52 INFO - 1499813152608 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:45:52 INFO - 1499813152610 Marionette TRACE 364 <- [1,4,null,{}]
15:45:52 INFO - 1499813152612 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"bc0b02a1-6e08-4cb0-b1f8-f854c5eed2da","name":"selected"}]
15:45:52 INFO - 1499813152640 Marionette TRACE 364 <- [1,5,null,{"value":true}]
15:45:52 INFO - 1499813152643 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}]
15:45:52 INFO - TEST-END: test_click.py TestClick.test_container_element1499813152651 Marionette TRACE 364 <- [1,6,null,{"value":null}]
15:45:52 INFO - 1499813152653 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152657 Marionette TRACE 364 <- [1,7,null,{}]
15:45:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 929ms
15:45:52 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152663 Marionette DEBUG Closed connection 364
15:45:52 INFO - 1499813152665 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49799
15:45:52 INFO - 1499813152667 Marionette DEBUG Closed connection 365
15:45:52 INFO - 1499813152668 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49800
15:45:52 INFO - 1499813152670 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:52 INFO - 1499813152672 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:52 INFO - 1499813152696 Marionette DEBUG Register listener.js for window 12
15:45:52 INFO - 1499813152737 Marionette TRACE 366 <- [1,1,null,{"sessionId":"c802c769-f1b9-4389-a8f7-a14729b2a5e9","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:52 INFO - 1499813152746 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
15:45:52 INFO - 1499813152748 Marionette TRACE 366 <- [1,2,null,{}]
15:45:52 INFO - 1499813152750 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:52 INFO - 1499813152752 Marionette TRACE 366 <- [1,3,null,{}]
15:45:52 INFO - 1499813152753 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:52 INFO - 1499813152755 Marionette TRACE 366 <- [1,4,null,{}]
15:45:52 INFO - 1499813152757 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}]
15:45:52 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499813152765 Marionette TRACE 366 <- [1,5,null,{"value":null}]
15:45:52 INFO - 1499813152767 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152772 Marionette TRACE 366 <- [1,6,null,{}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152778 Marionette DEBUG Closed connection 366
15:45:52 INFO - 1499813152779 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49801
15:45:52 INFO - 1499813152781 Marionette DEBUG Closed connection 367
15:45:52 INFO - 1499813152782 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49802
15:45:52 INFO - 1499813152785 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:52 INFO - 1499813152788 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:52 INFO - 1499813152817 Marionette DEBUG Register listener.js for window 12
15:45:52 INFO - 1499813152831 Marionette TRACE 368 <- [1,1,null,{"sessionId":"f279e316-a9a7-419f-8839-471bc9ca8cb2","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:52 INFO - 1499813152837 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152842 Marionette TRACE 368 <- [1,2,null,{}]
15:45:52 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:52 INFO - 1499813152847 Marionette DEBUG Closed connection 368
15:45:52 INFO - 1499813152849 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49803
15:45:52 INFO - 1499813152851 Marionette DEBUG Closed connection 369
15:45:52 INFO - 1499813152853 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49804
15:45:52 INFO - 1499813152855 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:52 INFO - 1499813152858 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:52 INFO - 1499813152881 Marionette DEBUG Register listener.js for window 12
15:45:52 INFO - 1499813152893 Marionette TRACE 370 <- [1,1,null,{"sessionId":"123f5943-5e4a-427f-bfa1-44197c1d3321","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:52 INFO - 1499813152899 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"}]
15:45:52 INFO - 1499813152903 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"
15:45:52 INFO - 1499813152909 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"
15:45:52 INFO - 1499813152910 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"
15:45:52 INFO - ++DOMWINDOW == 22 (0000003EFE506000) [pid = 2312] [serial = 44] [outer = 0000003E8A87E000]
15:45:52 INFO - 1499813152955 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"
15:45:52 INFO - 1499813152963 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"
15:45:52 INFO - 1499813152981 Marionette TRACE 370 <- [1,2,null,{}]
15:45:53 INFO - 1499813153036 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
15:45:53 INFO - 1499813153055 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ee7b50fe-317f-406d-829b-e4ac70fd0561","ELEMENT":"ee7b50fe-317f-406d-829b-e4ac70fd0561"}}]
15:45:53 INFO - 1499813153057 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"ee7b50fe-317f-406d-829b-e4ac70fd0561"}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
15:45:53 INFO - 1499813153506 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:45:53 INFO - 1499813153508 Marionette TRACE 370 <- [1,4,null,{}]
15:45:53 INFO - 1499813153512 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"ee7b50fe-317f-406d-829b-e4ac70fd0561","name":"selected"}]
15:45:53 INFO - 1499813153540 Marionette TRACE 370 <- [1,5,null,{"value":true}]
15:45:53 INFO - 1499813153543 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}]
15:45:53 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499813153550 Marionette TRACE 370 <- [1,6,null,{"value":null}]
15:45:53 INFO - 1499813153552 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153556 Marionette TRACE 370 <- [1,7,null,{}]
15:45:53 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 898ms
15:45:53 INFO - TEST-START | test_click.py TestClick.test_css_transforms
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153562 Marionette DEBUG Closed connection 370
15:45:53 INFO - 1499813153564 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49805
15:45:53 INFO - 1499813153565 Marionette DEBUG Closed connection 371
15:45:53 INFO - 1499813153567 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49806
15:45:53 INFO - 1499813153569 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:53 INFO - 1499813153571 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:53 INFO - 1499813153594 Marionette DEBUG Register listener.js for window 12
15:45:53 INFO - 1499813153605 Marionette TRACE 372 <- [1,1,null,{"sessionId":"9804e553-c02d-47d8-9d7b-7b106aeef789","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:53 INFO - 1499813153642 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
15:45:53 INFO - 1499813153643 Marionette TRACE 372 <- [1,2,null,{}]
15:45:53 INFO - 1499813153645 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:53 INFO - 1499813153647 Marionette TRACE 372 <- [1,3,null,{}]
15:45:53 INFO - 1499813153648 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:53 INFO - 1499813153650 Marionette TRACE 372 <- [1,4,null,{}]
15:45:53 INFO - 1499813153652 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}]
15:45:53 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499813153660 Marionette TRACE 372 <- [1,5,null,{"value":null}]
15:45:53 INFO - 1499813153662 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153666 Marionette TRACE 372 <- [1,6,null,{}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153691 Marionette DEBUG Closed connection 372
15:45:53 INFO - 1499813153692 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49807
15:45:53 INFO - 1499813153696 Marionette DEBUG Closed connection 373
15:45:53 INFO - 1499813153697 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49808
15:45:53 INFO - 1499813153699 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:53 INFO - 1499813153701 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:53 INFO - 1499813153725 Marionette DEBUG Register listener.js for window 12
15:45:53 INFO - 1499813153736 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d9d399e3-8e75-4695-8ddf-d1a5a9f2ce0d","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:53 INFO - 1499813153747 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153752 Marionette TRACE 374 <- [1,2,null,{}]
15:45:53 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:53 INFO - 1499813153774 Marionette DEBUG Closed connection 374
15:45:53 INFO - 1499813153776 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49809
15:45:54 INFO - 1499813154423 Marionette DEBUG Closed connection 375
15:45:54 INFO - 1499813154424 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49810
15:45:54 INFO - 1499813154428 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:54 INFO - 1499813154431 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:54 INFO - 1499813154454 Marionette DEBUG Register listener.js for window 12
15:45:54 INFO - 1499813154465 Marionette TRACE 376 <- [1,1,null,{"sessionId":"ce086594-b951-4148-afb8-4f4d9b6fb14c","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:54 INFO - 1499813154507 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"}]
15:45:54 INFO - 1499813154511 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"
15:45:54 INFO - 1499813154517 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"
15:45:54 INFO - 1499813154518 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"
15:45:54 INFO - ++DOMWINDOW == 23 (0000003E93485000) [pid = 2312] [serial = 45] [outer = 0000003E8A87E000]
15:45:54 INFO - 1499813154596 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"
15:45:54 INFO - 1499813154605 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"
15:45:54 INFO - 1499813154628 Marionette TRACE 376 <- [1,2,null,{}]
15:45:54 INFO - 1499813154635 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
15:45:54 INFO - 1499813154648 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b76c9343-e1fa-4d73-a336-eb468b016d62","ELEMENT":"b76c9343-e1fa-4d73-a336-eb468b016d62"}}]
15:45:54 INFO - 1499813154653 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"b76c9343-e1fa-4d73-a336-eb468b016d62"}]
15:45:55 INFO - 1499813155278 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:45:55 INFO - 1499813155282 Marionette TRACE 376 <- [1,4,null,{}]
15:45:55 INFO - 1499813155288 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}]
15:45:55 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499813155305 Marionette TRACE 376 <- [1,5,null,{"value":null}]
15:45:55 INFO - 1499813155309 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155319 Marionette TRACE 376 <- [1,6,null,{}]
15:45:55 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1762ms
15:45:55 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155328 Marionette DEBUG Closed connection 376
15:45:55 INFO - 1499813155331 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49811
15:45:55 INFO - 1499813155335 Marionette DEBUG Closed connection 377
15:45:55 INFO - 1499813155338 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49812
15:45:55 INFO - 1499813155342 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:55 INFO - 1499813155351 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:55 INFO - 1499813155401 Marionette DEBUG Register listener.js for window 12
15:45:55 INFO - 1499813155433 Marionette TRACE 378 <- [1,1,null,{"sessionId":"382ff8e1-a850-42bc-a2cd-9f6934920e28","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:55 INFO - 1499813155471 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
15:45:55 INFO - 1499813155474 Marionette TRACE 378 <- [1,2,null,{}]
15:45:55 INFO - 1499813155535 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:55 INFO - 1499813155538 Marionette TRACE 378 <- [1,3,null,{}]
15:45:55 INFO - 1499813155546 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:55 INFO - 1499813155549 Marionette TRACE 378 <- [1,4,null,{}]
15:45:55 INFO - 1499813155603 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}]
15:45:55 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499813155615 Marionette TRACE 378 <- [1,5,null,{"value":null}]
15:45:55 INFO - 1499813155621 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155628 Marionette TRACE 378 <- [1,6,null,{}]
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155653 Marionette DEBUG Closed connection 378
15:45:55 INFO - 1499813155656 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49813
15:45:55 INFO - 1499813155680 Marionette DEBUG Closed connection 379
15:45:55 INFO - 1499813155683 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49814
15:45:55 INFO - 1499813155726 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:55 INFO - 1499813155732 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:55 INFO - 1499813155781 Marionette DEBUG Register listener.js for window 12
15:45:55 INFO - 1499813155798 Marionette TRACE 380 <- [1,1,null,{"sessionId":"ed5ba8f1-55fe-4b13-a4a4-fbbaf22de953","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:55 INFO - 1499813155811 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155817 Marionette TRACE 380 <- [1,2,null,{}]
15:45:55 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:55 INFO - 1499813155874 Marionette DEBUG Closed connection 380
15:45:55 INFO - 1499813155876 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49815
15:45:55 INFO - 1499813155897 Marionette DEBUG Closed connection 381
15:45:55 INFO - 1499813155899 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49816
15:45:55 INFO - 1499813155903 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:55 INFO - 1499813155907 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:55 INFO - 1499813155956 Marionette DEBUG Register listener.js for window 12
15:45:55 INFO - 1499813155972 Marionette TRACE 382 <- [1,1,null,{"sessionId":"f26e0a8e-e861-49f5-979e-f1f2524fb450","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:56 INFO - 1499813156001 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"}]
15:45:56 INFO - 1499813156008 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"
15:45:56 INFO - 1499813156019 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"
15:45:56 INFO - 1499813156020 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"
15:45:56 INFO - ++DOMWINDOW == 24 (0000003E9426A800) [pid = 2312] [serial = 46] [outer = 0000003E8A87E000]
15:45:56 INFO - 1499813156090 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"
15:45:56 INFO - 1499813156097 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"
15:45:56 INFO - 1499813156117 Marionette TRACE 382 <- [1,2,null,{}]
15:45:56 INFO - 1499813156128 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
15:45:56 INFO - 1499813156138 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ee601f5f-4575-4f50-8d3f-7d348c83bd62","ELEMENT":"ee601f5f-4575-4f50-8d3f-7d348c83bd62"}}]
15:45:56 INFO - 1499813156141 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"ee601f5f-4575-4f50-8d3f-7d348c83bd62"}]
15:45:56 INFO - 1499813156899 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:45:56 INFO - 1499813156902 Marionette TRACE 382 <- [1,4,null,{}]
15:45:56 INFO - 1499813156908 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}]
15:45:56 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499813156923 Marionette TRACE 382 <- [1,5,null,{"value":null}]
15:45:56 INFO - 1499813156929 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
15:45:56 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:56 INFO - 1499813156939 Marionette TRACE 382 <- [1,6,null,{}]
15:45:56 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1620ms
15:45:56 INFO - TEST-START | test_click.py TestClick.test_input_file
15:45:56 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:56 INFO - 1499813156949 Marionette DEBUG Closed connection 382
15:45:56 INFO - 1499813156951 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49817
15:45:56 INFO - 1499813156953 Marionette DEBUG Closed connection 383
15:45:56 INFO - 1499813156956 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49818
15:45:56 INFO - 1499813156961 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:56 INFO - 1499813156972 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813156999 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157041 Marionette TRACE 384 <- [1,1,null,{"sessionId":"5c4b0c41-f3c5-4493-9615-d0cfc7f2a7eb","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157092 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
15:45:57 INFO - 1499813157095 Marionette TRACE 384 <- [1,2,null,{}]
15:45:57 INFO - 1499813157098 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:57 INFO - 1499813157102 Marionette TRACE 384 <- [1,3,null,{}]
15:45:57 INFO - 1499813157105 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:57 INFO - 1499813157107 Marionette TRACE 384 <- [1,4,null,{}]
15:45:57 INFO - 1499813157161 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}]
15:45:57 INFO - TEST-START: test_click.py TestClick.test_input_file1499813157173 Marionette TRACE 384 <- [1,5,null,{"value":null}]
15:45:57 INFO - 1499813157180 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157185 Marionette TRACE 384 <- [1,6,null,{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157195 Marionette DEBUG Closed connection 384
15:45:57 INFO - 1499813157198 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49819
15:45:57 INFO - 1499813157219 Marionette DEBUG Closed connection 385
15:45:57 INFO - 1499813157221 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49820
15:45:57 INFO - 1499813157236 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:57 INFO - 1499813157239 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813157266 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157282 Marionette TRACE 386 <- [1,1,null,{"sessionId":"f5939b9e-6cb0-454b-accc-a638500c1d1d","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157295 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157302 Marionette TRACE 386 <- [1,2,null,{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157312 Marionette DEBUG Closed connection 386
15:45:57 INFO - 1499813157315 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49821
15:45:57 INFO - 1499813157336 Marionette DEBUG Closed connection 387
15:45:57 INFO - 1499813157338 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49822
15:45:57 INFO - 1499813157346 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:57 INFO - 1499813157352 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813157377 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157392 Marionette TRACE 388 <- [1,1,null,{"sessionId":"4ad15cf9-c748-4810-8476-d425e7739398","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157405 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
15:45:57 INFO - 1499813157410 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"
15:45:57 INFO - 1499813157421 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"
15:45:57 INFO - 1499813157423 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"
15:45:57 INFO - ++DOMWINDOW == 25 (0000003E85231800) [pid = 2312] [serial = 47] [outer = 0000003E8A87E000]
15:45:57 INFO - 1499813157484 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:45:57 INFO - 1499813157491 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:45:57 INFO - 1499813157510 Marionette TRACE 388 <- [1,2,null,{}]
15:45:57 INFO - --DOMWINDOW == 24 (0000003EFD4F4000) [pid = 2312] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
15:45:57 INFO - --DOMWINDOW == 23 (0000003E9351D000) [pid = 2312] [serial = 35] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20vertically%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
15:45:57 INFO - --DOMWINDOW == 22 (0000003E91E8B800) [pid = 2312] [serial = 34] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20horizontally%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%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]
15:45:57 INFO - --DOMWINDOW == 21 (0000003E89FEE000) [pid = 2312] [serial = 33] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
15:45:57 INFO - 1499813157526 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
15:45:57 INFO - 1499813157536 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c6c19d4b-3287-480a-b0a2-1b074b76e988","ELEMENT":"c6c19d4b-3287-480a-b0a2-1b074b76e988"}}]
15:45:57 INFO - 1499813157538 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"c6c19d4b-3287-480a-b0a2-1b074b76e988"}]
15:45:57 INFO - 1499813157699 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
15:45:57 INFO - 1499813157716 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}]
15:45:57 INFO - TEST-END: test_click.py TestClick.test_input_file1499813157725 Marionette TRACE 388 <- [1,5,null,{"value":null}]
15:45:57 INFO - 1499813157727 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157731 Marionette TRACE 388 <- [1,6,null,{}]
15:45:57 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 791ms
15:45:57 INFO - TEST-START | test_click.py TestClick.test_obscured_element
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157738 Marionette DEBUG Closed connection 388
15:45:57 INFO - 1499813157740 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49823
15:45:57 INFO - 1499813157741 Marionette DEBUG Closed connection 389
15:45:57 INFO - 1499813157744 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49824
15:45:57 INFO - 1499813157746 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:57 INFO - 1499813157749 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813157774 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157788 Marionette TRACE 390 <- [1,1,null,{"sessionId":"a1e57b35-20f8-4d31-97d3-f8c4ee2cac30","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157795 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
15:45:57 INFO - 1499813157797 Marionette TRACE 390 <- [1,2,null,{}]
15:45:57 INFO - 1499813157799 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:57 INFO - 1499813157801 Marionette TRACE 390 <- [1,3,null,{}]
15:45:57 INFO - 1499813157803 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:57 INFO - 1499813157805 Marionette TRACE 390 <- [1,4,null,{}]
15:45:57 INFO - 1499813157807 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}]
15:45:57 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499813157817 Marionette TRACE 390 <- [1,5,null,{"value":null}]
15:45:57 INFO - 1499813157819 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157823 Marionette TRACE 390 <- [1,6,null,{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157829 Marionette DEBUG Closed connection 390
15:45:57 INFO - 1499813157831 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49825
15:45:57 INFO - 1499813157833 Marionette DEBUG Closed connection 391
15:45:57 INFO - 1499813157835 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49826
15:45:57 INFO - 1499813157837 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:57 INFO - 1499813157842 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813157867 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157882 Marionette TRACE 392 <- [1,1,null,{"sessionId":"68b21597-ab66-4ac7-a822-2bfee871a621","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157888 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157894 Marionette TRACE 392 <- [1,2,null,{}]
15:45:57 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:57 INFO - 1499813157902 Marionette DEBUG Closed connection 392
15:45:57 INFO - 1499813157907 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49827
15:45:57 INFO - 1499813157910 Marionette DEBUG Closed connection 393
15:45:57 INFO - 1499813157911 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49828
15:45:57 INFO - 1499813157914 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:57 INFO - 1499813157917 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:57 INFO - 1499813157941 Marionette DEBUG Register listener.js for window 12
15:45:57 INFO - 1499813157955 Marionette TRACE 394 <- [1,1,null,{"sessionId":"4c15891a-8554-4e92-88e3-35ed724a6ed9","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:57 INFO - 1499813157962 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"}]
15:45:57 INFO - 1499813157966 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:45:57 INFO - 1499813157975 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:45:57 INFO - 1499813157975 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
15:45:57 INFO - ++DOMWINDOW == 22 (0000003E91219800) [pid = 2312] [serial = 48] [outer = 0000003E8A87E000]
15:45:58 INFO - 1499813158040 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"
15:45:58 INFO - 1499813158047 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"
15:45:58 INFO - 1499813158066 Marionette TRACE 394 <- [1,2,null,{}]
15:45:58 INFO - 1499813158069 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
15:45:58 INFO - 1499813158077 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"56066ae8-971c-4e35-b518-ae1e28886db8","ELEMENT":"56066ae8-971c-4e35-b518-ae1e28886db8"}}]
15:45:58 INFO - 1499813158079 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
15:45:58 INFO - 1499813158089 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"307640a3-4ce8-43e8-8b80-33003bec2c01","ELEMENT":"307640a3-4ce8-43e8-8b80-33003bec2c01"}}]
15:45:58 INFO - 1499813158091 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"56066ae8-971c-4e35-b518-ae1e28886db8"}]
15:45:58 INFO - 1499813158539 Marionette DEBUG Canceled page load listener because no navigation has been detected
15:45:58 INFO - 1499813158541 Marionette TRACE 394 <- [1,5,null,{}]
15:45:58 INFO - 1499813158543 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"307640a3-4ce8-43e8-8b80-33003bec2c01"}]
15:45:58 INFO - 1499813158683 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
15:45:58 INFO - 1499813158686 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
15:45:58 INFO - 1499813158696 Marionette TRACE 394 <- [1,7,null,{"value":false}]
15:45:58 INFO - 1499813158699 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}]
15:45:58 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499813158708 Marionette TRACE 394 <- [1,8,null,{"value":null}]
15:45:58 INFO - 1499813158710 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158715 Marionette TRACE 394 <- [1,9,null,{}]
15:45:58 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 983ms
15:45:58 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158721 Marionette DEBUG Closed connection 394
15:45:58 INFO - 1499813158722 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49829
15:45:58 INFO - 1499813158724 Marionette DEBUG Closed connection 395
15:45:58 INFO - 1499813158725 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49830
15:45:58 INFO - 1499813158727 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:58 INFO - 1499813158730 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:58 INFO - 1499813158755 Marionette DEBUG Register listener.js for window 12
15:45:58 INFO - 1499813158771 Marionette TRACE 396 <- [1,1,null,{"sessionId":"819292f9-7de6-4389-904e-e9957143fb87","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:58 INFO - 1499813158791 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
15:45:58 INFO - 1499813158793 Marionette TRACE 396 <- [1,2,null,{}]
15:45:58 INFO - 1499813158803 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
15:45:58 INFO - 1499813158805 Marionette TRACE 396 <- [1,3,null,{}]
15:45:58 INFO - 1499813158810 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
15:45:58 INFO - 1499813158812 Marionette TRACE 396 <- [1,4,null,{}]
15:45:58 INFO - 1499813158825 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}]
15:45:58 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499813158837 Marionette TRACE 396 <- [1,5,null,{"value":null}]
15:45:58 INFO - 1499813158850 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158855 Marionette TRACE 396 <- [1,6,null,{}]
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158862 Marionette DEBUG Closed connection 396
15:45:58 INFO - 1499813158864 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49831
15:45:58 INFO - 1499813158865 Marionette DEBUG Closed connection 397
15:45:58 INFO - 1499813158868 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49832
15:45:58 INFO - 1499813158870 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
15:45:58 INFO - 1499813158874 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:58 INFO - 1499813158899 Marionette DEBUG Register listener.js for window 12
15:45:58 INFO - 1499813158910 Marionette TRACE 398 <- [1,1,null,{"sessionId":"e808e15a-36c5-4365-8161-60f505956bc9","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:58 INFO - 1499813158917 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158921 Marionette TRACE 398 <- [1,2,null,{}]
15:45:58 INFO - [Parent 2312] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
15:45:58 INFO - 1499813158927 Marionette DEBUG Closed connection 398
15:45:58 INFO - 1499813158928 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49833
15:45:58 INFO - 1499813158930 Marionette DEBUG Closed connection 399
15:45:58 INFO - 1499813158931 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49834
15:45:58 INFO - 1499813158934 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
15:45:58 INFO - 1499813158936 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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}
15:45:58 INFO - 1499813158961 Marionette DEBUG Register listener.js for window 12
15:45:58 INFO - 1499813158972 Marionette TRACE 400 <- [1,1,null,{"sessionId":"5bcc1571-c12d-406f-b2bf-470ff8daf17a","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":2312,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmp0olbsy.mozrunner","moz:accessibilityChecks":false}}]
15:45:58 INFO - 1499813158979 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"}]
15:45:58 INFO - 1499813158983 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"
15:45:58 INFO - 1499813158990 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"
15:45:58 INFO - 1499813158991 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"
15:45:58 INFO - ++DOMWINDOW == 23 (0000003E943B3800) [pid = 2312] [serial = 49] [outer = 0000003E8A87E000]
15:45:59 INFO - 1499813159049 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"
15:45:59 INFO - 1499813159055 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"
15:45:59 INFO - 1499813159070 Marionette TRACE 400 <- [1,2,null,{}]
15:45:59 INFO - 1499813159073 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
15:45:59 INFO - 1499813159082 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5705b710-a180-453b-9598-e3c7807a632b","ELEMENT":"5705b710-a180-453b-9598-e3c7807a632b"}}]
15:45:59 INFO - 1499813159084 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"5705b710-a180-453b-9598-e3c7807a632b"}]
15:45:59 INFO - 1499813159209 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
15:45:59 INFO - 1499813159211 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"5705b710-a180-453b-9598-e3c7807a632b"}]
15:45:59 INFO - 1499813159356 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element