could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
17:33:57 INFO - 1500942837610 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
17:33:57 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500942837618 Marionette TRACE 352 <- [1,5,null,{"value":null}]
17:33:57 INFO - 1500942837620 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837624 Marionette TRACE 352 <- [1,6,null,{}]
17:33:57 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 627ms
17:33:57 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837630 Marionette DEBUG Closed connection 352
17:33:57 INFO - 1500942837632 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49782
17:33:57 INFO - 1500942837633 Marionette DEBUG Closed connection 353
17:33:57 INFO - 1500942837634 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49783
17:33:57 INFO - 1500942837637 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:33:57 INFO - 1500942837639 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:57 INFO - 1500942837660 Marionette DEBUG Register listener.js for window 12
17:33:57 INFO - 1500942837711 Marionette TRACE 354 <- [1,1,null,{"sessionId":"8af5884c-e625-441f-83c1-7141f4ac4f14","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:57 INFO - 1500942837718 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
17:33:57 INFO - 1500942837720 Marionette TRACE 354 <- [1,2,null,{}]
17:33:57 INFO - 1500942837721 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:33:57 INFO - 1500942837723 Marionette TRACE 354 <- [1,3,null,{}]
17:33:57 INFO - 1500942837725 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
17:33:57 INFO - 1500942837727 Marionette TRACE 354 <- [1,4,null,{}]
17:33:57 INFO - 1500942837729 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
17:33:57 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500942837738 Marionette TRACE 354 <- [1,5,null,{"value":null}]
17:33:57 INFO - 1500942837739 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837744 Marionette TRACE 354 <- [1,6,null,{}]
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837750 Marionette DEBUG Closed connection 354
17:33:57 INFO - 1500942837751 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49784
17:33:57 INFO - 1500942837753 Marionette DEBUG Closed connection 355
17:33:57 INFO - 1500942837755 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49785
17:33:57 INFO - 1500942837776 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:33:57 INFO - 1500942837788 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:57 INFO - 1500942837813 Marionette DEBUG Register listener.js for window 12
17:33:57 INFO - 1500942837827 Marionette TRACE 356 <- [1,1,null,{"sessionId":"4808ef06-d76e-44fd-84c1-fc1604744709","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:57 INFO - 1500942837836 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837841 Marionette TRACE 356 <- [1,2,null,{}]
17:33:57 INFO - [Parent 3276] 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:33:57 INFO - 1500942837862 Marionette DEBUG Closed connection 356
17:33:57 INFO - 1500942837864 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49786
17:33:57 INFO - 1500942837867 Marionette DEBUG Closed connection 357
17:33:57 INFO - 1500942837868 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49787
17:33:57 INFO - 1500942837871 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:33:57 INFO - 1500942837873 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:57 INFO - 1500942837894 Marionette DEBUG Register listener.js for window 12
17:33:57 INFO - 1500942837905 Marionette TRACE 358 <- [1,1,null,{"sessionId":"2b4cce41-4504-42aa-8187-9710c4b3d640","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:57 INFO - 1500942837915 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49334/clicks.html"}]
17:33:57 INFO - 1500942837919 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/hidden.html"
17:33:57 INFO - 1500942837940 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/hidden.html"
17:33:57 INFO - 1500942837941 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/hidden.html"
17:33:57 INFO - ++DOMWINDOW == 20 (000000E84FB35000) [pid = 3276] [serial = 41] [outer = 000000E84F906000]
17:33:58 INFO - 1500942838013 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/clicks.html"
17:33:58 INFO - 1500942838022 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/clicks.html"
17:33:58 INFO - 1500942838039 Marionette TRACE 358 <- [1,2,null,{}]
17:33:58 INFO - 1500942838050 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
17:33:58 INFO - 1500942838057 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b404da32-1bda-48e1-afa6-ea2ba0de8bd7","ELEMENT":"b404da32-1bda-48e1-afa6-ea2ba0de8bd7"}}]
17:33:58 INFO - 1500942838060 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"b404da32-1bda-48e1-afa6-ea2ba0de8bd7"}]
17:33:58 INFO - 1500942838272 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/clicks.html"
17:33:58 INFO - [Parent 3276] 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:33:58 INFO - 1500942838290 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/clicks.html"
17:33:58 INFO - 1500942838291 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/clicks.html"
17:33:58 INFO - ++DOMWINDOW == 21 (000000E85081C800) [pid = 3276] [serial = 42] [outer = 000000E84F906000]
17:33:58 INFO - 1500942838356 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/test.html"
17:33:58 INFO - 1500942838361 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/test.html"
17:33:58 INFO - 1500942838377 Marionette TRACE 358 <- [1,4,null,{}]
17:33:58 INFO - 1500942838387 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
17:33:58 INFO - 1500942838394 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5b817c83-815c-4a8b-8bb3-284df5e8c3f6","ELEMENT":"5b817c83-815c-4a8b-8bb3-284df5e8c3f6"}}]
17:33:58 INFO - 1500942838396 Marionette TRACE 358 -> [0,6,"getTitle",{}]
17:33:58 INFO - 1500942838398 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
17:33:58 INFO - 1500942838400 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
17:33:58 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500942838408 Marionette TRACE 358 <- [1,7,null,{"value":null}]
17:33:58 INFO - 1500942838410 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
17:33:58 INFO - [Parent 3276] 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:33:58 INFO - 1500942838414 Marionette TRACE 358 <- [1,8,null,{}]
17:33:58 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 789ms
17:33:58 INFO - TEST-START | test_click.py TestClick.test_container_element
17:33:58 INFO - [Parent 3276] 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:33:58 INFO - 1500942838420 Marionette DEBUG Closed connection 358
17:33:58 INFO - 1500942838422 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49790
17:33:58 INFO - 1500942838423 Marionette DEBUG Closed connection 359
17:33:58 INFO - 1500942838425 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49791
17:33:58 INFO - 1500942838427 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:33:58 INFO - 1500942838429 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:58 INFO - 1500942838450 Marionette DEBUG Register listener.js for window 12
17:33:58 INFO - 1500942838461 Marionette TRACE 360 <- [1,1,null,{"sessionId":"a6753dbb-ef25-42c0-b8fb-52ad396dbeba","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:58 INFO - 1500942838467 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
17:33:58 INFO - 1500942838469 Marionette TRACE 360 <- [1,2,null,{}]
17:33:58 INFO - 1500942838493 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:33:58 INFO - 1500942838495 Marionette TRACE 360 <- [1,3,null,{}]
17:33:58 INFO - 1500942838499 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
17:33:58 INFO - 1500942838501 Marionette TRACE 360 <- [1,4,null,{}]
17:33:59 INFO - 1500942839103 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
17:33:59 INFO - TEST-START: test_click.py TestClick.test_container_element1500942839115 Marionette TRACE 360 <- [1,5,null,{"value":null}]
17:33:59 INFO - 1500942839119 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839123 Marionette TRACE 360 <- [1,6,null,{}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839163 Marionette DEBUG Closed connection 360
17:33:59 INFO - 1500942839164 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49792
17:33:59 INFO - 1500942839208 Marionette DEBUG Closed connection 361
17:33:59 INFO - 1500942839210 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49793
17:33:59 INFO - 1500942839219 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:33:59 INFO - 1500942839221 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:59 INFO - 1500942839243 Marionette DEBUG Register listener.js for window 12
17:33:59 INFO - 1500942839255 Marionette TRACE 362 <- [1,1,null,{"sessionId":"cd978988-8174-41e2-91c7-302651eb8468","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:59 INFO - 1500942839265 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839269 Marionette TRACE 362 <- [1,2,null,{}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839290 Marionette DEBUG Closed connection 362
17:33:59 INFO - 1500942839292 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49794
17:33:59 INFO - 1500942839296 Marionette DEBUG Closed connection 363
17:33:59 INFO - 1500942839299 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49795
17:33:59 INFO - 1500942839301 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:33:59 INFO - 1500942839303 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:33:59 INFO - 1500942839325 Marionette DEBUG Register listener.js for window 12
17:33:59 INFO - 1500942839336 Marionette TRACE 364 <- [1,1,null,{"sessionId":"8cf9eeb5-4389-45be-a78b-65d865888821","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:33:59 INFO - 1500942839345 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
17:33:59 INFO - 1500942839349 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/test.html"
17:33:59 INFO - 1500942839355 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/test.html"
17:33:59 INFO - 1500942839356 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/test.html"
17:33:59 INFO - ++DOMWINDOW == 22 (000000E857CC4800) [pid = 3276] [serial = 43] [outer = 000000E84F906000]
17:33:59 INFO - 1500942839406 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:33:59 INFO - 1500942839414 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:33:59 INFO - 1500942839431 Marionette TRACE 364 <- [1,2,null,{}]
17:33:59 INFO - 1500942839441 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:33:59 INFO - 1500942839450 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a4a9b856-2b5b-46cc-9a95-a07519ffb2e9","ELEMENT":"a4a9b856-2b5b-46cc-9a95-a07519ffb2e9"}}]
17:33:59 INFO - 1500942839452 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"a4a9b856-2b5b-46cc-9a95-a07519ffb2e9"}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - [Parent 3276] 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:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839871 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:33:59 INFO - 1500942839874 Marionette TRACE 364 <- [1,4,null,{}]
17:33:59 INFO - 1500942839880 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"a4a9b856-2b5b-46cc-9a95-a07519ffb2e9","name":"selected"}]
17:33:59 INFO - 1500942839922 Marionette TRACE 364 <- [1,5,null,{"value":true}]
17:33:59 INFO - 1500942839931 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
17:33:59 INFO - TEST-END: test_click.py TestClick.test_container_element1500942839946 Marionette TRACE 364 <- [1,6,null,{"value":null}]
17:33:59 INFO - 1500942839965 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839975 Marionette TRACE 364 <- [1,7,null,{}]
17:33:59 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1561ms
17:33:59 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
17:33:59 INFO - [Parent 3276] 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:33:59 INFO - 1500942839987 Marionette DEBUG Closed connection 364
17:33:59 INFO - 1500942839990 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49796
17:33:59 INFO - 1500942839994 Marionette DEBUG Closed connection 365
17:34:00 INFO - 1500942839998 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49797
17:34:00 INFO - 1500942840021 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:00 INFO - 1500942840031 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:00 INFO - 1500942840073 Marionette DEBUG Register listener.js for window 12
17:34:00 INFO - 1500942840106 Marionette TRACE 366 <- [1,1,null,{"sessionId":"4bb4c584-c182-4650-bafe-b2849599dfe0","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:00 INFO - 1500942840123 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
17:34:00 INFO - 1500942840128 Marionette TRACE 366 <- [1,2,null,{}]
17:34:00 INFO - 1500942840181 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:00 INFO - 1500942840183 Marionette TRACE 366 <- [1,3,null,{}]
17:34:00 INFO - 1500942840187 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:00 INFO - 1500942840189 Marionette TRACE 366 <- [1,4,null,{}]
17:34:00 INFO - 1500942840193 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
17:34:00 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500942840206 Marionette TRACE 366 <- [1,5,null,{"value":null}]
17:34:00 INFO - 1500942840210 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
17:34:00 INFO - [Parent 3276] 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:34:00 INFO - 1500942840216 Marionette TRACE 366 <- [1,6,null,{}]
17:34:00 INFO - [Parent 3276] 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:34:00 INFO - 1500942840275 Marionette DEBUG Closed connection 366
17:34:00 INFO - 1500942840278 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49798
17:34:00 INFO - 1500942840298 Marionette DEBUG Closed connection 367
17:34:00 INFO - 1500942840300 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49799
17:34:00 INFO - 1500942840304 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:00 INFO - 1500942840307 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:00 INFO - 1500942840350 Marionette DEBUG Register listener.js for window 12
17:34:00 INFO - 1500942840385 Marionette TRACE 368 <- [1,1,null,{"sessionId":"5fbe8af9-ab7f-4b6b-989e-1ffba6ec7538","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:00 INFO - 1500942840407 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
17:34:00 INFO - [Parent 3276] 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:34:00 INFO - 1500942840416 Marionette TRACE 368 <- [1,2,null,{}]
17:34:00 INFO - [Parent 3276] 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:34:00 INFO - 1500942840424 Marionette DEBUG Closed connection 368
17:34:00 INFO - 1500942840426 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49800
17:34:00 INFO - 1500942840450 Marionette DEBUG Closed connection 369
17:34:00 INFO - 1500942840453 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49801
17:34:00 INFO - 1500942840468 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:00 INFO - 1500942840473 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:00 INFO - 1500942840517 Marionette DEBUG Register listener.js for window 12
17:34:00 INFO - 1500942840533 Marionette TRACE 370 <- [1,1,null,{"sessionId":"40195185-94ff-4bc5-ae89-b0939732ab4c","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:00 INFO - 1500942840546 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
17:34:00 INFO - 1500942840551 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:34:00 INFO - 1500942840562 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:34:00 INFO - 1500942840563 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:34:00 INFO - ++DOMWINDOW == 23 (000000E84ED90000) [pid = 3276] [serial = 44] [outer = 000000E84F906000]
17:34:00 INFO - 1500942840631 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:34:00 INFO - 1500942840654 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:34:00 INFO - 1500942840677 Marionette TRACE 370 <- [1,2,null,{}]
17:34:00 INFO - 1500942840681 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:34:00 INFO - 1500942840693 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a99ab743-b4d2-4331-9aff-29ac9f2943d3","ELEMENT":"a99ab743-b4d2-4331-9aff-29ac9f2943d3"}}]
17:34:00 INFO - 1500942840696 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"a99ab743-b4d2-4331-9aff-29ac9f2943d3"}]
17:34:00 INFO - [Parent 3276] 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:34:00 INFO - [Parent 3276] 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:34:00 INFO - [Parent 3276] 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:34:01 INFO - 1500942841339 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:34:01 INFO - 1500942841358 Marionette TRACE 370 <- [1,4,null,{}]
17:34:01 INFO - 1500942841367 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"a99ab743-b4d2-4331-9aff-29ac9f2943d3","name":"selected"}]
17:34:01 INFO - 1500942841396 Marionette TRACE 370 <- [1,5,null,{"value":true}]
17:34:01 INFO - 1500942841401 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
17:34:01 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500942841414 Marionette TRACE 370 <- [1,6,null,{"value":null}]
17:34:01 INFO - 1500942841426 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841435 Marionette TRACE 370 <- [1,7,null,{}]
17:34:01 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1459ms
17:34:01 INFO - TEST-START | test_click.py TestClick.test_css_transforms
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841465 Marionette DEBUG Closed connection 370
17:34:01 INFO - 1500942841468 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49802
17:34:01 INFO - 1500942841491 Marionette DEBUG Closed connection 371
17:34:01 INFO - 1500942841495 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49803
17:34:01 INFO - 1500942841500 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:01 INFO - 1500942841510 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:01 INFO - 1500942841534 Marionette DEBUG Register listener.js for window 12
17:34:01 INFO - 1500942841555 Marionette TRACE 372 <- [1,1,null,{"sessionId":"7f4fec43-96f1-4add-abf6-8ef24b0d6cff","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:01 INFO - 1500942841587 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
17:34:01 INFO - 1500942841591 Marionette TRACE 372 <- [1,2,null,{}]
17:34:01 INFO - 1500942841599 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:01 INFO - 1500942841602 Marionette TRACE 372 <- [1,3,null,{}]
17:34:01 INFO - 1500942841608 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:01 INFO - 1500942841611 Marionette TRACE 372 <- [1,4,null,{}]
17:34:01 INFO - 1500942841614 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
17:34:01 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500942841625 Marionette TRACE 372 <- [1,5,null,{"value":null}]
17:34:01 INFO - 1500942841629 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841635 Marionette TRACE 372 <- [1,6,null,{}]
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841648 Marionette DEBUG Closed connection 372
17:34:01 INFO - 1500942841651 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49804
17:34:01 INFO - 1500942841671 Marionette DEBUG Closed connection 373
17:34:01 INFO - 1500942841673 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49805
17:34:01 INFO - 1500942841676 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:01 INFO - 1500942841679 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:01 INFO - 1500942841704 Marionette DEBUG Register listener.js for window 12
17:34:01 INFO - 1500942841720 Marionette TRACE 374 <- [1,1,null,{"sessionId":"32f1dd71-fa73-4907-8d84-57412a936d52","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:01 INFO - 1500942841776 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841785 Marionette TRACE 374 <- [1,2,null,{}]
17:34:01 INFO - [Parent 3276] 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:34:01 INFO - 1500942841810 Marionette DEBUG Closed connection 374
17:34:01 INFO - 1500942841813 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49806
17:34:01 INFO - 1500942841817 Marionette DEBUG Closed connection 375
17:34:01 INFO - 1500942841819 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49807
17:34:01 INFO - 1500942841825 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:01 INFO - 1500942841829 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:01 INFO - 1500942841853 Marionette DEBUG Register listener.js for window 12
17:34:01 INFO - 1500942841868 Marionette TRACE 376 <- [1,1,null,{"sessionId":"7c6e9b84-60ba-423d-83a2-48103dab89ac","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:01 INFO - 1500942841878 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
17:34:01 INFO - 1500942841884 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:34:01 INFO - 1500942841894 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:34:01 INFO - 1500942841895 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:34:01 INFO - ++DOMWINDOW == 24 (000000E843DD8800) [pid = 3276] [serial = 45] [outer = 000000E84F906000]
17:34:01 INFO - 1500942841959 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:34:01 INFO - 1500942841966 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:34:01 INFO - 1500942841990 Marionette TRACE 376 <- [1,2,null,{}]
17:34:01 INFO - 1500942841997 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
17:34:02 INFO - 1500942842008 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"456c3fe4-1a92-4020-bbe2-6b4bb9936e52","ELEMENT":"456c3fe4-1a92-4020-bbe2-6b4bb9936e52"}}]
17:34:02 INFO - 1500942842010 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"456c3fe4-1a92-4020-bbe2-6b4bb9936e52"}]
17:34:02 INFO - --DOMWINDOW == 23 (000000E84FB8A000) [pid = 3276] [serial = 34] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20horizontally%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
17:34:02 INFO - --DOMWINDOW == 22 (000000E84F3D1800) [pid = 3276] [serial = 33] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
17:34:02 INFO - --DOMWINDOW == 21 (000000E84483A800) [pid = 3276] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
17:34:02 INFO - --DOMWINDOW == 20 (000000E858823000) [pid = 3276] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
17:34:02 INFO - 1500942842409 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:34:02 INFO - 1500942842411 Marionette TRACE 376 <- [1,4,null,{}]
17:34:02 INFO - 1500942842415 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
17:34:02 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500942842423 Marionette TRACE 376 <- [1,5,null,{"value":null}]
17:34:02 INFO - 1500942842426 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
17:34:02 INFO - [Parent 3276] 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:34:02 INFO - 1500942842431 Marionette TRACE 376 <- [1,6,null,{}]
17:34:02 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 997ms
17:34:02 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
17:34:02 INFO - [Parent 3276] 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:34:02 INFO - 1500942842454 Marionette DEBUG Closed connection 376
17:34:02 INFO - 1500942842456 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49808
17:34:02 INFO - 1500942842459 Marionette DEBUG Closed connection 377
17:34:02 INFO - 1500942842461 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49809
17:34:02 INFO - 1500942842466 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:02 INFO - 1500942842469 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:02 INFO - 1500942842492 Marionette DEBUG Register listener.js for window 12
17:34:02 INFO - 1500942842507 Marionette TRACE 378 <- [1,1,null,{"sessionId":"85e5bf55-3dd0-4620-91db-571dd0dddefa","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:02 INFO - 1500942842520 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
17:34:02 INFO - 1500942842522 Marionette TRACE 378 <- [1,2,null,{}]
17:34:02 INFO - 1500942842524 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:02 INFO - 1500942842526 Marionette TRACE 378 <- [1,3,null,{}]
17:34:02 INFO - 1500942842528 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:02 INFO - 1500942842530 Marionette TRACE 378 <- [1,4,null,{}]
17:34:02 INFO - 1500942842534 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
17:34:02 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500942842543 Marionette TRACE 378 <- [1,5,null,{"value":null}]
17:34:02 INFO - 1500942842545 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
17:34:02 INFO - [Parent 3276] 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:34:02 INFO - 1500942842549 Marionette TRACE 378 <- [1,6,null,{}]
17:34:02 INFO - [Parent 3276] 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:34:02 INFO - 1500942842556 Marionette DEBUG Closed connection 378
17:34:02 INFO - 1500942842558 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49810
17:34:02 INFO - 1500942842560 Marionette DEBUG Closed connection 379
17:34:02 INFO - 1500942842562 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49811
17:34:02 INFO - 1500942842564 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:02 INFO - 1500942842569 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:02 INFO - 1500942842592 Marionette DEBUG Register listener.js for window 12
17:34:02 INFO - 1500942842608 Marionette TRACE 380 <- [1,1,null,{"sessionId":"07fa9ff2-c20f-44fd-8876-6fb132094a34","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:02 INFO - 1500942842637 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
17:34:02 INFO - [Parent 3276] 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:34:02 INFO - 1500942842642 Marionette TRACE 380 <- [1,2,null,{}]
17:34:03 INFO - [Parent 3276] 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:34:03 INFO - 1500942843317 Marionette DEBUG Closed connection 380
17:34:03 INFO - 1500942843322 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49812
17:34:03 INFO - 1500942843344 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49813
17:34:03 INFO - 1500942843345 Marionette DEBUG Closed connection 381
17:34:03 INFO - 1500942843389 Marionette DEBUG Closed connection 382
17:34:03 INFO - 1500942843391 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49814
17:34:03 INFO - 1500942843444 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:03 INFO - 1500942843446 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:03 INFO - 1500942843470 Marionette DEBUG Register listener.js for window 12
17:34:03 INFO - 1500942843484 Marionette TRACE 383 <- [1,1,null,{"sessionId":"6626eb9b-f84f-4021-a846-e24c06801618","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:03 INFO - 1500942843534 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:34:03 INFO - 1500942843539 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:34:03 INFO - 1500942843548 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:34:03 INFO - 1500942843549 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:34:03 INFO - ++DOMWINDOW == 21 (000000E852DBE800) [pid = 3276] [serial = 46] [outer = 000000E84F906000]
17:34:03 INFO - 1500942843658 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:34:03 INFO - 1500942843673 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:34:03 INFO - 1500942843691 Marionette TRACE 383 <- [1,2,null,{}]
17:34:03 INFO - 1500942843695 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
17:34:03 INFO - 1500942843705 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"57352d0a-444b-407b-8e2a-6e2a3436be60","ELEMENT":"57352d0a-444b-407b-8e2a-6e2a3436be60"}}]
17:34:03 INFO - 1500942843716 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"57352d0a-444b-407b-8e2a-6e2a3436be60"}]
17:34:04 INFO - 1500942844166 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:34:04 INFO - 1500942844168 Marionette TRACE 383 <- [1,4,null,{}]
17:34:04 INFO - 1500942844172 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:34:04 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500942844181 Marionette TRACE 383 <- [1,5,null,{"value":null}]
17:34:04 INFO - 1500942844184 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844188 Marionette TRACE 383 <- [1,6,null,{}]
17:34:04 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1756ms
17:34:04 INFO - TEST-START | test_click.py TestClick.test_input_file
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844209 Marionette DEBUG Closed connection 383
17:34:04 INFO - 1500942844211 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49815
17:34:04 INFO - 1500942844212 Marionette DEBUG Closed connection 384
17:34:04 INFO - 1500942844214 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49816
17:34:04 INFO - 1500942844216 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:04 INFO - 1500942844219 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:04 INFO - 1500942844241 Marionette DEBUG Register listener.js for window 12
17:34:04 INFO - 1500942844253 Marionette TRACE 385 <- [1,1,null,{"sessionId":"5f2b0373-3939-49cf-a78e-29aad08b54d6","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:04 INFO - 1500942844264 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
17:34:04 INFO - 1500942844266 Marionette TRACE 385 <- [1,2,null,{}]
17:34:04 INFO - 1500942844268 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:04 INFO - 1500942844270 Marionette TRACE 385 <- [1,3,null,{}]
17:34:04 INFO - 1500942844272 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:04 INFO - 1500942844274 Marionette TRACE 385 <- [1,4,null,{}]
17:34:04 INFO - 1500942844276 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:34:04 INFO - TEST-START: test_click.py TestClick.test_input_file1500942844285 Marionette TRACE 385 <- [1,5,null,{"value":null}]
17:34:04 INFO - 1500942844288 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844292 Marionette TRACE 385 <- [1,6,null,{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844298 Marionette DEBUG Closed connection 385
17:34:04 INFO - 1500942844301 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49817
17:34:04 INFO - 1500942844302 Marionette DEBUG Closed connection 386
17:34:04 INFO - 1500942844304 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49818
17:34:04 INFO - 1500942844307 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:04 INFO - 1500942844309 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:04 INFO - 1500942844332 Marionette DEBUG Register listener.js for window 12
17:34:04 INFO - 1500942844344 Marionette TRACE 387 <- [1,1,null,{"sessionId":"88e30c46-bdc6-4efc-bde9-80f37168c048","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:04 INFO - 1500942844351 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844355 Marionette TRACE 387 <- [1,2,null,{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844361 Marionette DEBUG Closed connection 387
17:34:04 INFO - 1500942844362 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49819
17:34:04 INFO - 1500942844364 Marionette DEBUG Closed connection 388
17:34:04 INFO - 1500942844365 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49820
17:34:04 INFO - 1500942844367 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:04 INFO - 1500942844370 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:04 INFO - 1500942844393 Marionette DEBUG Register listener.js for window 12
17:34:04 INFO - 1500942844404 Marionette TRACE 389 <- [1,1,null,{"sessionId":"a893a18b-d306-4713-8d6f-d2568cc7af6d","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:04 INFO - 1500942844411 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
17:34:04 INFO - 1500942844415 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:34:04 INFO - 1500942844421 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:34:04 INFO - 1500942844423 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:34:04 INFO - ++DOMWINDOW == 22 (000000E854577800) [pid = 3276] [serial = 47] [outer = 000000E84F906000]
17:34:04 INFO - 1500942844530 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:34:04 INFO - 1500942844535 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:34:04 INFO - 1500942844553 Marionette TRACE 389 <- [1,2,null,{}]
17:34:04 INFO - 1500942844571 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
17:34:04 INFO - 1500942844579 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a91670dd-b922-4cec-aa5d-bedfa8343319","ELEMENT":"a91670dd-b922-4cec-aa5d-bedfa8343319"}}]
17:34:04 INFO - 1500942844581 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"a91670dd-b922-4cec-aa5d-bedfa8343319"}]
17:34:04 INFO - 1500942844719 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
17:34:04 INFO - 1500942844737 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:34:04 INFO - TEST-END: test_click.py TestClick.test_input_file1500942844746 Marionette TRACE 389 <- [1,5,null,{"value":null}]
17:34:04 INFO - 1500942844748 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844752 Marionette TRACE 389 <- [1,6,null,{}]
17:34:04 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 563ms
17:34:04 INFO - TEST-START | test_click.py TestClick.test_obscured_element
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844774 Marionette DEBUG Closed connection 389
17:34:04 INFO - 1500942844776 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49821
17:34:04 INFO - 1500942844778 Marionette DEBUG Closed connection 390
17:34:04 INFO - 1500942844779 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49822
17:34:04 INFO - 1500942844781 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:04 INFO - 1500942844784 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:04 INFO - 1500942844806 Marionette DEBUG Register listener.js for window 12
17:34:04 INFO - 1500942844818 Marionette TRACE 391 <- [1,1,null,{"sessionId":"09ea5d52-73e1-47a1-b8bd-d30941a75a79","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:04 INFO - 1500942844830 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
17:34:04 INFO - 1500942844832 Marionette TRACE 391 <- [1,2,null,{}]
17:34:04 INFO - 1500942844834 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:04 INFO - 1500942844836 Marionette TRACE 391 <- [1,3,null,{}]
17:34:04 INFO - 1500942844838 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:04 INFO - 1500942844840 Marionette TRACE 391 <- [1,4,null,{}]
17:34:04 INFO - 1500942844842 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:34:04 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500942844851 Marionette TRACE 391 <- [1,5,null,{"value":null}]
17:34:04 INFO - 1500942844853 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844857 Marionette TRACE 391 <- [1,6,null,{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844882 Marionette DEBUG Closed connection 391
17:34:04 INFO - 1500942844883 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49823
17:34:04 INFO - 1500942844887 Marionette DEBUG Closed connection 392
17:34:04 INFO - 1500942844888 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49824
17:34:04 INFO - 1500942844891 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:04 INFO - 1500942844894 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:04 INFO - 1500942844921 Marionette DEBUG Register listener.js for window 12
17:34:04 INFO - 1500942844935 Marionette TRACE 393 <- [1,1,null,{"sessionId":"915ca439-70ca-46b4-af02-17201478fe6c","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:04 INFO - 1500942844948 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844952 Marionette TRACE 393 <- [1,2,null,{}]
17:34:04 INFO - [Parent 3276] 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:34:04 INFO - 1500942844973 Marionette DEBUG Closed connection 393
17:34:04 INFO - 1500942844974 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49825
17:34:04 INFO - 1500942844976 Marionette DEBUG Closed connection 394
17:34:04 INFO - 1500942844977 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49826
17:34:04 INFO - 1500942844979 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:04 INFO - 1500942844982 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:05 INFO - 1500942845005 Marionette DEBUG Register listener.js for window 12
17:34:05 INFO - 1500942845016 Marionette TRACE 395 <- [1,1,null,{"sessionId":"60ba1217-abdd-4de4-a3e1-eb498a3fdc8b","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:05 INFO - 1500942845022 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:34:05 INFO - 1500942845026 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:34:05 INFO - 1500942845036 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:34:05 INFO - 1500942845037 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:34:05 INFO - ++DOMWINDOW == 23 (000000E858078800) [pid = 3276] [serial = 48] [outer = 000000E84F906000]
17:34:05 INFO - 1500942845098 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:34:05 INFO - 1500942845104 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:34:05 INFO - 1500942845122 Marionette TRACE 395 <- [1,2,null,{}]
17:34:05 INFO - 1500942845135 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
17:34:05 INFO - 1500942845143 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f0d61ef3-a31e-40a7-ac42-e05d2bf4e64a","ELEMENT":"f0d61ef3-a31e-40a7-ac42-e05d2bf4e64a"}}]
17:34:05 INFO - 1500942845145 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
17:34:05 INFO - 1500942845152 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9846ce76-2a6b-4cf5-af93-4a0ec2896478","ELEMENT":"9846ce76-2a6b-4cf5-af93-4a0ec2896478"}}]
17:34:05 INFO - 1500942845154 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"f0d61ef3-a31e-40a7-ac42-e05d2bf4e64a"}]
17:34:05 INFO - 1500942845561 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:34:05 INFO - 1500942845563 Marionette TRACE 395 <- [1,5,null,{}]
17:34:05 INFO - 1500942845566 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"9846ce76-2a6b-4cf5-af93-4a0ec2896478"}]
17:34:05 INFO - 1500942845664 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
17:34:05 INFO - 1500942845696 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
17:34:05 INFO - 1500942845704 Marionette TRACE 395 <- [1,7,null,{"value":false}]
17:34:05 INFO - 1500942845707 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:34:05 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500942845715 Marionette TRACE 395 <- [1,8,null,{"value":null}]
17:34:05 INFO - 1500942845716 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845721 Marionette TRACE 395 <- [1,9,null,{}]
17:34:05 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 968ms
17:34:05 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845727 Marionette DEBUG Closed connection 395
17:34:05 INFO - 1500942845729 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49827
17:34:05 INFO - 1500942845730 Marionette DEBUG Closed connection 396
17:34:05 INFO - 1500942845732 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49828
17:34:05 INFO - 1500942845755 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:05 INFO - 1500942845757 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:05 INFO - 1500942845780 Marionette DEBUG Register listener.js for window 12
17:34:05 INFO - 1500942845791 Marionette TRACE 397 <- [1,1,null,{"sessionId":"8006bd20-a3ec-42d4-81eb-e3c0698313f8","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:05 INFO - 1500942845797 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
17:34:05 INFO - 1500942845798 Marionette TRACE 397 <- [1,2,null,{}]
17:34:05 INFO - 1500942845800 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:34:05 INFO - 1500942845801 Marionette TRACE 397 <- [1,3,null,{}]
17:34:05 INFO - 1500942845803 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
17:34:05 INFO - 1500942845805 Marionette TRACE 397 <- [1,4,null,{}]
17:34:05 INFO - 1500942845807 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:34:05 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500942845818 Marionette TRACE 397 <- [1,5,null,{"value":null}]
17:34:05 INFO - 1500942845820 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845824 Marionette TRACE 397 <- [1,6,null,{}]
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845830 Marionette DEBUG Closed connection 397
17:34:05 INFO - 1500942845832 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49829
17:34:05 INFO - 1500942845833 Marionette DEBUG Closed connection 398
17:34:05 INFO - 1500942845834 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49830
17:34:05 INFO - 1500942845837 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:34:05 INFO - 1500942845839 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:05 INFO - 1500942845862 Marionette DEBUG Register listener.js for window 12
17:34:05 INFO - 1500942845872 Marionette TRACE 399 <- [1,1,null,{"sessionId":"e31acd80-d357-4219-9f63-808e443da143","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:05 INFO - 1500942845878 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845882 Marionette TRACE 399 <- [1,2,null,{}]
17:34:05 INFO - [Parent 3276] 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:34:05 INFO - 1500942845888 Marionette DEBUG Closed connection 399
17:34:05 INFO - 1500942845890 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49831
17:34:05 INFO - 1500942845891 Marionette DEBUG Closed connection 400
17:34:05 INFO - 1500942845893 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49832
17:34:05 INFO - 1500942845895 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:34:05 INFO - 1500942845897 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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}
17:34:05 INFO - 1500942845921 Marionette DEBUG Register listener.js for window 12
17:34:05 INFO - 1500942845931 Marionette TRACE 401 <- [1,1,null,{"sessionId":"05171a60-a700-495a-a3e1-e002a8f83571","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":3276,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-173.001\\AppData\\Local\\Temp\\tmphvnor1.mozrunner","moz:accessibilityChecks":false}}]
17:34:05 INFO - 1500942845937 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:34:05 INFO - 1500942845941 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:34:05 INFO - 1500942845947 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:34:05 INFO - 1500942845948 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:34:05 INFO - ++DOMWINDOW == 24 (000000E8585B2000) [pid = 3276] [serial = 49] [outer = 000000E84F906000]
17:34:06 INFO - 1500942846704 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:34:06 INFO - 1500942846710 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:34:06 INFO - 1500942846734 Marionette TRACE 401 <- [1,2,null,{}]
17:34:06 INFO - 1500942846744 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
17:34:06 INFO - 1500942846762 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"14b4900e-46be-4974-85a6-edf39ea6421a","ELEMENT":"14b4900e-46be-4974-85a6-edf39ea6421a"}}]
17:34:06 INFO - 1500942846767 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"14b4900e-46be-4974-85a6-edf39ea6421a"}]
17:34:06 INFO - 1500942846913 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
17:34:06 INFO - 1500942846927 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"14b4900e-46be-4974-85a6-edf39ea6421a"}]
17:34:07 INFO - 1500942847142 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element