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]
17:54:09 INFO - 1500425649984 Marionette TRACE 353 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
17:54:09 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500425649991 Marionette TRACE 353 <- [1,5,null,{"value":null}]
17:54:09 INFO - 1500425649993 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425649997 Marionette TRACE 353 <- [1,6,null,{}]
17:54:10 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1621ms
17:54:10 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425650003 Marionette DEBUG Closed connection 353
17:54:10 INFO - 1500425650005 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49787
17:54:10 INFO - 1500425650009 Marionette DEBUG Closed connection 354
17:54:10 INFO - 1500425650010 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49788
17:54:10 INFO - 1500425650013 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:10 INFO - 1500425650015 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:10 INFO - 1500425650036 Marionette DEBUG Register listener.js for window 15
17:54:10 INFO - 1500425650093 Marionette TRACE 355 <- [1,1,null,{"sessionId":"7e881ffa-dfe4-45cd-9721-46005d630e8a","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:10 INFO - 1500425650099 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
17:54:10 INFO - 1500425650101 Marionette TRACE 355 <- [1,2,null,{}]
17:54:10 INFO - 1500425650103 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:10 INFO - 1500425650104 Marionette TRACE 355 <- [1,3,null,{}]
17:54:10 INFO - 1500425650106 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:10 INFO - 1500425650108 Marionette TRACE 355 <- [1,4,null,{}]
17:54:10 INFO - 1500425650110 Marionette TRACE 355 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
17:54:10 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500425650118 Marionette TRACE 355 <- [1,5,null,{"value":null}]
17:54:10 INFO - 1500425650120 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425650125 Marionette TRACE 355 <- [1,6,null,{}]
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425650130 Marionette DEBUG Closed connection 355
17:54:10 INFO - 1500425650132 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49789
17:54:10 INFO - 1500425650133 Marionette DEBUG Closed connection 356
17:54:10 INFO - 1500425650135 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49790
17:54:10 INFO - 1500425650137 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:10 INFO - 1500425650139 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:10 INFO - 1500425650159 Marionette DEBUG Register listener.js for window 15
17:54:10 INFO - 1500425650170 Marionette TRACE 357 <- [1,1,null,{"sessionId":"97d1879c-f749-4040-a351-ff8c99d8c3f1","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:10 INFO - 1500425650201 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425650205 Marionette TRACE 357 <- [1,2,null,{}]
17:54:10 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:10 INFO - 1500425650213 Marionette DEBUG Closed connection 357
17:54:10 INFO - 1500425650215 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49791
17:54:10 INFO - 1500425650216 Marionette DEBUG Closed connection 358
17:54:10 INFO - 1500425650218 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49792
17:54:10 INFO - 1500425650220 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:10 INFO - 1500425650222 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:10 INFO - 1500425650242 Marionette DEBUG Register listener.js for window 15
17:54:10 INFO - 1500425650253 Marionette TRACE 359 <- [1,1,null,{"sessionId":"c6faaca5-d9c7-4399-9d5a-69ce140dc8b0","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:10 INFO - 1500425650259 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
17:54:10 INFO - 1500425650263 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
17:54:10 INFO - 1500425650274 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
17:54:10 INFO - 1500425650275 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
17:54:10 INFO - ++DOMWINDOW == 28 (00000018530BA000) [pid = 3908] [serial = 40] [outer = 00000018572BB000]
17:54:10 INFO - 1500425650363 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
17:54:10 INFO - 1500425650369 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
17:54:10 INFO - 1500425650391 Marionette TRACE 359 <- [1,2,null,{}]
17:54:10 INFO - 1500425650428 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
17:54:10 INFO - 1500425650441 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"241f3798-6cfd-4813-8703-a40fccb38f74","ELEMENT":"241f3798-6cfd-4813-8703-a40fccb38f74"}}]
17:54:10 INFO - 1500425650446 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"241f3798-6cfd-4813-8703-a40fccb38f74"}]
17:54:10 INFO - 1500425650869 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
17:54:10 INFO - [Parent 3908] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
17:54:10 INFO - 1500425650893 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
17:54:10 INFO - 1500425650897 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
17:54:10 INFO - ++DOMWINDOW == 29 (000000184BD9B000) [pid = 3908] [serial = 41] [outer = 00000018572BB000]
17:54:10 INFO - 1500425650970 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
17:54:10 INFO - 1500425650978 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
17:54:11 INFO - 1500425651000 Marionette TRACE 359 <- [1,4,null,{}]
17:54:11 INFO - 1500425651018 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
17:54:11 INFO - 1500425651032 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3f63c1ab-28e5-487f-b937-0d85a5dcbd5e","ELEMENT":"3f63c1ab-28e5-487f-b937-0d85a5dcbd5e"}}]
17:54:11 INFO - 1500425651035 Marionette TRACE 359 -> [0,6,"getTitle",{}]
17:54:11 INFO - 1500425651038 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
17:54:11 INFO - 1500425651043 Marionette TRACE 359 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
17:54:11 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500425651056 Marionette TRACE 359 <- [1,7,null,{"value":null}]
17:54:11 INFO - 1500425651060 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651069 Marionette TRACE 359 <- [1,8,null,{}]
17:54:11 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1072ms
17:54:11 INFO - TEST-START | test_click.py TestClick.test_container_element
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651128 Marionette DEBUG Closed connection 359
17:54:11 INFO - 1500425651130 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49795
17:54:11 INFO - 1500425651144 Marionette DEBUG Closed connection 360
17:54:11 INFO - 1500425651147 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49796
17:54:11 INFO - 1500425651153 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:11 INFO - 1500425651163 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:11 INFO - 1500425651205 Marionette DEBUG Register listener.js for window 15
17:54:11 INFO - 1500425651225 Marionette TRACE 361 <- [1,1,null,{"sessionId":"53ecd548-826b-4bd1-a067-7ddd7b687037","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:11 INFO - 1500425651242 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
17:54:11 INFO - 1500425651245 Marionette TRACE 361 <- [1,2,null,{}]
17:54:11 INFO - 1500425651249 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:11 INFO - 1500425651252 Marionette TRACE 361 <- [1,3,null,{}]
17:54:11 INFO - 1500425651304 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:11 INFO - 1500425651308 Marionette TRACE 361 <- [1,4,null,{}]
17:54:11 INFO - 1500425651317 Marionette TRACE 361 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
17:54:11 INFO - TEST-START: test_click.py TestClick.test_container_element1500425651331 Marionette TRACE 361 <- [1,5,null,{"value":null}]
17:54:11 INFO - 1500425651335 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651341 Marionette TRACE 361 <- [1,6,null,{}]
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651401 Marionette DEBUG Closed connection 361
17:54:11 INFO - 1500425651404 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49797
17:54:11 INFO - 1500425651426 Marionette DEBUG Closed connection 362
17:54:11 INFO - 1500425651428 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49798
17:54:11 INFO - 1500425651431 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:11 INFO - 1500425651435 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:11 INFO - 1500425651477 Marionette DEBUG Register listener.js for window 15
17:54:11 INFO - 1500425651496 Marionette TRACE 363 <- [1,1,null,{"sessionId":"8cae1e7c-edaa-4f6a-8175-7fbf13ad9f0e","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:11 INFO - 1500425651505 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651512 Marionette TRACE 363 <- [1,2,null,{}]
17:54:11 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:11 INFO - 1500425651540 Marionette DEBUG Closed connection 363
17:54:11 INFO - 1500425651542 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49799
17:54:11 INFO - 1500425651556 Marionette DEBUG Closed connection 364
17:54:11 INFO - 1500425651558 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49800
17:54:11 INFO - 1500425651561 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:11 INFO - 1500425651565 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:11 INFO - 1500425651608 Marionette DEBUG Register listener.js for window 15
17:54:11 INFO - 1500425651625 Marionette TRACE 365 <- [1,1,null,{"sessionId":"ad65359a-f230-4ee6-b0c6-4af2511a24e3","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:11 INFO - 1500425651640 Marionette TRACE 365 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
17:54:11 INFO - 1500425651645 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
17:54:11 INFO - 1500425651652 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
17:54:11 INFO - 1500425651653 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
17:54:11 INFO - ++DOMWINDOW == 30 (00000018530C6000) [pid = 3908] [serial = 42] [outer = 00000018572BB000]
17:54:11 INFO - 1500425651722 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"
17:54:11 INFO - 1500425651730 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"
17:54:11 INFO - 1500425651760 Marionette TRACE 365 <- [1,2,null,{}]
17:54:11 INFO - 1500425651767 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:54:11 INFO - 1500425651778 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"37c7dbf0-9453-443f-adf6-bdfde41629a2","ELEMENT":"37c7dbf0-9453-443f-adf6-bdfde41629a2"}}]
17:54:11 INFO - 1500425651780 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"37c7dbf0-9453-443f-adf6-bdfde41629a2"}]
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
17:54:12 INFO - 1500425652406 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:54:12 INFO - 1500425652409 Marionette TRACE 365 <- [1,4,null,{}]
17:54:12 INFO - 1500425652413 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"37c7dbf0-9453-443f-adf6-bdfde41629a2","name":"selected"}]
17:54:12 INFO - 1500425652471 Marionette TRACE 365 <- [1,5,null,{"value":true}]
17:54:12 INFO - 1500425652479 Marionette TRACE 365 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
17:54:12 INFO - TEST-END: test_click.py TestClick.test_container_element1500425652492 Marionette TRACE 365 <- [1,6,null,{"value":null}]
17:54:12 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1480ms
17:54:12 INFO - 1500425652544 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:12 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
17:54:12 INFO - 1500425652550 Marionette TRACE 365 <- [1,7,null,{}]
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:12 INFO - 1500425652575 Marionette DEBUG Closed connection 365
17:54:12 INFO - 1500425652580 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49801
17:54:12 INFO - 1500425652584 Marionette DEBUG Closed connection 366
17:54:12 INFO - 1500425652587 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49802
17:54:12 INFO - 1500425652604 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:12 INFO - 1500425652607 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:12 INFO - 1500425652651 Marionette DEBUG Register listener.js for window 15
17:54:12 INFO - 1500425652668 Marionette TRACE 367 <- [1,1,null,{"sessionId":"a1b92186-0037-4fd4-a85f-49977c5b6d92","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:12 INFO - 1500425652680 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
17:54:12 INFO - 1500425652682 Marionette TRACE 367 <- [1,2,null,{}]
17:54:12 INFO - 1500425652699 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:12 INFO - 1500425652701 Marionette TRACE 367 <- [1,3,null,{}]
17:54:12 INFO - 1500425652704 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:12 INFO - 1500425652706 Marionette TRACE 367 <- [1,4,null,{}]
17:54:12 INFO - 1500425652710 Marionette TRACE 367 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
17:54:12 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500425652721 Marionette TRACE 367 <- [1,5,null,{"value":null}]
17:54:12 INFO - 1500425652899 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:12 INFO - 1500425652912 Marionette TRACE 367 <- [1,6,null,{}]
17:54:12 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:12 INFO - 1500425652940 Marionette DEBUG Closed connection 367
17:54:12 INFO - 1500425652943 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49803
17:54:13 INFO - 1500425652996 Marionette DEBUG Closed connection 368
17:54:13 INFO - 1500425652999 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49804
17:54:13 INFO - 1500425653009 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:13 INFO - 1500425653018 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:13 INFO - 1500425653042 Marionette DEBUG Register listener.js for window 15
17:54:13 INFO - 1500425653061 Marionette TRACE 369 <- [1,1,null,{"sessionId":"6f528abc-9824-4a36-8e25-04a73c216389","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:13 INFO - 1500425653079 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
17:54:13 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:13 INFO - 1500425653087 Marionette TRACE 369 <- [1,2,null,{}]
17:54:13 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:13 INFO - 1500425653139 Marionette DEBUG Closed connection 369
17:54:13 INFO - 1500425653142 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49805
17:54:13 INFO - 1500425653167 Marionette DEBUG Closed connection 370
17:54:13 INFO - 1500425653169 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49806
17:54:13 INFO - 1500425653174 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:13 INFO - 1500425653179 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:13 INFO - 1500425653202 Marionette DEBUG Register listener.js for window 15
17:54:13 INFO - 1500425653219 Marionette TRACE 371 <- [1,1,null,{"sessionId":"8acd2423-4e24-4aa2-ac56-6aca3f903126","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:13 INFO - 1500425653230 Marionette TRACE 371 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
17:54:13 INFO - 1500425653238 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"
17:54:13 INFO - 1500425653246 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"
17:54:13 INFO - 1500425653247 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"
17:54:13 INFO - ++DOMWINDOW == 31 (000000184AAE0800) [pid = 3908] [serial = 43] [outer = 00000018572BB000]
17:54:13 INFO - 1500425653301 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"
17:54:13 INFO - 1500425653310 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"
17:54:13 INFO - 1500425653330 Marionette TRACE 371 <- [1,2,null,{}]
17:54:13 INFO - 1500425653343 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:54:13 INFO - 1500425653355 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"78500a41-fa52-4bb8-b458-46a30ba13937","ELEMENT":"78500a41-fa52-4bb8-b458-46a30ba13937"}}]
17:54:13 INFO - 1500425653358 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"78500a41-fa52-4bb8-b458-46a30ba13937"}]
17:54:13 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
17:54:13 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
17:54:13 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
17:54:13 INFO - --DOMWINDOW == 30 (000000185E2A7000) [pid = 3908] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 29 (0000001851558000) [pid = 3908] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 28 (0000001853088800) [pid = 3908] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 27 (000000184D03B000) [pid = 3908] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 26 (000000184AE70000) [pid = 3908] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 25 (000000185B0DF800) [pid = 3908] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 24 (000000185E2BD800) [pid = 3908] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:13 INFO - --DOMWINDOW == 23 (000000186041B000) [pid = 3908] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
17:54:14 INFO - 1500425654509 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:54:14 INFO - 1500425654531 Marionette TRACE 371 <- [1,4,null,{}]
17:54:14 INFO - 1500425654538 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"78500a41-fa52-4bb8-b458-46a30ba13937","name":"selected"}]
17:54:14 INFO - 1500425654570 Marionette TRACE 371 <- [1,5,null,{"value":true}]
17:54:14 INFO - 1500425654573 Marionette TRACE 371 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
17:54:14 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500425654624 Marionette TRACE 371 <- [1,6,null,{"value":null}]
17:54:14 INFO - 1500425654675 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
17:54:14 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:14 INFO - 1500425654681 Marionette TRACE 371 <- [1,7,null,{}]
17:54:14 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 2130ms
17:54:14 INFO - TEST-START | test_click.py TestClick.test_css_transforms
17:54:14 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:14 INFO - 1500425654688 Marionette DEBUG Closed connection 371
17:54:14 INFO - 1500425654689 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49807
17:54:14 INFO - 1500425654738 Marionette DEBUG Closed connection 372
17:54:14 INFO - 1500425654740 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49808
17:54:14 INFO - 1500425654797 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:14 INFO - 1500425654802 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:14 INFO - 1500425654824 Marionette DEBUG Register listener.js for window 15
17:54:14 INFO - 1500425654840 Marionette TRACE 373 <- [1,1,null,{"sessionId":"76141283-5a78-47a9-ba9b-b1e81c4e7acd","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:14 INFO - 1500425654898 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
17:54:14 INFO - 1500425654900 Marionette TRACE 373 <- [1,2,null,{}]
17:54:14 INFO - 1500425654915 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:14 INFO - 1500425654917 Marionette TRACE 373 <- [1,3,null,{}]
17:54:14 INFO - 1500425654935 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:14 INFO - 1500425654938 Marionette TRACE 373 <- [1,4,null,{}]
17:54:14 INFO - 1500425654941 Marionette TRACE 373 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
17:54:14 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500425654950 Marionette TRACE 373 <- [1,5,null,{"value":null}]
17:54:14 INFO - 1500425654954 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
17:54:14 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:14 INFO - 1500425654958 Marionette TRACE 373 <- [1,6,null,{}]
17:54:14 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:14 INFO - 1500425654981 Marionette DEBUG Closed connection 373
17:54:14 INFO - 1500425654983 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49809
17:54:14 INFO - 1500425654987 Marionette DEBUG Closed connection 374
17:54:14 INFO - 1500425654990 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49810
17:54:14 INFO - 1500425654992 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:14 INFO - 1500425654994 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:15 INFO - 1500425655018 Marionette DEBUG Register listener.js for window 15
17:54:15 INFO - 1500425655031 Marionette TRACE 375 <- [1,1,null,{"sessionId":"fb8a7f5e-870b-4b3a-b4cf-fb0fe658f777","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:15 INFO - 1500425655043 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655047 Marionette TRACE 375 <- [1,2,null,{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655069 Marionette DEBUG Closed connection 375
17:54:15 INFO - 1500425655071 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49811
17:54:15 INFO - 1500425655076 Marionette DEBUG Closed connection 376
17:54:15 INFO - 1500425655078 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49812
17:54:15 INFO - 1500425655080 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:15 INFO - 1500425655086 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:15 INFO - 1500425655109 Marionette DEBUG Register listener.js for window 15
17:54:15 INFO - 1500425655125 Marionette TRACE 377 <- [1,1,null,{"sessionId":"ed2320be-8c30-446a-8548-d7f7116852f5","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:15 INFO - 1500425655134 Marionette TRACE 377 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
17:54:15 INFO - 1500425655139 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"
17:54:15 INFO - 1500425655146 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"
17:54:15 INFO - 1500425655147 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"
17:54:15 INFO - ++DOMWINDOW == 24 (0000001850D1F800) [pid = 3908] [serial = 44] [outer = 00000018572BB000]
17:54:15 INFO - 1500425655203 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"
17:54:15 INFO - 1500425655212 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"
17:54:15 INFO - 1500425655229 Marionette TRACE 377 <- [1,2,null,{}]
17:54:15 INFO - 1500425655236 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
17:54:15 INFO - 1500425655246 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"59543ae4-7ae8-4bf4-b361-dded8bee53ac","ELEMENT":"59543ae4-7ae8-4bf4-b361-dded8bee53ac"}}]
17:54:15 INFO - 1500425655250 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"59543ae4-7ae8-4bf4-b361-dded8bee53ac"}]
17:54:15 INFO - 1500425655682 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:54:15 INFO - 1500425655684 Marionette TRACE 377 <- [1,4,null,{}]
17:54:15 INFO - 1500425655687 Marionette TRACE 377 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
17:54:15 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500425655695 Marionette TRACE 377 <- [1,5,null,{"value":null}]
17:54:15 INFO - 1500425655697 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655702 Marionette TRACE 377 <- [1,6,null,{}]
17:54:15 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1020ms
17:54:15 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655710 Marionette DEBUG Closed connection 377
17:54:15 INFO - 1500425655715 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49813
17:54:15 INFO - 1500425655731 Marionette DEBUG Closed connection 378
17:54:15 INFO - 1500425655733 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49814
17:54:15 INFO - 1500425655735 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:15 INFO - 1500425655737 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:15 INFO - 1500425655759 Marionette DEBUG Register listener.js for window 15
17:54:15 INFO - 1500425655775 Marionette TRACE 379 <- [1,1,null,{"sessionId":"410c8a73-1fb6-4fa6-8cf1-e17e807ada6e","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:15 INFO - 1500425655808 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
17:54:15 INFO - 1500425655809 Marionette TRACE 379 <- [1,2,null,{}]
17:54:15 INFO - 1500425655811 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:15 INFO - 1500425655813 Marionette TRACE 379 <- [1,3,null,{}]
17:54:15 INFO - 1500425655815 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:15 INFO - 1500425655816 Marionette TRACE 379 <- [1,4,null,{}]
17:54:15 INFO - 1500425655819 Marionette TRACE 379 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
17:54:15 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500425655833 Marionette TRACE 379 <- [1,5,null,{"value":null}]
17:54:15 INFO - 1500425655835 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655840 Marionette TRACE 379 <- [1,6,null,{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655865 Marionette DEBUG Closed connection 379
17:54:15 INFO - 1500425655866 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49815
17:54:15 INFO - 1500425655868 Marionette DEBUG Closed connection 380
17:54:15 INFO - 1500425655869 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49816
17:54:15 INFO - 1500425655871 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:15 INFO - 1500425655874 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:15 INFO - 1500425655895 Marionette DEBUG Register listener.js for window 15
17:54:15 INFO - 1500425655907 Marionette TRACE 381 <- [1,1,null,{"sessionId":"5cd048f7-c3ef-47af-bcbc-416394269bc5","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:15 INFO - 1500425655919 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655923 Marionette TRACE 381 <- [1,2,null,{}]
17:54:15 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:15 INFO - 1500425655929 Marionette DEBUG Closed connection 381
17:54:15 INFO - 1500425655931 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49817
17:54:15 INFO - 1500425655932 Marionette DEBUG Closed connection 382
17:54:15 INFO - 1500425655935 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49818
17:54:15 INFO - 1500425655937 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:15 INFO - 1500425655940 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:15 INFO - 1500425655963 Marionette DEBUG Register listener.js for window 15
17:54:15 INFO - 1500425655975 Marionette TRACE 383 <- [1,1,null,{"sessionId":"69cf8b5a-b0f5-46c9-98c2-87073b42a15b","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:15 INFO - 1500425655981 Marionette TRACE 383 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
17:54:15 INFO - 1500425655985 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"
17:54:15 INFO - 1500425655992 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"
17:54:15 INFO - 1500425655993 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"
17:54:15 INFO - ++DOMWINDOW == 25 (00000018530CE000) [pid = 3908] [serial = 45] [outer = 00000018572BB000]
17:54:16 INFO - 1500425656049 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"
17:54:16 INFO - 1500425656055 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"
17:54:16 INFO - 1500425656073 Marionette TRACE 383 <- [1,2,null,{}]
17:54:16 INFO - 1500425656076 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
17:54:16 INFO - 1500425656085 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0006a46d-cf1c-403d-a0e0-b8525a7ae611","ELEMENT":"0006a46d-cf1c-403d-a0e0-b8525a7ae611"}}]
17:54:16 INFO - 1500425656087 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"0006a46d-cf1c-403d-a0e0-b8525a7ae611"}]
17:54:17 INFO - 1500425657189 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:54:17 INFO - 1500425657192 Marionette TRACE 383 <- [1,4,null,{}]
17:54:17 INFO - 1500425657231 Marionette TRACE 383 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
17:54:17 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500425657239 Marionette TRACE 383 <- [1,5,null,{"value":null}]
17:54:17 INFO - 1500425657272 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657277 Marionette TRACE 383 <- [1,6,null,{}]
17:54:17 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1574ms
17:54:17 INFO - TEST-START | test_click.py TestClick.test_input_file
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657283 Marionette DEBUG Closed connection 383
17:54:17 INFO - 1500425657285 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49819
17:54:17 INFO - 1500425657286 Marionette DEBUG Closed connection 384
17:54:17 INFO - 1500425657288 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49820
17:54:17 INFO - 1500425657290 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:17 INFO - 1500425657292 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:17 INFO - 1500425657315 Marionette DEBUG Register listener.js for window 15
17:54:17 INFO - 1500425657327 Marionette TRACE 385 <- [1,1,null,{"sessionId":"e1b59da6-d7db-496a-b6cd-99b98c89b57e","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:17 INFO - 1500425657333 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
17:54:17 INFO - 1500425657335 Marionette TRACE 385 <- [1,2,null,{}]
17:54:17 INFO - 1500425657337 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:17 INFO - 1500425657338 Marionette TRACE 385 <- [1,3,null,{}]
17:54:17 INFO - 1500425657368 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:17 INFO - 1500425657370 Marionette TRACE 385 <- [1,4,null,{}]
17:54:17 INFO - 1500425657373 Marionette TRACE 385 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
17:54:17 INFO - TEST-START: test_click.py TestClick.test_input_file1500425657382 Marionette TRACE 385 <- [1,5,null,{"value":null}]
17:54:17 INFO - 1500425657384 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657388 Marionette TRACE 385 <- [1,6,null,{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657412 Marionette DEBUG Closed connection 385
17:54:17 INFO - 1500425657414 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49821
17:54:17 INFO - 1500425657417 Marionette DEBUG Closed connection 386
17:54:17 INFO - 1500425657419 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49822
17:54:17 INFO - 1500425657421 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:17 INFO - 1500425657423 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:17 INFO - 1500425657445 Marionette DEBUG Register listener.js for window 15
17:54:17 INFO - 1500425657457 Marionette TRACE 387 <- [1,1,null,{"sessionId":"04473e50-cd45-471c-9cd7-f380ada85811","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:17 INFO - 1500425657467 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657471 Marionette TRACE 387 <- [1,2,null,{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657493 Marionette DEBUG Closed connection 387
17:54:17 INFO - 1500425657495 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49823
17:54:17 INFO - 1500425657499 Marionette DEBUG Closed connection 388
17:54:17 INFO - 1500425657500 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49824
17:54:17 INFO - 1500425657503 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:17 INFO - 1500425657506 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:17 INFO - 1500425657533 Marionette DEBUG Register listener.js for window 15
17:54:17 INFO - 1500425657547 Marionette TRACE 389 <- [1,1,null,{"sessionId":"c16bf816-e03e-427d-9037-19681c2b4846","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:17 INFO - 1500425657557 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
17:54:17 INFO - 1500425657562 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"
17:54:17 INFO - 1500425657568 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"
17:54:17 INFO - 1500425657570 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"
17:54:17 INFO - ++DOMWINDOW == 26 (0000001855932800) [pid = 3908] [serial = 46] [outer = 00000018572BB000]
17:54:17 INFO - 1500425657619 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:54:17 INFO - 1500425657636 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:54:17 INFO - 1500425657644 Marionette TRACE 389 <- [1,2,null,{}]
17:54:17 INFO - 1500425657654 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
17:54:17 INFO - 1500425657663 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8a607596-1ab3-4dd3-ab32-d3d3f2a25dbf","ELEMENT":"8a607596-1ab3-4dd3-ab32-d3d3f2a25dbf"}}]
17:54:17 INFO - 1500425657670 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"8a607596-1ab3-4dd3-ab32-d3d3f2a25dbf"}]
17:54:17 INFO - 1500425657833 Marionette TRACE 389 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
17:54:17 INFO - 1500425657837 Marionette TRACE 389 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
17:54:17 INFO - TEST-END: test_click.py TestClick.test_input_file1500425657845 Marionette TRACE 389 <- [1,5,null,{"value":null}]
17:54:17 INFO - 1500425657898 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657908 Marionette TRACE 389 <- [1,6,null,{}]
17:54:17 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 632ms
17:54:17 INFO - TEST-START | test_click.py TestClick.test_obscured_element
17:54:17 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:17 INFO - 1500425657937 Marionette DEBUG Closed connection 389
17:54:17 INFO - 1500425657940 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49825
17:54:18 INFO - 1500425657993 Marionette DEBUG Closed connection 390
17:54:18 INFO - 1500425657996 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49826
17:54:18 INFO - 1500425658004 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:18 INFO - 1500425658014 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:18 INFO - 1500425658062 Marionette DEBUG Register listener.js for window 15
17:54:18 INFO - 1500425658084 Marionette TRACE 391 <- [1,1,null,{"sessionId":"552917c6-f17f-42d9-a129-cfb1a90c5bbe","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:18 INFO - 1500425658104 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
17:54:18 INFO - 1500425658108 Marionette TRACE 391 <- [1,2,null,{}]
17:54:18 INFO - 1500425658163 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:18 INFO - 1500425658168 Marionette TRACE 391 <- [1,3,null,{}]
17:54:18 INFO - 1500425658173 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:18 INFO - 1500425658176 Marionette TRACE 391 <- [1,4,null,{}]
17:54:18 INFO - 1500425658180 Marionette TRACE 391 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
17:54:18 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500425658197 Marionette TRACE 391 <- [1,5,null,{"value":null}]
17:54:18 INFO - 1500425658199 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
17:54:18 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:18 INFO - 1500425658207 Marionette TRACE 391 <- [1,6,null,{}]
17:54:18 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:18 INFO - 1500425658217 Marionette DEBUG Closed connection 391
17:54:18 INFO - 1500425658220 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49827
17:54:18 INFO - 1500425658223 Marionette DEBUG Closed connection 392
17:54:18 INFO - 1500425658225 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49828
17:54:18 INFO - 1500425658230 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:18 INFO - 1500425658234 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:18 INFO - 1500425658281 Marionette DEBUG Register listener.js for window 15
17:54:18 INFO - 1500425658309 Marionette TRACE 393 <- [1,1,null,{"sessionId":"206ea566-a4cb-49cf-ad31-258775d1a4cd","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:18 INFO - 1500425658343 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
17:54:18 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:18 INFO - 1500425658350 Marionette TRACE 393 <- [1,2,null,{}]
17:54:18 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:18 INFO - 1500425658374 Marionette DEBUG Closed connection 393
17:54:18 INFO - 1500425658376 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49829
17:54:18 INFO - 1500425658402 Marionette DEBUG Closed connection 394
17:54:18 INFO - 1500425658404 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49830
17:54:18 INFO - 1500425658411 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:18 INFO - 1500425658415 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:18 INFO - 1500425658463 Marionette DEBUG Register listener.js for window 15
17:54:18 INFO - 1500425658480 Marionette TRACE 395 <- [1,1,null,{"sessionId":"8635028d-4e03-4ee6-970c-718f98fba1e5","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:18 INFO - 1500425658497 Marionette TRACE 395 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
17:54:18 INFO - 1500425658505 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:54:18 INFO - 1500425658514 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:54:18 INFO - 1500425658515 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:54:18 INFO - ++DOMWINDOW == 27 (000000184F4A3800) [pid = 3908] [serial = 47] [outer = 00000018572BB000]
17:54:18 INFO - 1500425658628 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"
17:54:18 INFO - 1500425658636 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"
17:54:18 INFO - 1500425658658 Marionette TRACE 395 <- [1,2,null,{}]
17:54:18 INFO - 1500425658661 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
17:54:18 INFO - 1500425658671 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c9e8c228-8275-4507-8603-7a549d09bbdd","ELEMENT":"c9e8c228-8275-4507-8603-7a549d09bbdd"}}]
17:54:18 INFO - 1500425658673 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
17:54:18 INFO - 1500425658683 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"56190d9f-7067-42a8-8bbd-ab1c84197f60","ELEMENT":"56190d9f-7067-42a8-8bbd-ab1c84197f60"}}]
17:54:18 INFO - 1500425658686 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"c9e8c228-8275-4507-8603-7a549d09bbdd"}]
17:54:19 INFO - 1500425659313 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:54:19 INFO - 1500425659316 Marionette TRACE 395 <- [1,5,null,{}]
17:54:19 INFO - 1500425659320 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"56190d9f-7067-42a8-8bbd-ab1c84197f60"}]
17:54:19 INFO - 1500425659611 Marionette TRACE 395 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
17:54:19 INFO - 1500425659655 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
17:54:19 INFO - 1500425659669 Marionette TRACE 395 <- [1,7,null,{"value":false}]
17:54:19 INFO - 1500425659672 Marionette TRACE 395 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
17:54:19 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500425659683 Marionette TRACE 395 <- [1,8,null,{"value":null}]
17:54:19 INFO - 1500425659685 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
17:54:19 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:19 INFO - 1500425659690 Marionette TRACE 395 <- [1,9,null,{}]
17:54:19 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1781ms
17:54:19 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
17:54:19 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:19 INFO - 1500425659713 Marionette DEBUG Closed connection 395
17:54:19 INFO - 1500425659715 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49831
17:54:19 INFO - 1500425659739 Marionette DEBUG Closed connection 396
17:54:19 INFO - 1500425659742 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49832
17:54:19 INFO - 1500425659745 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:19 INFO - 1500425659749 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:19 INFO - 1500425659796 Marionette DEBUG Register listener.js for window 15
17:54:19 INFO - 1500425659811 Marionette TRACE 397 <- [1,1,null,{"sessionId":"ca4e8d7b-a487-4844-a6d9-e0980f2fb523","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:19 INFO - 1500425659844 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
17:54:19 INFO - 1500425659846 Marionette TRACE 397 <- [1,2,null,{}]
17:54:19 INFO - 1500425659852 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:54:19 INFO - 1500425659854 Marionette TRACE 397 <- [1,3,null,{}]
17:54:19 INFO - 1500425659856 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
17:54:19 INFO - 1500425659858 Marionette TRACE 397 <- [1,4,null,{}]
17:54:19 INFO - 1500425659869 Marionette TRACE 397 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
17:54:19 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500425659879 Marionette TRACE 397 <- [1,5,null,{"value":null}]
17:54:19 INFO - 1500425659883 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
17:54:19 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:19 INFO - 1500425659888 Marionette TRACE 397 <- [1,6,null,{}]
17:54:19 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:19 INFO - 1500425659912 Marionette DEBUG Closed connection 397
17:54:19 INFO - 1500425659915 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49833
17:54:20 INFO - 1500425660083 Marionette DEBUG Closed connection 398
17:54:20 INFO - 1500425660086 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49834
17:54:20 INFO - 1500425660091 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:54:20 INFO - 1500425660102 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:20 INFO - 1500425660129 Marionette DEBUG Register listener.js for window 15
17:54:20 INFO - 1500425660150 Marionette TRACE 399 <- [1,1,null,{"sessionId":"77bbcc5a-6d4e-4059-b141-963b4b8c347a","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:20 INFO - 1500425660169 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
17:54:20 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:20 INFO - 1500425660176 Marionette TRACE 399 <- [1,2,null,{}]
17:54:20 INFO - [Parent 3908] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:54:20 INFO - 1500425660193 Marionette DEBUG Closed connection 399
17:54:20 INFO - 1500425660195 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49835
17:54:20 INFO - 1500425660219 Marionette DEBUG Closed connection 400
17:54:20 INFO - 1500425660224 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49836
17:54:20 INFO - 1500425660230 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:54:20 INFO - 1500425660237 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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}
17:54:20 INFO - 1500425660263 Marionette DEBUG Register listener.js for window 15
17:54:20 INFO - 1500425660280 Marionette TRACE 401 <- [1,1,null,{"sessionId":"4e986b13-d97d-47ce-8b77-49a7dcd99e99","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":3908,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-104\\AppData\\Local\\Temp\\tmplokdxd.mozrunner","moz:accessibilityChecks":false}}]
17:54:20 INFO - 1500425660327 Marionette TRACE 401 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
17:54:20 INFO - 1500425660333 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"
17:54:20 INFO - 1500425660341 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"
17:54:20 INFO - 1500425660342 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"
17:54:20 INFO - ++DOMWINDOW == 28 (000000184D1D7000) [pid = 3908] [serial = 48] [outer = 00000018572BB000]
17:54:20 INFO - 1500425660403 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"
17:54:20 INFO - 1500425660411 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"
17:54:20 INFO - 1500425660429 Marionette TRACE 401 <- [1,2,null,{}]
17:54:20 INFO - 1500425660444 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
17:54:20 INFO - 1500425660455 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3887393f-ba17-4781-b7ab-dc3427c6fe59","ELEMENT":"3887393f-ba17-4781-b7ab-dc3427c6fe59"}}]
17:54:20 INFO - 1500425660458 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"3887393f-ba17-4781-b7ab-dc3427c6fe59"}]
17:54:20 INFO - 1500425660601 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
17:54:20 INFO - 1500425660604 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"3887393f-ba17-4781-b7ab-dc3427c6fe59"}]
17:54:20 INFO - 1500425660772 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element