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]
14:28:31 INFO - 1500672511969 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}]
14:28:31 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500672511977 Marionette TRACE 352 <- [1,5,null,{"value":null}]
14:28:31 INFO - 1500672511979 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
14:28:31 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:31 INFO - 1500672511983 Marionette TRACE 352 <- [1,6,null,{}]
14:28:31 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 642ms
14:28:31 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
14:28:31 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:31 INFO - 1500672511989 Marionette DEBUG Closed connection 352
14:28:31 INFO - 1500672511990 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49781
14:28:31 INFO - 1500672511992 Marionette DEBUG Closed connection 353
14:28:31 INFO - 1500672511993 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49782
14:28:31 INFO - 1500672511995 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:31 INFO - 1500672511997 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:32 INFO - 1500672512019 Marionette DEBUG Register listener.js for window 15
14:28:32 INFO - 1500672512030 Marionette TRACE 354 <- [1,1,null,{"sessionId":"c6d1e030-acca-4fb1-ba6d-486ec251d241","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:32 INFO - 1500672512060 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
14:28:32 INFO - 1500672512062 Marionette TRACE 354 <- [1,2,null,{}]
14:28:32 INFO - 1500672512064 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:32 INFO - 1500672512066 Marionette TRACE 354 <- [1,3,null,{}]
14:28:32 INFO - 1500672512068 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:32 INFO - 1500672512069 Marionette TRACE 354 <- [1,4,null,{}]
14:28:32 INFO - 1500672512072 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}]
14:28:32 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500672512079 Marionette TRACE 354 <- [1,5,null,{"value":null}]
14:28:32 INFO - 1500672512081 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
14:28:32 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:32 INFO - 1500672512085 Marionette TRACE 354 <- [1,6,null,{}]
14:28:32 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:32 INFO - 1500672512113 Marionette DEBUG Closed connection 354
14:28:32 INFO - 1500672512114 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49783
14:28:32 INFO - 1500672512119 Marionette DEBUG Closed connection 355
14:28:32 INFO - 1500672512120 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49784
14:28:32 INFO - 1500672512122 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:32 INFO - 1500672512125 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:32 INFO - 1500672512148 Marionette DEBUG Register listener.js for window 15
14:28:32 INFO - 1500672512159 Marionette TRACE 356 <- [1,1,null,{"sessionId":"39e474af-9f35-499b-9269-3fcfb291b2f2","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:32 INFO - 1500672512171 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
14:28:32 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:32 INFO - 1500672512176 Marionette TRACE 356 <- [1,2,null,{}]
14:28:32 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:32 INFO - 1500672512199 Marionette DEBUG Closed connection 356
14:28:32 INFO - 1500672512201 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49785
14:28:32 INFO - 1500672512206 Marionette DEBUG Closed connection 357
14:28:32 INFO - 1500672512207 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49786
14:28:32 INFO - 1500672512210 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:32 INFO - 1500672512213 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:32 INFO - 1500672512236 Marionette DEBUG Register listener.js for window 15
14:28:32 INFO - 1500672512247 Marionette TRACE 358 <- [1,1,null,{"sessionId":"b9683257-137c-408c-b25d-a4a319fb5e24","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:32 INFO - 1500672512262 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49332/clicks.html"}]
14:28:32 INFO - 1500672512266 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/hidden.html"
14:28:32 INFO - 1500672512277 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/hidden.html"
14:28:32 INFO - 1500672512278 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/hidden.html"
14:28:32 INFO - ++DOMWINDOW == 28 (000000DEBFD42800) [pid = 2404] [serial = 40] [outer = 000000DECC2CD000]
14:28:32 INFO - 1500672512343 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/clicks.html"
14:28:32 INFO - 1500672512348 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/clicks.html"
14:28:32 INFO - 1500672512364 Marionette TRACE 358 <- [1,2,null,{}]
14:28:32 INFO - 1500672512371 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
14:28:32 INFO - 1500672512378 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"75876a3a-b432-47f4-884b-4f514ca545a9","ELEMENT":"75876a3a-b432-47f4-884b-4f514ca545a9"}}]
14:28:32 INFO - 1500672512380 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"75876a3a-b432-47f4-884b-4f514ca545a9"}]
14:28:33 INFO - 1500672513448 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/clicks.html"
14:28:33 INFO - [Parent 2404] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
14:28:33 INFO - 1500672513480 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/clicks.html"
14:28:33 INFO - 1500672513482 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/clicks.html"
14:28:33 INFO - ++DOMWINDOW == 29 (000000DEBFD4F000) [pid = 2404] [serial = 41] [outer = 000000DECC2CD000]
14:28:33 INFO - 1500672513612 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49332/test.html"
14:28:33 INFO - 1500672513623 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49332/test.html"
14:28:33 INFO - 1500672513641 Marionette TRACE 358 <- [1,4,null,{}]
14:28:33 INFO - 1500672513698 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
14:28:33 INFO - 1500672513704 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"da7d0e4a-c7b2-44db-a95f-d5edf9170046","ELEMENT":"da7d0e4a-c7b2-44db-a95f-d5edf9170046"}}]
14:28:33 INFO - 1500672513706 Marionette TRACE 358 -> [0,6,"getTitle",{}]
14:28:33 INFO - 1500672513708 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
14:28:33 INFO - 1500672513710 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}]
14:28:33 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500672513717 Marionette TRACE 358 <- [1,7,null,{"value":null}]
14:28:33 INFO - 1500672513719 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
14:28:33 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:33 INFO - 1500672513723 Marionette TRACE 358 <- [1,8,null,{}]
14:28:33 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1739ms
14:28:33 INFO - TEST-START | test_click.py TestClick.test_container_element
14:28:33 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:33 INFO - 1500672513729 Marionette DEBUG Closed connection 358
14:28:33 INFO - 1500672513730 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49789
14:28:33 INFO - 1500672513732 Marionette DEBUG Closed connection 359
14:28:33 INFO - 1500672513734 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49790
14:28:33 INFO - 1500672513787 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:33 INFO - 1500672513789 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:33 INFO - 1500672513811 Marionette DEBUG Register listener.js for window 15
14:28:33 INFO - 1500672513821 Marionette TRACE 360 <- [1,1,null,{"sessionId":"573f4d46-07c8-464f-937b-02a1265dfda9","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:33 INFO - 1500672513877 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
14:28:33 INFO - 1500672513879 Marionette TRACE 360 <- [1,2,null,{}]
14:28:33 INFO - 1500672513918 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:33 INFO - 1500672513920 Marionette TRACE 360 <- [1,3,null,{}]
14:28:33 INFO - 1500672513939 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:33 INFO - 1500672513940 Marionette TRACE 360 <- [1,4,null,{}]
14:28:33 INFO - 1500672513944 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}]
14:28:33 INFO - TEST-START: test_click.py TestClick.test_container_element1500672513952 Marionette TRACE 360 <- [1,5,null,{"value":null}]
14:28:33 INFO - 1500672513955 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
14:28:33 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:33 INFO - 1500672513959 Marionette TRACE 360 <- [1,6,null,{}]
14:28:33 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:33 INFO - 1500672513982 Marionette DEBUG Closed connection 360
14:28:33 INFO - 1500672513983 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49791
14:28:33 INFO - 1500672513987 Marionette DEBUG Closed connection 361
14:28:33 INFO - 1500672513989 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49792
14:28:33 INFO - 1500672513991 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:33 INFO - 1500672513993 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:34 INFO - 1500672514015 Marionette DEBUG Register listener.js for window 15
14:28:34 INFO - 1500672514026 Marionette TRACE 362 <- [1,1,null,{"sessionId":"c4393b54-85ec-4059-87bc-d34309e83662","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:34 INFO - 1500672514034 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:34 INFO - 1500672514038 Marionette TRACE 362 <- [1,2,null,{}]
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:34 INFO - 1500672514066 Marionette DEBUG Closed connection 362
14:28:34 INFO - 1500672514067 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49793
14:28:34 INFO - 1500672514071 Marionette DEBUG Closed connection 363
14:28:34 INFO - 1500672514073 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49794
14:28:34 INFO - 1500672514075 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:34 INFO - 1500672514077 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:34 INFO - 1500672514100 Marionette DEBUG Register listener.js for window 15
14:28:34 INFO - 1500672514110 Marionette TRACE 364 <- [1,1,null,{"sessionId":"c6e590ef-8cde-44aa-ad49-276472a47802","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:34 INFO - 1500672514116 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"}]
14:28:34 INFO - 1500672514120 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49332/test.html"
14:28:34 INFO - 1500672514125 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49332/test.html"
14:28:34 INFO - 1500672514125 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49332/test.html"
14:28:34 INFO - ++DOMWINDOW == 30 (000000DED4661800) [pid = 2404] [serial = 42] [outer = 000000DECC2CD000]
14:28:34 INFO - 1500672514182 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"
14:28:34 INFO - 1500672514193 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"
14:28:34 INFO - 1500672514201 Marionette TRACE 364 <- [1,2,null,{}]
14:28:34 INFO - 1500672514211 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:28:34 INFO - 1500672514219 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e4e8b9b5-5a5f-4fce-94ad-dd87b1ee2218","ELEMENT":"e4e8b9b5-5a5f-4fce-94ad-dd87b1ee2218"}}]
14:28:34 INFO - 1500672514221 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"e4e8b9b5-5a5f-4fce-94ad-dd87b1ee2218"}]
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
14:28:34 INFO - 1500672514671 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:28:34 INFO - 1500672514674 Marionette TRACE 364 <- [1,4,null,{}]
14:28:34 INFO - 1500672514680 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"e4e8b9b5-5a5f-4fce-94ad-dd87b1ee2218","name":"selected"}]
14:28:34 INFO - 1500672514737 Marionette TRACE 364 <- [1,5,null,{"value":true}]
14:28:34 INFO - 1500672514747 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}]
14:28:34 INFO - TEST-END: test_click.py TestClick.test_container_element1500672514762 Marionette TRACE 364 <- [1,6,null,{"value":null}]
14:28:34 INFO - 1500672514768 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:34 INFO - 1500672514777 Marionette TRACE 364 <- [1,7,null,{}]
14:28:34 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1054ms
14:28:34 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
14:28:34 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:34 INFO - 1500672514787 Marionette DEBUG Closed connection 364
14:28:34 INFO - 1500672514789 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49795
14:28:34 INFO - 1500672514793 Marionette DEBUG Closed connection 365
14:28:34 INFO - 1500672514798 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49796
14:28:34 INFO - 1500672514803 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:34 INFO - 1500672514813 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:34 INFO - 1500672514860 Marionette DEBUG Register listener.js for window 15
14:28:34 INFO - 1500672514893 Marionette TRACE 366 <- [1,1,null,{"sessionId":"69034be4-7682-4f07-a3e7-4b465682da5b","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:34 INFO - 1500672514931 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
14:28:34 INFO - 1500672514936 Marionette TRACE 366 <- [1,2,null,{}]
14:28:34 INFO - 1500672514988 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:34 INFO - 1500672514991 Marionette TRACE 366 <- [1,3,null,{}]
14:28:34 INFO - 1500672514995 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:34 INFO - 1500672514997 Marionette TRACE 366 <- [1,4,null,{}]
14:28:35 INFO - 1500672515001 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}]
14:28:35 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500672515013 Marionette TRACE 366 <- [1,5,null,{"value":null}]
14:28:35 INFO - 1500672515017 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:35 INFO - 1500672515024 Marionette TRACE 366 <- [1,6,null,{}]
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:35 INFO - 1500672515083 Marionette DEBUG Closed connection 366
14:28:35 INFO - 1500672515086 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49797
14:28:35 INFO - 1500672515108 Marionette DEBUG Closed connection 367
14:28:35 INFO - 1500672515110 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49798
14:28:35 INFO - 1500672515114 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:35 INFO - 1500672515117 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:35 INFO - 1500672515164 Marionette DEBUG Register listener.js for window 15
14:28:35 INFO - 1500672515181 Marionette TRACE 368 <- [1,1,null,{"sessionId":"37164aa0-b385-4ff0-84f7-8701fd77e279","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:35 INFO - 1500672515204 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:35 INFO - 1500672515214 Marionette TRACE 368 <- [1,2,null,{}]
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:35 INFO - 1500672515240 Marionette DEBUG Closed connection 368
14:28:35 INFO - 1500672515243 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49799
14:28:35 INFO - 1500672515272 Marionette DEBUG Closed connection 369
14:28:35 INFO - 1500672515274 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49800
14:28:35 INFO - 1500672515280 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:35 INFO - 1500672515285 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:35 INFO - 1500672515331 Marionette DEBUG Register listener.js for window 15
14:28:35 INFO - 1500672515347 Marionette TRACE 370 <- [1,1,null,{"sessionId":"ecad1519-4023-44ef-a8ee-08c4721c2b3d","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:35 INFO - 1500672515359 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"}]
14:28:35 INFO - 1500672515365 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"
14:28:35 INFO - 1500672515373 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"
14:28:35 INFO - 1500672515374 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"
14:28:35 INFO - ++DOMWINDOW == 31 (000000DEC191E800) [pid = 2404] [serial = 43] [outer = 000000DECC2CD000]
14:28:35 INFO - 1500672515446 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"
14:28:35 INFO - 1500672515453 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"
14:28:35 INFO - 1500672515510 Marionette TRACE 370 <- [1,2,null,{}]
14:28:35 INFO - 1500672515513 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:28:35 INFO - 1500672515525 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"6878e23e-6868-4da1-8663-eb38152eaa9d","ELEMENT":"6878e23e-6868-4da1-8663-eb38152eaa9d"}}]
14:28:35 INFO - 1500672515527 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"6878e23e-6868-4da1-8663-eb38152eaa9d"}]
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
14:28:35 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
14:28:36 INFO - 1500672516275 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:28:36 INFO - 1500672516279 Marionette TRACE 370 <- [1,4,null,{}]
14:28:36 INFO - 1500672516288 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"6878e23e-6868-4da1-8663-eb38152eaa9d","name":"selected"}]
14:28:36 INFO - 1500672516324 Marionette TRACE 370 <- [1,5,null,{"value":true}]
14:28:36 INFO - 1500672516334 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}]
14:28:36 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500672516347 Marionette TRACE 370 <- [1,6,null,{"value":null}]
14:28:36 INFO - 1500672516351 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516361 Marionette TRACE 370 <- [1,7,null,{}]
14:28:36 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1583ms
14:28:36 INFO - TEST-START | test_click.py TestClick.test_css_transforms
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516369 Marionette DEBUG Closed connection 370
14:28:36 INFO - 1500672516372 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49801
14:28:36 INFO - 1500672516415 Marionette DEBUG Closed connection 371
14:28:36 INFO - 1500672516420 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49802
14:28:36 INFO - 1500672516446 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:36 INFO - 1500672516457 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:36 INFO - 1500672516484 Marionette DEBUG Register listener.js for window 15
14:28:36 INFO - 1500672516506 Marionette TRACE 372 <- [1,1,null,{"sessionId":"3c4df456-a457-401f-af70-015a4eb9697e","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:36 INFO - 1500672516523 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
14:28:36 INFO - 1500672516528 Marionette TRACE 372 <- [1,2,null,{}]
14:28:36 INFO - 1500672516547 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:36 INFO - 1500672516549 Marionette TRACE 372 <- [1,3,null,{}]
14:28:36 INFO - 1500672516556 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:36 INFO - 1500672516559 Marionette TRACE 372 <- [1,4,null,{}]
14:28:36 INFO - 1500672516562 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}]
14:28:36 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500672516573 Marionette TRACE 372 <- [1,5,null,{"value":null}]
14:28:36 INFO - 1500672516577 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516584 Marionette TRACE 372 <- [1,6,null,{}]
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516645 Marionette DEBUG Closed connection 372
14:28:36 INFO - 1500672516648 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49803
14:28:36 INFO - 1500672516671 Marionette DEBUG Closed connection 373
14:28:36 INFO - 1500672516673 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49804
14:28:36 INFO - 1500672516676 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:36 INFO - 1500672516679 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:36 INFO - 1500672516705 Marionette DEBUG Register listener.js for window 15
14:28:36 INFO - 1500672516722 Marionette TRACE 374 <- [1,1,null,{"sessionId":"d83158e8-72a3-4aad-82ce-4836464f20a1","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:36 INFO - 1500672516757 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516765 Marionette TRACE 374 <- [1,2,null,{}]
14:28:36 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:36 INFO - 1500672516793 Marionette DEBUG Closed connection 374
14:28:36 INFO - 1500672516795 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49805
14:28:36 INFO - 1500672516800 Marionette DEBUG Closed connection 375
14:28:36 INFO - 1500672516802 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49806
14:28:36 INFO - 1500672516808 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:36 INFO - 1500672516812 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:36 INFO - 1500672516836 Marionette DEBUG Register listener.js for window 15
14:28:36 INFO - 1500672516851 Marionette TRACE 376 <- [1,1,null,{"sessionId":"d6015627-b502-4efa-ae37-96bca11f56fd","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:36 INFO - 1500672516863 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"}]
14:28:36 INFO - 1500672516868 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"
14:28:36 INFO - 1500672516876 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"
14:28:36 INFO - 1500672516876 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"
14:28:36 INFO - ++DOMWINDOW == 32 (000000DEBEEB2000) [pid = 2404] [serial = 44] [outer = 000000DECC2CD000]
14:28:36 INFO - 1500672516940 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"
14:28:36 INFO - 1500672516947 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"
14:28:36 INFO - 1500672516965 Marionette TRACE 376 <- [1,2,null,{}]
14:28:36 INFO - 1500672516977 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
14:28:36 INFO - 1500672516988 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"005f8df9-c3c4-4463-aeab-b4a79f237455","ELEMENT":"005f8df9-c3c4-4463-aeab-b4a79f237455"}}]
14:28:36 INFO - 1500672516991 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"005f8df9-c3c4-4463-aeab-b4a79f237455"}]
14:28:37 INFO - --DOMWINDOW == 31 (000000DEBEB79000) [pid = 2404] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 30 (000000DECFFA8000) [pid = 2404] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 29 (000000DEC8988000) [pid = 2404] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 28 (000000DECAFA9000) [pid = 2404] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 27 (000000DECB89F800) [pid = 2404] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 26 (000000DED0D1C800) [pid = 2404] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 25 (000000DED420D800) [pid = 2404] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - --DOMWINDOW == 24 (000000DED3445000) [pid = 2404] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49332/test_accessibility.html]
14:28:37 INFO - 1500672517416 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:28:37 INFO - 1500672517418 Marionette TRACE 376 <- [1,4,null,{}]
14:28:37 INFO - 1500672517422 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}]
14:28:37 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500672517431 Marionette TRACE 376 <- [1,5,null,{"value":null}]
14:28:37 INFO - 1500672517434 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
14:28:37 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:37 INFO - 1500672517439 Marionette TRACE 376 <- [1,6,null,{}]
14:28:37 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1077ms
14:28:37 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
14:28:37 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:37 INFO - 1500672517464 Marionette DEBUG Closed connection 376
14:28:37 INFO - 1500672517466 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49807
14:28:37 INFO - 1500672517470 Marionette DEBUG Closed connection 377
14:28:37 INFO - 1500672517472 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49808
14:28:37 INFO - 1500672517478 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:37 INFO - 1500672517481 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:37 INFO - 1500672517507 Marionette DEBUG Register listener.js for window 15
14:28:37 INFO - 1500672517523 Marionette TRACE 378 <- [1,1,null,{"sessionId":"366d1ee5-bbfe-4430-94b4-3d822076cb98","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:37 INFO - 1500672517534 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
14:28:37 INFO - 1500672517536 Marionette TRACE 378 <- [1,2,null,{}]
14:28:37 INFO - 1500672517539 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:37 INFO - 1500672517541 Marionette TRACE 378 <- [1,3,null,{}]
14:28:37 INFO - 1500672517545 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:37 INFO - 1500672517547 Marionette TRACE 378 <- [1,4,null,{}]
14:28:38 INFO - 1500672518328 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}]
14:28:38 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500672518342 Marionette TRACE 378 <- [1,5,null,{"value":null}]
14:28:38 INFO - 1500672518388 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
14:28:38 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:38 INFO - 1500672518393 Marionette TRACE 378 <- [1,6,null,{}]
14:28:38 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:38 INFO - 1500672518456 Marionette DEBUG Closed connection 378
14:28:38 INFO - 1500672518458 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49809
14:28:38 INFO - 1500672518510 Marionette DEBUG Closed connection 379
14:28:38 INFO - 1500672518512 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49810
14:28:38 INFO - 1500672518565 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:38 INFO - 1500672518570 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:38 INFO - 1500672518595 Marionette DEBUG Register listener.js for window 15
14:28:38 INFO - 1500672518610 Marionette TRACE 380 <- [1,1,null,{"sessionId":"beb3eb1e-1e60-4285-bddc-6b29b654e9a7","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:38 INFO - 1500672518667 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
14:28:38 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:38 INFO - 1500672518672 Marionette TRACE 380 <- [1,2,null,{}]
14:28:38 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:38 INFO - 1500672518730 Marionette DEBUG Closed connection 380
14:28:38 INFO - 1500672518735 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49811
14:28:38 INFO - 1500672518758 Marionette DEBUG Closed connection 381
14:28:38 INFO - 1500672518760 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49812
14:28:38 INFO - 1500672518784 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:38 INFO - 1500672518787 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:38 INFO - 1500672518812 Marionette DEBUG Register listener.js for window 15
14:28:38 INFO - 1500672518826 Marionette TRACE 382 <- [1,1,null,{"sessionId":"ea975c03-7a89-4bbf-9f19-2f888ceff33d","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:38 INFO - 1500672518833 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"}]
14:28:38 INFO - 1500672518838 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"
14:28:38 INFO - 1500672518845 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"
14:28:38 INFO - 1500672518846 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"
14:28:38 INFO - ++DOMWINDOW == 25 (000000DEC16B1800) [pid = 2404] [serial = 45] [outer = 000000DECC2CD000]
14:28:38 INFO - 1500672518913 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"
14:28:38 INFO - 1500672518918 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"
14:28:38 INFO - 1500672518939 Marionette TRACE 382 <- [1,2,null,{}]
14:28:38 INFO - 1500672518955 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
14:28:38 INFO - 1500672518966 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"69bc4d36-f07f-4f44-afaf-22c20a157e07","ELEMENT":"69bc4d36-f07f-4f44-afaf-22c20a157e07"}}]
14:28:38 INFO - 1500672518968 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"69bc4d36-f07f-4f44-afaf-22c20a157e07"}]
14:28:39 INFO - 1500672519425 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:28:39 INFO - 1500672519427 Marionette TRACE 382 <- [1,4,null,{}]
14:28:39 INFO - 1500672519430 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}]
14:28:39 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500672519438 Marionette TRACE 382 <- [1,5,null,{"value":null}]
14:28:39 INFO - 1500672519440 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519445 Marionette TRACE 382 <- [1,6,null,{}]
14:28:39 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 2005ms
14:28:39 INFO - TEST-START | test_click.py TestClick.test_input_file
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519451 Marionette DEBUG Closed connection 382
14:28:39 INFO - 1500672519452 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49813
14:28:39 INFO - 1500672519454 Marionette DEBUG Closed connection 383
14:28:39 INFO - 1500672519456 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49814
14:28:39 INFO - 1500672519458 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:39 INFO - 1500672519460 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:39 INFO - 1500672519483 Marionette DEBUG Register listener.js for window 15
14:28:39 INFO - 1500672519495 Marionette TRACE 384 <- [1,1,null,{"sessionId":"b2b6884d-bdc7-4f07-8af3-963693011110","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:39 INFO - 1500672519503 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
14:28:39 INFO - 1500672519505 Marionette TRACE 384 <- [1,2,null,{}]
14:28:39 INFO - 1500672519532 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:39 INFO - 1500672519534 Marionette TRACE 384 <- [1,3,null,{}]
14:28:39 INFO - 1500672519536 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:39 INFO - 1500672519537 Marionette TRACE 384 <- [1,4,null,{}]
14:28:39 INFO - 1500672519540 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}]
14:28:39 INFO - TEST-START: test_click.py TestClick.test_input_file1500672519549 Marionette TRACE 384 <- [1,5,null,{"value":null}]
14:28:39 INFO - 1500672519551 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519556 Marionette TRACE 384 <- [1,6,null,{}]
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519562 Marionette DEBUG Closed connection 384
14:28:39 INFO - 1500672519563 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49815
14:28:39 INFO - 1500672519565 Marionette DEBUG Closed connection 385
14:28:39 INFO - 1500672519568 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49816
14:28:39 INFO - 1500672519591 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:39 INFO - 1500672519594 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:39 INFO - 1500672519618 Marionette DEBUG Register listener.js for window 15
14:28:39 INFO - 1500672519629 Marionette TRACE 386 <- [1,1,null,{"sessionId":"b43bbc25-8820-477b-a78f-d8aa4e3ab78c","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:39 INFO - 1500672519639 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519643 Marionette TRACE 386 <- [1,2,null,{}]
14:28:39 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:39 INFO - 1500672519665 Marionette DEBUG Closed connection 386
14:28:39 INFO - 1500672519667 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49817
14:28:39 INFO - 1500672519671 Marionette DEBUG Closed connection 387
14:28:39 INFO - 1500672519672 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49818
14:28:39 INFO - 1500672519674 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:39 INFO - 1500672519678 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:39 INFO - 1500672519701 Marionette DEBUG Register listener.js for window 15
14:28:39 INFO - 1500672519713 Marionette TRACE 388 <- [1,1,null,{"sessionId":"701059c9-6a99-47d0-9d17-8f27f83505cd","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:39 INFO - 1500672519724 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
14:28:39 INFO - 1500672519728 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"
14:28:39 INFO - 1500672519733 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"
14:28:39 INFO - 1500672519735 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"
14:28:39 INFO - ++DOMWINDOW == 26 (000000DEC5FCD800) [pid = 2404] [serial = 46] [outer = 000000DECC2CD000]
14:28:39 INFO - 1500672519796 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:28:39 INFO - 1500672519802 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:28:39 INFO - 1500672519819 Marionette TRACE 388 <- [1,2,null,{}]
14:28:39 INFO - 1500672519827 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
14:28:39 INFO - 1500672519836 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fe89adff-c8e5-4ceb-a751-e2b6ba25f52f","ELEMENT":"fe89adff-c8e5-4ceb-a751-e2b6ba25f52f"}}]
14:28:39 INFO - 1500672519838 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"fe89adff-c8e5-4ceb-a751-e2b6ba25f52f"}]
14:28:40 INFO - 1500672520025 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]
14:28:40 INFO - 1500672520028 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}]
14:28:40 INFO - TEST-END: test_click.py TestClick.test_input_file1500672520037 Marionette TRACE 388 <- [1,5,null,{"value":null}]
14:28:40 INFO - 1500672520039 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520043 Marionette TRACE 388 <- [1,6,null,{}]
14:28:40 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 599ms
14:28:40 INFO - TEST-START | test_click.py TestClick.test_obscured_element
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520049 Marionette DEBUG Closed connection 388
14:28:40 INFO - 1500672520051 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49819
14:28:40 INFO - 1500672520053 Marionette DEBUG Closed connection 389
14:28:40 INFO - 1500672520054 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49820
14:28:40 INFO - 1500672520077 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:40 INFO - 1500672520080 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:40 INFO - 1500672520104 Marionette DEBUG Register listener.js for window 15
14:28:40 INFO - 1500672520115 Marionette TRACE 390 <- [1,1,null,{"sessionId":"ec7a203b-2ae6-47cd-a9bd-f2e79ad6a1df","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:40 INFO - 1500672520125 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
14:28:40 INFO - 1500672520127 Marionette TRACE 390 <- [1,2,null,{}]
14:28:40 INFO - 1500672520130 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:40 INFO - 1500672520132 Marionette TRACE 390 <- [1,3,null,{}]
14:28:40 INFO - 1500672520134 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:40 INFO - 1500672520136 Marionette TRACE 390 <- [1,4,null,{}]
14:28:40 INFO - 1500672520139 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}]
14:28:40 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500672520147 Marionette TRACE 390 <- [1,5,null,{"value":null}]
14:28:40 INFO - 1500672520149 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520153 Marionette TRACE 390 <- [1,6,null,{}]
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520177 Marionette DEBUG Closed connection 390
14:28:40 INFO - 1500672520179 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49821
14:28:40 INFO - 1500672520183 Marionette DEBUG Closed connection 391
14:28:40 INFO - 1500672520184 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49822
14:28:40 INFO - 1500672520186 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:40 INFO - 1500672520190 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:40 INFO - 1500672520218 Marionette DEBUG Register listener.js for window 15
14:28:40 INFO - 1500672520233 Marionette TRACE 392 <- [1,1,null,{"sessionId":"145d9ee4-5e6d-47d6-8576-49b6017b7de7","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:40 INFO - 1500672520244 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520248 Marionette TRACE 392 <- [1,2,null,{}]
14:28:40 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:40 INFO - 1500672520271 Marionette DEBUG Closed connection 392
14:28:40 INFO - 1500672520272 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49823
14:28:40 INFO - 1500672520277 Marionette DEBUG Closed connection 393
14:28:40 INFO - 1500672520278 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49824
14:28:40 INFO - 1500672520281 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:40 INFO - 1500672520284 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:40 INFO - 1500672520308 Marionette DEBUG Register listener.js for window 15
14:28:40 INFO - 1500672520320 Marionette TRACE 394 <- [1,1,null,{"sessionId":"d9ae633a-24d4-4ea5-8a45-4a6b2879c2a3","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:40 INFO - 1500672520331 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"}]
14:28:40 INFO - 1500672520338 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:28:40 INFO - 1500672520344 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:28:40 INFO - 1500672520345 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:28:40 INFO - ++DOMWINDOW == 27 (000000DEC882A800) [pid = 2404] [serial = 47] [outer = 000000DECC2CD000]
14:28:40 INFO - 1500672520408 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"
14:28:40 INFO - 1500672520413 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"
14:28:40 INFO - 1500672520422 Marionette TRACE 394 <- [1,2,null,{}]
14:28:40 INFO - 1500672520433 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
14:28:40 INFO - 1500672520441 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7df3ab0c-ec84-4896-9294-52f1786fa1e8","ELEMENT":"7df3ab0c-ec84-4896-9294-52f1786fa1e8"}}]
14:28:40 INFO - 1500672520449 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
14:28:40 INFO - 1500672520456 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2475434f-03e5-492f-9c4d-ab85df8089d2","ELEMENT":"2475434f-03e5-492f-9c4d-ab85df8089d2"}}]
14:28:40 INFO - 1500672520458 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"7df3ab0c-ec84-4896-9294-52f1786fa1e8"}]
14:28:40 INFO - 1500672520901 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:28:40 INFO - 1500672520903 Marionette TRACE 394 <- [1,5,null,{}]
14:28:40 INFO - 1500672520905 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"2475434f-03e5-492f-9c4d-ab85df8089d2"}]
14:28:41 INFO - 1500672521048 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]
14:28:41 INFO - 1500672521679 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
14:28:41 INFO - 1500672521688 Marionette TRACE 394 <- [1,7,null,{"value":false}]
14:28:41 INFO - 1500672521731 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}]
14:28:41 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500672521739 Marionette TRACE 394 <- [1,8,null,{"value":null}]
14:28:41 INFO - 1500672521744 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
14:28:41 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:41 INFO - 1500672521748 Marionette TRACE 394 <- [1,9,null,{}]
14:28:41 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1705ms
14:28:41 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
14:28:41 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:41 INFO - 1500672521808 Marionette DEBUG Closed connection 394
14:28:41 INFO - 1500672521811 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49825
14:28:41 INFO - 1500672521818 Marionette DEBUG Closed connection 395
14:28:41 INFO - 1500672521821 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49826
14:28:41 INFO - 1500672521826 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:41 INFO - 1500672521838 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:41 INFO - 1500672521890 Marionette DEBUG Register listener.js for window 15
14:28:41 INFO - 1500672521913 Marionette TRACE 396 <- [1,1,null,{"sessionId":"c7baae4e-8b57-413c-a3bb-e477c4ec6d94","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:41 INFO - 1500672521937 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
14:28:41 INFO - 1500672521941 Marionette TRACE 396 <- [1,2,null,{}]
14:28:41 INFO - 1500672521951 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:28:41 INFO - 1500672521956 Marionette TRACE 396 <- [1,3,null,{}]
14:28:41 INFO - 1500672521960 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
14:28:41 INFO - 1500672521965 Marionette TRACE 396 <- [1,4,null,{}]
14:28:42 INFO - 1500672522018 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}]
14:28:42 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500672522032 Marionette TRACE 396 <- [1,5,null,{"value":null}]
14:28:42 INFO - 1500672522037 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
14:28:42 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:42 INFO - 1500672522046 Marionette TRACE 396 <- [1,6,null,{}]
14:28:42 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:42 INFO - 1500672522105 Marionette DEBUG Closed connection 396
14:28:42 INFO - 1500672522109 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49827
14:28:42 INFO - 1500672522131 Marionette DEBUG Closed connection 397
14:28:42 INFO - 1500672522133 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49828
14:28:42 INFO - 1500672522137 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:28:42 INFO - 1500672522142 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:42 INFO - 1500672522194 Marionette DEBUG Register listener.js for window 15
14:28:42 INFO - 1500672522212 Marionette TRACE 398 <- [1,1,null,{"sessionId":"ad00c5e1-86db-4461-a8dd-45261c8d29e0","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:42 INFO - 1500672522223 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
14:28:42 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:42 INFO - 1500672522228 Marionette TRACE 398 <- [1,2,null,{}]
14:28:42 INFO - [Parent 2404] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:28:42 INFO - 1500672522237 Marionette DEBUG Closed connection 398
14:28:42 INFO - 1500672522239 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49829
14:28:42 INFO - 1500672522253 Marionette DEBUG Closed connection 399
14:28:42 INFO - 1500672522255 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49830
14:28:42 INFO - 1500672522281 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:28:42 INFO - 1500672522286 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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}
14:28:42 INFO - 1500672522338 Marionette DEBUG Register listener.js for window 15
14:28:42 INFO - 1500672522356 Marionette TRACE 400 <- [1,1,null,{"sessionId":"8120cf9e-3c7c-4e51-8ce1-4efcfd1798bc","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":2404,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-317.001\\AppData\\Local\\Temp\\tmp3bmdgd.mozrunner","moz:accessibilityChecks":false}}]
14:28:42 INFO - 1500672522368 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"}]
14:28:42 INFO - 1500672522374 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"
14:28:42 INFO - 1500672522383 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"
14:28:42 INFO - 1500672522384 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"
14:28:42 INFO - ++DOMWINDOW == 28 (000000DEBFF86800) [pid = 2404] [serial = 48] [outer = 000000DECC2CD000]
14:28:42 INFO - 1500672522471 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"
14:28:42 INFO - 1500672522478 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"
14:28:42 INFO - 1500672522497 Marionette TRACE 400 <- [1,2,null,{}]
14:28:42 INFO - 1500672522507 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
14:28:42 INFO - 1500672522521 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d4db87e7-2c04-41e7-8f86-1e62d2a25de9","ELEMENT":"d4db87e7-2c04-41e7-8f86-1e62d2a25de9"}}]
14:28:42 INFO - 1500672522523 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"d4db87e7-2c04-41e7-8f86-1e62d2a25de9"}]
14:28:42 INFO - 1500672522722 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
14:28:42 INFO - 1500672522736 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"d4db87e7-2c04-41e7-8f86-1e62d2a25de9"}]
14:28:43 INFO - 1500672523008 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element