could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:42:32 INFO - 1500658952216 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:42:32 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500658952224 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:42:32 INFO - 1500658952280 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952285 Marionette TRACE 352 <- [1,6,null,{}]
10:42:32 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1521ms
10:42:32 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952342 Marionette DEBUG Closed connection 352
10:42:32 INFO - 1500658952344 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49780
10:42:32 INFO - 1500658952397 Marionette DEBUG Closed connection 353
10:42:32 INFO - 1500658952398 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49781
10:42:32 INFO - 1500658952426 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:32 INFO - 1500658952428 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:32 INFO - 1500658952451 Marionette DEBUG Register listener.js for window 15
10:42:32 INFO - 1500658952463 Marionette TRACE 354 <- [1,1,null,{"sessionId":"2b1715df-fa4c-4fb7-825d-eb06bd379263","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:32 INFO - 1500658952490 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:42:32 INFO - 1500658952492 Marionette TRACE 354 <- [1,2,null,{}]
10:42:32 INFO - 1500658952494 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:32 INFO - 1500658952495 Marionette TRACE 354 <- [1,3,null,{}]
10:42:32 INFO - 1500658952499 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:32 INFO - 1500658952500 Marionette TRACE 354 <- [1,4,null,{}]
10:42:32 INFO - 1500658952505 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:42:32 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500658952512 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:42:32 INFO - 1500658952515 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952520 Marionette TRACE 354 <- [1,6,null,{}]
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952526 Marionette DEBUG Closed connection 354
10:42:32 INFO - 1500658952527 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49782
10:42:32 INFO - 1500658952529 Marionette DEBUG Closed connection 355
10:42:32 INFO - 1500658952530 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49783
10:42:32 INFO - 1500658952532 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:32 INFO - 1500658952534 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:32 INFO - 1500658952556 Marionette DEBUG Register listener.js for window 15
10:42:32 INFO - 1500658952568 Marionette TRACE 356 <- [1,1,null,{"sessionId":"dc40d7ed-966e-4fc2-9e20-66f945e8a12c","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:32 INFO - 1500658952598 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952602 Marionette TRACE 356 <- [1,2,null,{}]
10:42:32 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:32 INFO - 1500658952625 Marionette DEBUG Closed connection 356
10:42:32 INFO - 1500658952627 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49784
10:42:32 INFO - 1500658952631 Marionette DEBUG Closed connection 357
10:42:32 INFO - 1500658952633 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49785
10:42:32 INFO - 1500658952686 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:32 INFO - 1500658952699 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:32 INFO - 1500658952744 Marionette DEBUG Register listener.js for window 15
10:42:32 INFO - 1500658952768 Marionette TRACE 358 <- [1,1,null,{"sessionId":"63bc96dc-cc32-44c7-877d-2a1236131d49","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:32 INFO - 1500658952782 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49331/clicks.html"}]
10:42:32 INFO - 1500658952790 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/hidden.html"
10:42:32 INFO - 1500658952806 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/hidden.html"
10:42:32 INFO - 1500658952807 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/hidden.html"
10:42:32 INFO - ++DOMWINDOW == 28 (000000F22C491800) [pid = 3544] [serial = 40] [outer = 000000F238A4A000]
10:42:32 INFO - 1500658952902 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/clicks.html"
10:42:32 INFO - 1500658952910 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/clicks.html"
10:42:32 INFO - 1500658952935 Marionette TRACE 358 <- [1,2,null,{}]
10:42:32 INFO - 1500658952956 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:42:32 INFO - 1500658952970 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d1bd143e-4d61-405f-8dc7-eee5bb6f92cd","ELEMENT":"d1bd143e-4d61-405f-8dc7-eee5bb6f92cd"}}]
10:42:32 INFO - 1500658952973 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"d1bd143e-4d61-405f-8dc7-eee5bb6f92cd"}]
10:42:33 INFO - 1500658953365 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/clicks.html"
10:42:33 INFO - [Parent 3544] 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
10:42:33 INFO - 1500658953387 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/clicks.html"
10:42:33 INFO - 1500658953388 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/clicks.html"
10:42:33 INFO - ++DOMWINDOW == 29 (000000F232690800) [pid = 3544] [serial = 41] [outer = 000000F238A4A000]
10:42:33 INFO - 1500658953471 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/test.html"
10:42:33 INFO - 1500658953477 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/test.html"
10:42:33 INFO - 1500658953499 Marionette TRACE 358 <- [1,4,null,{}]
10:42:33 INFO - 1500658953517 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:42:33 INFO - 1500658953529 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"30031db5-cdd7-488a-b12a-762d9cc052c6","ELEMENT":"30031db5-cdd7-488a-b12a-762d9cc052c6"}}]
10:42:33 INFO - 1500658953533 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:42:33 INFO - 1500658953537 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:42:33 INFO - 1500658953541 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:42:33 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500658953553 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:42:33 INFO - 1500658953556 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:42:33 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:33 INFO - 1500658953562 Marionette TRACE 358 <- [1,8,null,{}]
10:42:33 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1277ms
10:42:33 INFO - TEST-START | test_click.py TestClick.test_container_element
10:42:33 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:33 INFO - 1500658953571 Marionette DEBUG Closed connection 358
10:42:33 INFO - 1500658953574 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49788
10:42:33 INFO - 1500658953577 Marionette DEBUG Closed connection 359
10:42:33 INFO - 1500658953580 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49789
10:42:33 INFO - 1500658953650 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:33 INFO - 1500658953654 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:33 INFO - 1500658953700 Marionette DEBUG Register listener.js for window 15
10:42:33 INFO - 1500658953720 Marionette TRACE 360 <- [1,1,null,{"sessionId":"d485c5d4-a093-453b-b75d-0caf5c3e6edc","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:33 INFO - 1500658953731 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:42:33 INFO - 1500658953734 Marionette TRACE 360 <- [1,2,null,{}]
10:42:33 INFO - 1500658953742 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:33 INFO - 1500658953748 Marionette TRACE 360 <- [1,3,null,{}]
10:42:33 INFO - 1500658953755 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:33 INFO - 1500658953758 Marionette TRACE 360 <- [1,4,null,{}]
10:42:33 INFO - 1500658953811 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:42:33 INFO - TEST-START: test_click.py TestClick.test_container_element1500658953826 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:42:33 INFO - 1500658953831 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:42:33 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:33 INFO - 1500658953836 Marionette TRACE 360 <- [1,6,null,{}]
10:42:33 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:33 INFO - 1500658953844 Marionette DEBUG Closed connection 360
10:42:33 INFO - 1500658953847 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49790
10:42:33 INFO - 1500658953899 Marionette DEBUG Closed connection 361
10:42:33 INFO - 1500658953901 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49791
10:42:33 INFO - 1500658953923 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:33 INFO - 1500658953927 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:33 INFO - 1500658953970 Marionette DEBUG Register listener.js for window 15
10:42:33 INFO - 1500658953991 Marionette TRACE 362 <- [1,1,null,{"sessionId":"c71891a6-5c8e-4c3e-b842-1ed5e6793f79","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:34 INFO - 1500658954000 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:42:34 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:34 INFO - 1500658954005 Marionette TRACE 362 <- [1,2,null,{}]
10:42:34 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:34 INFO - 1500658954012 Marionette DEBUG Closed connection 362
10:42:34 INFO - 1500658954014 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49792
10:42:34 INFO - 1500658954017 Marionette DEBUG Closed connection 363
10:42:34 INFO - 1500658954019 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49793
10:42:34 INFO - 1500658954022 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:34 INFO - 1500658954026 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:34 INFO - 1500658954071 Marionette DEBUG Register listener.js for window 15
10:42:34 INFO - 1500658954098 Marionette TRACE 364 <- [1,1,null,{"sessionId":"59b37124-af5a-4f6c-81b1-4b6c3ca952a5","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:34 INFO - 1500658954133 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:42:34 INFO - 1500658954139 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/test.html"
10:42:34 INFO - 1500658954146 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/test.html"
10:42:34 INFO - 1500658954147 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/test.html"
10:42:34 INFO - ++DOMWINDOW == 30 (000000F23D810800) [pid = 3544] [serial = 42] [outer = 000000F238A4A000]
10:42:34 INFO - 1500658954220 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:34 INFO - 1500658954227 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:34 INFO - 1500658954246 Marionette TRACE 364 <- [1,2,null,{}]
10:42:34 INFO - 1500658954260 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:42:34 INFO - 1500658954270 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"19616e38-2085-48ba-94e9-a9b7ccdc15ab","ELEMENT":"19616e38-2085-48ba-94e9-a9b7ccdc15ab"}}]
10:42:34 INFO - 1500658954272 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"19616e38-2085-48ba-94e9-a9b7ccdc15ab"}]
10:42:34 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:42:34 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:42:34 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:42:34 INFO - 1500658954867 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:42:34 INFO - 1500658954870 Marionette TRACE 364 <- [1,4,null,{}]
10:42:34 INFO - 1500658954872 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"19616e38-2085-48ba-94e9-a9b7ccdc15ab","name":"selected"}]
10:42:34 INFO - 1500658954928 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:42:35 INFO - 1500658955112 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:42:35 INFO - TEST-END: test_click.py TestClick.test_container_element1500658955128 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:42:35 INFO - 1500658955141 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955154 Marionette TRACE 364 <- [1,7,null,{}]
10:42:35 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1610ms
10:42:35 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955185 Marionette DEBUG Closed connection 364
10:42:35 INFO - 1500658955189 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49794
10:42:35 INFO - 1500658955204 Marionette DEBUG Closed connection 365
10:42:35 INFO - 1500658955206 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49795
10:42:35 INFO - 1500658955234 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:35 INFO - 1500658955246 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:35 INFO - 1500658955273 Marionette DEBUG Register listener.js for window 15
10:42:35 INFO - 1500658955296 Marionette TRACE 366 <- [1,1,null,{"sessionId":"a0de4a49-65fb-4599-9029-cfd7063c73a7","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:35 INFO - 1500658955314 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:42:35 INFO - 1500658955318 Marionette TRACE 366 <- [1,2,null,{}]
10:42:35 INFO - 1500658955334 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:35 INFO - 1500658955337 Marionette TRACE 366 <- [1,3,null,{}]
10:42:35 INFO - 1500658955344 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:35 INFO - 1500658955347 Marionette TRACE 366 <- [1,4,null,{}]
10:42:35 INFO - 1500658955403 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:42:35 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500658955416 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:42:35 INFO - 1500658955421 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955427 Marionette TRACE 366 <- [1,6,null,{}]
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955453 Marionette DEBUG Closed connection 366
10:42:35 INFO - 1500658955457 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49796
10:42:35 INFO - 1500658955460 Marionette DEBUG Closed connection 367
10:42:35 INFO - 1500658955462 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49797
10:42:35 INFO - 1500658955488 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:35 INFO - 1500658955492 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:35 INFO - 1500658955517 Marionette DEBUG Register listener.js for window 15
10:42:35 INFO - 1500658955533 Marionette TRACE 368 <- [1,1,null,{"sessionId":"8c822605-13eb-42ae-9a29-6014a7747f60","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:35 INFO - 1500658955550 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955556 Marionette TRACE 368 <- [1,2,null,{}]
10:42:35 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:35 INFO - 1500658955566 Marionette DEBUG Closed connection 368
10:42:35 INFO - 1500658955568 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49798
10:42:35 INFO - 1500658955591 Marionette DEBUG Closed connection 369
10:42:35 INFO - 1500658955593 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49799
10:42:35 INFO - 1500658955601 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:35 INFO - 1500658955607 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:35 INFO - 1500658955631 Marionette DEBUG Register listener.js for window 15
10:42:35 INFO - 1500658955647 Marionette TRACE 370 <- [1,1,null,{"sessionId":"53e68e06-02f5-490d-be74-cfe7032a1a35","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:35 INFO - 1500658955663 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:42:35 INFO - 1500658955668 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:35 INFO - 1500658955676 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:35 INFO - 1500658955677 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:35 INFO - ++DOMWINDOW == 31 (000000F22BD3D800) [pid = 3544] [serial = 43] [outer = 000000F238A4A000]
10:42:35 INFO - 1500658955734 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:35 INFO - 1500658955744 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:35 INFO - 1500658955765 Marionette TRACE 370 <- [1,2,null,{}]
10:42:35 INFO - 1500658955768 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:42:35 INFO - 1500658955778 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cf5959aa-1a37-442b-81bc-9cc3ade034e6","ELEMENT":"cf5959aa-1a37-442b-81bc-9cc3ade034e6"}}]
10:42:35 INFO - 1500658955786 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"cf5959aa-1a37-442b-81bc-9cc3ade034e6"}]
10:42:36 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:42:36 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:42:36 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:42:36 INFO - --DOMWINDOW == 30 (000000F238524000) [pid = 3544] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 29 (000000F23FA1F000) [pid = 3544] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 28 (000000F23D9E2800) [pid = 3544] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 27 (000000F234EF8000) [pid = 3544] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 26 (000000F233367000) [pid = 3544] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 25 (000000F23CD73000) [pid = 3544] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - --DOMWINDOW == 24 (000000F22E0C4800) [pid = 3544] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
10:42:36 INFO - 1500658956920 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:42:36 INFO - 1500658956943 Marionette TRACE 370 <- [1,4,null,{}]
10:42:36 INFO - 1500658956988 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"cf5959aa-1a37-442b-81bc-9cc3ade034e6","name":"selected"}]
10:42:37 INFO - 1500658957017 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:42:37 INFO - 1500658957019 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:42:37 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500658957028 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:42:37 INFO - 1500658957078 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957083 Marionette TRACE 370 <- [1,7,null,{}]
10:42:37 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1910ms
10:42:37 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957090 Marionette DEBUG Closed connection 370
10:42:37 INFO - 1500658957092 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49800
10:42:37 INFO - 1500658957146 Marionette DEBUG Closed connection 371
10:42:37 INFO - 1500658957149 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49801
10:42:37 INFO - 1500658957201 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:37 INFO - 1500658957204 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:37 INFO - 1500658957229 Marionette DEBUG Register listener.js for window 15
10:42:37 INFO - 1500658957245 Marionette TRACE 372 <- [1,1,null,{"sessionId":"fc6486d2-b753-49e4-95f1-c7d4c32f3fbb","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:37 INFO - 1500658957302 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:42:37 INFO - 1500658957304 Marionette TRACE 372 <- [1,2,null,{}]
10:42:37 INFO - 1500658957354 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:37 INFO - 1500658957356 Marionette TRACE 372 <- [1,3,null,{}]
10:42:37 INFO - 1500658957378 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:37 INFO - 1500658957380 Marionette TRACE 372 <- [1,4,null,{}]
10:42:37 INFO - 1500658957384 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:42:37 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500658957393 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:42:37 INFO - 1500658957397 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957401 Marionette TRACE 372 <- [1,6,null,{}]
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957426 Marionette DEBUG Closed connection 372
10:42:37 INFO - 1500658957428 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49802
10:42:37 INFO - 1500658957432 Marionette DEBUG Closed connection 373
10:42:37 INFO - 1500658957434 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49803
10:42:37 INFO - 1500658957436 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:37 INFO - 1500658957441 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:37 INFO - 1500658957464 Marionette DEBUG Register listener.js for window 15
10:42:37 INFO - 1500658957480 Marionette TRACE 374 <- [1,1,null,{"sessionId":"2796ee5c-e529-4244-a5ef-3e6b93691421","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:37 INFO - 1500658957491 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957496 Marionette TRACE 374 <- [1,2,null,{}]
10:42:37 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:37 INFO - 1500658957521 Marionette DEBUG Closed connection 374
10:42:37 INFO - 1500658957526 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49804
10:42:37 INFO - 1500658957531 Marionette DEBUG Closed connection 375
10:42:37 INFO - 1500658957533 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49805
10:42:37 INFO - 1500658957536 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:37 INFO - 1500658957539 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:37 INFO - 1500658957563 Marionette DEBUG Register listener.js for window 15
10:42:37 INFO - 1500658957578 Marionette TRACE 376 <- [1,1,null,{"sessionId":"f5f29b62-db74-44f4-912c-7d33f56f0acc","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:37 INFO - 1500658957585 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:42:37 INFO - 1500658957590 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:37 INFO - 1500658957596 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:37 INFO - 1500658957597 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:37 INFO - ++DOMWINDOW == 25 (000000F230E2E000) [pid = 3544] [serial = 44] [outer = 000000F238A4A000]
10:42:37 INFO - 1500658957663 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:42:37 INFO - 1500658957669 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:42:37 INFO - 1500658957681 Marionette TRACE 376 <- [1,2,null,{}]
10:42:37 INFO - 1500658957692 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:42:37 INFO - 1500658957701 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0a4da3b-6d89-4f2c-b631-7e074a014541","ELEMENT":"e0a4da3b-6d89-4f2c-b631-7e074a014541"}}]
10:42:37 INFO - 1500658957703 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"e0a4da3b-6d89-4f2c-b631-7e074a014541"}]
10:42:38 INFO - 1500658958178 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:42:38 INFO - 1500658958181 Marionette TRACE 376 <- [1,4,null,{}]
10:42:38 INFO - 1500658958184 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:42:38 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500658958192 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:42:38 INFO - 1500658958194 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958198 Marionette TRACE 376 <- [1,6,null,{}]
10:42:38 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1114ms
10:42:38 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958205 Marionette DEBUG Closed connection 376
10:42:38 INFO - 1500658958206 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49806
10:42:38 INFO - 1500658958208 Marionette DEBUG Closed connection 377
10:42:38 INFO - 1500658958209 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49807
10:42:38 INFO - 1500658958211 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:38 INFO - 1500658958214 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:38 INFO - 1500658958236 Marionette DEBUG Register listener.js for window 15
10:42:38 INFO - 1500658958248 Marionette TRACE 378 <- [1,1,null,{"sessionId":"f6c48768-aed4-45fe-9fc4-149cdf114d6c","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:38 INFO - 1500658958254 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:42:38 INFO - 1500658958256 Marionette TRACE 378 <- [1,2,null,{}]
10:42:38 INFO - 1500658958286 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:38 INFO - 1500658958288 Marionette TRACE 378 <- [1,3,null,{}]
10:42:38 INFO - 1500658958290 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:38 INFO - 1500658958292 Marionette TRACE 378 <- [1,4,null,{}]
10:42:38 INFO - 1500658958294 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:42:38 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500658958303 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:42:38 INFO - 1500658958305 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958309 Marionette TRACE 378 <- [1,6,null,{}]
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958315 Marionette DEBUG Closed connection 378
10:42:38 INFO - 1500658958317 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49808
10:42:38 INFO - 1500658958318 Marionette DEBUG Closed connection 379
10:42:38 INFO - 1500658958321 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49809
10:42:38 INFO - 1500658958344 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:38 INFO - 1500658958347 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:38 INFO - 1500658958370 Marionette DEBUG Register listener.js for window 15
10:42:38 INFO - 1500658958382 Marionette TRACE 380 <- [1,1,null,{"sessionId":"fb64eab0-765b-4931-86af-b17401e56fcf","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:38 INFO - 1500658958388 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958392 Marionette TRACE 380 <- [1,2,null,{}]
10:42:38 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:38 INFO - 1500658958398 Marionette DEBUG Closed connection 380
10:42:38 INFO - 1500658958400 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49810
10:42:38 INFO - 1500658958401 Marionette DEBUG Closed connection 381
10:42:38 INFO - 1500658958403 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49811
10:42:38 INFO - 1500658958405 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:38 INFO - 1500658958408 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:38 INFO - 1500658958431 Marionette DEBUG Register listener.js for window 15
10:42:38 INFO - 1500658958443 Marionette TRACE 382 <- [1,1,null,{"sessionId":"102ce460-a5b9-483d-924c-430cb2066598","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:38 INFO - 1500658958449 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:42:38 INFO - 1500658958453 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:42:38 INFO - 1500658958458 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:42:38 INFO - 1500658958459 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:42:38 INFO - ++DOMWINDOW == 26 (000000F233370800) [pid = 3544] [serial = 45] [outer = 000000F238A4A000]
10:42:38 INFO - 1500658958518 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:38 INFO - 1500658958523 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:38 INFO - 1500658958540 Marionette TRACE 382 <- [1,2,null,{}]
10:42:38 INFO - 1500658958576 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:42:38 INFO - 1500658958584 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"32d3f73e-6516-4d4b-bbcf-2dc8db52f313","ELEMENT":"32d3f73e-6516-4d4b-bbcf-2dc8db52f313"}}]
10:42:38 INFO - 1500658958586 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"32d3f73e-6516-4d4b-bbcf-2dc8db52f313"}]
10:42:39 INFO - 1500658959034 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:42:39 INFO - 1500658959036 Marionette TRACE 382 <- [1,4,null,{}]
10:42:39 INFO - 1500658959039 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:42:39 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500658959048 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:42:39 INFO - 1500658959050 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959054 Marionette TRACE 382 <- [1,6,null,{}]
10:42:39 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 855ms
10:42:39 INFO - TEST-START | test_click.py TestClick.test_input_file
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959060 Marionette DEBUG Closed connection 382
10:42:39 INFO - 1500658959061 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49812
10:42:39 INFO - 1500658959063 Marionette DEBUG Closed connection 383
10:42:39 INFO - 1500658959064 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49813
10:42:39 INFO - 1500658959067 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:39 INFO - 1500658959069 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:39 INFO - 1500658959092 Marionette DEBUG Register listener.js for window 15
10:42:39 INFO - 1500658959104 Marionette TRACE 384 <- [1,1,null,{"sessionId":"cb8560e0-28a9-475e-b5a0-185fb39a12f6","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:39 INFO - 1500658959110 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:42:39 INFO - 1500658959112 Marionette TRACE 384 <- [1,2,null,{}]
10:42:39 INFO - 1500658959114 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:39 INFO - 1500658959116 Marionette TRACE 384 <- [1,3,null,{}]
10:42:39 INFO - 1500658959117 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:39 INFO - 1500658959119 Marionette TRACE 384 <- [1,4,null,{}]
10:42:39 INFO - 1500658959127 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:42:39 INFO - TEST-START: test_click.py TestClick.test_input_file1500658959135 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:42:39 INFO - 1500658959137 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959142 Marionette TRACE 384 <- [1,6,null,{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959193 Marionette DEBUG Closed connection 384
10:42:39 INFO - 1500658959195 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49814
10:42:39 INFO - 1500658959196 Marionette DEBUG Closed connection 385
10:42:39 INFO - 1500658959198 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49815
10:42:39 INFO - 1500658959200 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:39 INFO - 1500658959203 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:39 INFO - 1500658959231 Marionette DEBUG Register listener.js for window 15
10:42:39 INFO - 1500658959245 Marionette TRACE 386 <- [1,1,null,{"sessionId":"cdfd25dc-20e7-4021-bb76-7b445cc4e07e","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:39 INFO - 1500658959258 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959263 Marionette TRACE 386 <- [1,2,null,{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959285 Marionette DEBUG Closed connection 386
10:42:39 INFO - 1500658959286 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49816
10:42:39 INFO - 1500658959291 Marionette DEBUG Closed connection 387
10:42:39 INFO - 1500658959292 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49817
10:42:39 INFO - 1500658959295 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:39 INFO - 1500658959297 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:39 INFO - 1500658959320 Marionette DEBUG Register listener.js for window 15
10:42:39 INFO - 1500658959332 Marionette TRACE 388 <- [1,1,null,{"sessionId":"fc06605a-abdd-4148-a9dd-75ac35b334c3","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:39 INFO - 1500658959342 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:42:39 INFO - 1500658959347 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:39 INFO - 1500658959352 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:39 INFO - 1500658959354 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:42:39 INFO - ++DOMWINDOW == 27 (000000F236EE0000) [pid = 3544] [serial = 46] [outer = 000000F238A4A000]
10:42:39 INFO - 1500658959407 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:42:39 INFO - 1500658959419 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:42:39 INFO - 1500658959429 Marionette TRACE 388 <- [1,2,null,{}]
10:42:39 INFO - 1500658959439 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:42:39 INFO - 1500658959449 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"aafe3de7-a878-4659-a654-81e6a59e4f06","ELEMENT":"aafe3de7-a878-4659-a654-81e6a59e4f06"}}]
10:42:39 INFO - 1500658959456 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"aafe3de7-a878-4659-a654-81e6a59e4f06"}]
10:42:39 INFO - 1500658959633 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:42:39 INFO - 1500658959636 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:42:39 INFO - TEST-END: test_click.py TestClick.test_input_file1500658959644 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:42:39 INFO - 1500658959646 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959650 Marionette TRACE 388 <- [1,6,null,{}]
10:42:39 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 595ms
10:42:39 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:42:39 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:39 INFO - 1500658959656 Marionette DEBUG Closed connection 388
10:42:39 INFO - 1500658959657 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49818
10:42:39 INFO - 1500658959659 Marionette DEBUG Closed connection 389
10:42:39 INFO - 1500658959660 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49819
10:42:39 INFO - 1500658959686 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:39 INFO - 1500658959688 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:39 INFO - 1500658959712 Marionette DEBUG Register listener.js for window 15
10:42:39 INFO - 1500658959724 Marionette TRACE 390 <- [1,1,null,{"sessionId":"65de769c-2ddd-41e3-89d9-8cf36ceb1c29","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:39 INFO - 1500658959733 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:42:39 INFO - 1500658959735 Marionette TRACE 390 <- [1,2,null,{}]
10:42:40 INFO - 1500658960374 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:40 INFO - 1500658960376 Marionette TRACE 390 <- [1,3,null,{}]
10:42:40 INFO - 1500658960427 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:40 INFO - 1500658960429 Marionette TRACE 390 <- [1,4,null,{}]
10:42:40 INFO - 1500658960497 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:42:40 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500658960512 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:42:40 INFO - 1500658960519 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:42:40 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:40 INFO - 1500658960530 Marionette TRACE 390 <- [1,6,null,{}]
10:42:40 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:40 INFO - 1500658960557 Marionette DEBUG Closed connection 390
10:42:40 INFO - 1500658960561 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49820
10:42:40 INFO - 1500658960564 Marionette DEBUG Closed connection 391
10:42:40 INFO - 1500658960567 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49821
10:42:40 INFO - 1500658960572 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:40 INFO - 1500658960582 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:40 INFO - 1500658960631 Marionette DEBUG Register listener.js for window 15
10:42:40 INFO - 1500658960665 Marionette TRACE 392 <- [1,1,null,{"sessionId":"caa23eee-688c-4103-86d8-e2c0e0360ec7","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:40 INFO - 1500658960687 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:42:40 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:40 INFO - 1500658960696 Marionette TRACE 392 <- [1,2,null,{}]
10:42:40 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:40 INFO - 1500658960755 Marionette DEBUG Closed connection 392
10:42:40 INFO - 1500658960758 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49822
10:42:40 INFO - 1500658960762 Marionette DEBUG Closed connection 393
10:42:40 INFO - 1500658960764 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49823
10:42:40 INFO - 1500658960787 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:40 INFO - 1500658960791 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:40 INFO - 1500658960838 Marionette DEBUG Register listener.js for window 15
10:42:40 INFO - 1500658960856 Marionette TRACE 394 <- [1,1,null,{"sessionId":"8ae44430-fabe-4606-8e6e-7878f580d158","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:40 INFO - 1500658960866 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:42:40 INFO - 1500658960886 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:42:40 INFO - 1500658960894 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:42:40 INFO - 1500658960895 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:42:40 INFO - ++DOMWINDOW == 28 (000000F22DBC6000) [pid = 3544] [serial = 47] [outer = 000000F238A4A000]
10:42:40 INFO - 1500658960969 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:42:40 INFO - 1500658960977 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:42:41 INFO - 1500658960998 Marionette TRACE 394 <- [1,2,null,{}]
10:42:41 INFO - 1500658961011 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:42:41 INFO - 1500658961021 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e95322df-bb22-4749-8e85-275245190226","ELEMENT":"e95322df-bb22-4749-8e85-275245190226"}}]
10:42:41 INFO - 1500658961026 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:42:41 INFO - 1500658961037 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d01d0406-bd9c-415b-b903-e819d55676a2","ELEMENT":"d01d0406-bd9c-415b-b903-e819d55676a2"}}]
10:42:41 INFO - 1500658961051 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"e95322df-bb22-4749-8e85-275245190226"}]
10:42:41 INFO - 1500658961661 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:42:41 INFO - 1500658961664 Marionette TRACE 394 <- [1,5,null,{}]
10:42:41 INFO - 1500658961669 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"d01d0406-bd9c-415b-b903-e819d55676a2"}]
10:42:41 INFO - 1500658961976 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:42:42 INFO - 1500658961989 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
10:42:42 INFO - 1500658962004 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:42:42 INFO - 1500658962007 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:42:42 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500658962017 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:42:42 INFO - 1500658962020 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962027 Marionette TRACE 394 <- [1,9,null,{}]
10:42:42 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 2377ms
10:42:42 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962080 Marionette DEBUG Closed connection 394
10:42:42 INFO - 1500658962082 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49824
10:42:42 INFO - 1500658962098 Marionette DEBUG Closed connection 395
10:42:42 INFO - 1500658962100 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49825
10:42:42 INFO - 1500658962103 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:42 INFO - 1500658962107 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:42 INFO - 1500658962154 Marionette DEBUG Register listener.js for window 15
10:42:42 INFO - 1500658962172 Marionette TRACE 396 <- [1,1,null,{"sessionId":"362f98be-2b40-4ece-bd9f-e1c452074ad6","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:42 INFO - 1500658962229 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:42:42 INFO - 1500658962232 Marionette TRACE 396 <- [1,2,null,{}]
10:42:42 INFO - 1500658962237 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:42:42 INFO - 1500658962240 Marionette TRACE 396 <- [1,3,null,{}]
10:42:42 INFO - 1500658962242 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:42:42 INFO - 1500658962244 Marionette TRACE 396 <- [1,4,null,{}]
10:42:42 INFO - 1500658962296 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:42:42 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500658962306 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:42:42 INFO - 1500658962310 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962316 Marionette TRACE 396 <- [1,6,null,{}]
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962340 Marionette DEBUG Closed connection 396
10:42:42 INFO - 1500658962342 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49826
10:42:42 INFO - 1500658962363 Marionette DEBUG Closed connection 397
10:42:42 INFO - 1500658962366 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49827
10:42:42 INFO - 1500658962372 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:42:42 INFO - 1500658962375 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:42 INFO - 1500658962426 Marionette DEBUG Register listener.js for window 15
10:42:42 INFO - 1500658962441 Marionette TRACE 398 <- [1,1,null,{"sessionId":"be519a72-da07-463a-8c0c-07a8992cd993","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:42 INFO - 1500658962452 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962458 Marionette TRACE 398 <- [1,2,null,{}]
10:42:42 INFO - [Parent 3544] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:42:42 INFO - 1500658962634 Marionette DEBUG Closed connection 398
10:42:42 INFO - 1500658962637 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49828
10:42:42 INFO - 1500658962661 Marionette DEBUG Closed connection 399
10:42:42 INFO - 1500658962664 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49829
10:42:42 INFO - 1500658962669 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:42:42 INFO - 1500658962681 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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}
10:42:42 INFO - 1500658962709 Marionette DEBUG Register listener.js for window 15
10:42:42 INFO - 1500658962730 Marionette TRACE 400 <- [1,1,null,{"sessionId":"7491a27b-ec58-4126-a70d-1cd5fb8d5ff9","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":3544,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-332.000\\AppData\\Local\\Temp\\tmpcymw4o.mozrunner","moz:accessibilityChecks":false}}]
10:42:42 INFO - 1500658962768 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:42:42 INFO - 1500658962774 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:42:42 INFO - 1500658962783 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:42:42 INFO - 1500658962785 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:42:42 INFO - ++DOMWINDOW == 29 (000000F22E78A000) [pid = 3544] [serial = 48] [outer = 000000F238A4A000]
10:42:42 INFO - 1500658962851 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:42:42 INFO - 1500658962857 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:42:42 INFO - 1500658962878 Marionette TRACE 400 <- [1,2,null,{}]
10:42:42 INFO - 1500658962894 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:42:42 INFO - 1500658962906 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ad02a23e-1d99-4051-a91c-8837c8d9b93c","ELEMENT":"ad02a23e-1d99-4051-a91c-8837c8d9b93c"}}]
10:42:42 INFO - 1500658962910 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"ad02a23e-1d99-4051-a91c-8837c8d9b93c"}]
10:42:43 INFO - 1500658963054 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:42:43 INFO - 1500658963058 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"ad02a23e-1d99-4051-a91c-8837c8d9b93c"}]
10:42:43 INFO - 1500658963221 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element