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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:36:49 INFO - 1499531809806 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}]
09:36:49 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499531809814 Marionette TRACE 352 <- [1,5,null,{"value":null}]
09:36:49 INFO - 1499531809815 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809819 Marionette TRACE 352 <- [1,6,null,{}]
09:36:49 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 626ms
09:36:49 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809825 Marionette DEBUG Closed connection 352
09:36:49 INFO - 1499531809826 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49898
09:36:49 INFO - 1499531809828 Marionette DEBUG Closed connection 353
09:36:49 INFO - 1499531809829 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49899
09:36:49 INFO - 1499531809831 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:49 INFO - 1499531809833 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:49 INFO - 1499531809855 Marionette DEBUG Register listener.js for window 12
09:36:49 INFO - 1499531809866 Marionette TRACE 354 <- [1,1,null,{"sessionId":"cf954427-5805-4a11-9b15-74db2b910e99","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:49 INFO - 1499531809895 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
09:36:49 INFO - 1499531809897 Marionette TRACE 354 <- [1,2,null,{}]
09:36:49 INFO - 1499531809899 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:49 INFO - 1499531809900 Marionette TRACE 354 <- [1,3,null,{}]
09:36:49 INFO - 1499531809902 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:49 INFO - 1499531809903 Marionette TRACE 354 <- [1,4,null,{}]
09:36:49 INFO - 1499531809906 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}]
09:36:49 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499531809913 Marionette TRACE 354 <- [1,5,null,{"value":null}]
09:36:49 INFO - 1499531809915 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809919 Marionette TRACE 354 <- [1,6,null,{}]
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809925 Marionette DEBUG Closed connection 354
09:36:49 INFO - 1499531809926 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49900
09:36:49 INFO - 1499531809928 Marionette DEBUG Closed connection 355
09:36:49 INFO - 1499531809930 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49901
09:36:49 INFO - 1499531809932 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:49 INFO - 1499531809934 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:49 INFO - 1499531809955 Marionette DEBUG Register listener.js for window 12
09:36:49 INFO - 1499531809965 Marionette TRACE 356 <- [1,1,null,{"sessionId":"99c12455-91d1-419c-a8fd-ac61f717abb4","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:49 INFO - 1499531809971 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809975 Marionette TRACE 356 <- [1,2,null,{}]
09:36:49 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:49 INFO - 1499531809981 Marionette DEBUG Closed connection 356
09:36:49 INFO - 1499531809982 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49902
09:36:49 INFO - 1499531809984 Marionette DEBUG Closed connection 357
09:36:49 INFO - 1499531809985 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49903
09:36:49 INFO - 1499531809987 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:49 INFO - 1499531809990 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:50 INFO - 1499531810013 Marionette DEBUG Register listener.js for window 12
09:36:50 INFO - 1499531810024 Marionette TRACE 358 <- [1,1,null,{"sessionId":"97a167e0-e89f-40d3-b066-6d38a8b62817","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:50 INFO - 1499531810079 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49450/clicks.html"}]
09:36:50 INFO - 1499531810082 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49450/hidden.html"
09:36:50 INFO - 1499531810099 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49450/hidden.html"
09:36:50 INFO - 1499531810100 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49450/hidden.html"
09:36:50 INFO - ++DOMWINDOW == 29 (00000063F50F8800) [pid = 1796] [serial = 44] [outer = 0000006382DB1800]
09:36:50 INFO - 1499531810185 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49450/clicks.html"
09:36:50 INFO - 1499531810196 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49450/clicks.html"
09:36:50 INFO - 1499531810218 Marionette TRACE 358 <- [1,2,null,{}]
09:36:50 INFO - 1499531810229 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
09:36:50 INFO - 1499531810235 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2fda8068-bc90-43fc-9255-6effbebbe7da","ELEMENT":"2fda8068-bc90-43fc-9255-6effbebbe7da"}}]
09:36:50 INFO - 1499531810240 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"2fda8068-bc90-43fc-9255-6effbebbe7da"}]
09:36:50 INFO - 1499531810483 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49450/clicks.html"
09:36:50 INFO - [1796] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
09:36:50 INFO - 1499531810505 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49450/clicks.html"
09:36:50 INFO - 1499531810508 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49450/clicks.html"
09:36:50 INFO - ++DOMWINDOW == 30 (00000063825D1800) [pid = 1796] [serial = 45] [outer = 0000006382DB1800]
09:36:50 INFO - 1499531810610 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49450/test.html"
09:36:50 INFO - 1499531810618 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49450/test.html"
09:36:50 INFO - 1499531810653 Marionette TRACE 358 <- [1,4,null,{}]
09:36:50 INFO - 1499531810658 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
09:36:50 INFO - 1499531810671 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"39c18fd7-0e64-43d0-be50-91c27d6bcb4f","ELEMENT":"39c18fd7-0e64-43d0-be50-91c27d6bcb4f"}}]
09:36:50 INFO - 1499531810706 Marionette TRACE 358 -> [0,6,"getTitle",{}]
09:36:50 INFO - 1499531810709 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
09:36:50 INFO - 1499531810715 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}]
09:36:50 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499531810729 Marionette TRACE 358 <- [1,7,null,{"value":null}]
09:36:50 INFO - 1499531810733 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
09:36:50 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:50 INFO - 1499531810742 Marionette TRACE 358 <- [1,8,null,{}]
09:36:50 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 935ms
09:36:50 INFO - TEST-START | test_click.py TestClick.test_container_element
09:36:50 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:50 INFO - 1499531810782 Marionette DEBUG Closed connection 358
09:36:50 INFO - 1499531810785 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49906
09:36:50 INFO - 1499531810790 Marionette DEBUG Closed connection 359
09:36:50 INFO - 1499531810793 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49907
09:36:50 INFO - 1499531810846 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:50 INFO - 1499531810857 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:50 INFO - 1499531810901 Marionette DEBUG Register listener.js for window 12
09:36:50 INFO - 1499531810922 Marionette TRACE 360 <- [1,1,null,{"sessionId":"2a0d0292-fd7f-41ce-8ca5-ab91ec524429","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:50 INFO - 1499531810939 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
09:36:50 INFO - 1499531810942 Marionette TRACE 360 <- [1,2,null,{}]
09:36:51 INFO - 1499531810994 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:51 INFO - 1499531810996 Marionette TRACE 360 <- [1,3,null,{}]
09:36:51 INFO - 1499531811001 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:51 INFO - 1499531811003 Marionette TRACE 360 <- [1,4,null,{}]
09:36:51 INFO - 1499531811008 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}]
09:36:51 INFO - TEST-START: test_click.py TestClick.test_container_element1499531811020 Marionette TRACE 360 <- [1,5,null,{"value":null}]
09:36:51 INFO - 1499531811073 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:51 INFO - 1499531811080 Marionette TRACE 360 <- [1,6,null,{}]
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:51 INFO - 1499531811089 Marionette DEBUG Closed connection 360
09:36:51 INFO - 1499531811092 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49908
09:36:51 INFO - 1499531811117 Marionette DEBUG Closed connection 361
09:36:51 INFO - 1499531811119 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49909
09:36:51 INFO - 1499531811148 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:51 INFO - 1499531811154 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:51 INFO - 1499531811197 Marionette DEBUG Register listener.js for window 12
09:36:51 INFO - 1499531811213 Marionette TRACE 362 <- [1,1,null,{"sessionId":"f2327e99-5766-4601-8734-f7b68c140151","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:51 INFO - 1499531811237 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:51 INFO - 1499531811244 Marionette TRACE 362 <- [1,2,null,{}]
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:51 INFO - 1499531811268 Marionette DEBUG Closed connection 362
09:36:51 INFO - 1499531811271 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49910
09:36:51 INFO - 1499531811273 Marionette DEBUG Closed connection 363
09:36:51 INFO - 1499531811276 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49911
09:36:51 INFO - 1499531811294 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:51 INFO - 1499531811298 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:51 INFO - 1499531811343 Marionette DEBUG Register listener.js for window 12
09:36:51 INFO - 1499531811359 Marionette TRACE 364 <- [1,1,null,{"sessionId":"47039141-e874-4df5-b92b-915f90af2ed6","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:51 INFO - 1499531811368 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"}]
09:36:51 INFO - 1499531811374 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49450/test.html"
09:36:51 INFO - 1499531811384 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49450/test.html"
09:36:51 INFO - 1499531811385 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49450/test.html"
09:36:51 INFO - ++DOMWINDOW == 31 (0000006387B16000) [pid = 1796] [serial = 46] [outer = 0000006382DB1800]
09:36:51 INFO - 1499531811448 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"
09:36:51 INFO - 1499531811464 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"
09:36:51 INFO - 1499531811495 Marionette TRACE 364 <- [1,2,null,{}]
09:36:51 INFO - 1499531811498 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:36:51 INFO - 1499531811510 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0968bf75-5293-4bfe-b3cd-35f95cf4815e","ELEMENT":"0968bf75-5293-4bfe-b3cd-35f95cf4815e"}}]
09:36:51 INFO - 1499531811512 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"0968bf75-5293-4bfe-b3cd-35f95cf4815e"}]
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
09:36:51 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
09:36:52 INFO - 1499531812123 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:36:52 INFO - 1499531812125 Marionette TRACE 364 <- [1,4,null,{}]
09:36:52 INFO - 1499531812128 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"0968bf75-5293-4bfe-b3cd-35f95cf4815e","name":"selected"}]
09:36:52 INFO - 1499531812183 Marionette TRACE 364 <- [1,5,null,{"value":true}]
09:36:52 INFO - 1499531812185 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}]
09:36:52 INFO - TEST-END: test_click.py TestClick.test_container_element1499531812196 Marionette TRACE 364 <- [1,6,null,{"value":null}]
09:36:52 INFO - 1499531812199 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812203 Marionette TRACE 364 <- [1,7,null,{}]
09:36:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1449ms
09:36:52 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812211 Marionette DEBUG Closed connection 364
09:36:52 INFO - 1499531812213 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49912
09:36:52 INFO - 1499531812215 Marionette DEBUG Closed connection 365
09:36:52 INFO - 1499531812217 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49913
09:36:52 INFO - 1499531812222 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:52 INFO - 1499531812225 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:52 INFO - 1499531812270 Marionette DEBUG Register listener.js for window 12
09:36:52 INFO - 1499531812285 Marionette TRACE 366 <- [1,1,null,{"sessionId":"0ae3eb16-e144-46a3-8998-407eb59cae45","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:52 INFO - 1499531812304 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
09:36:52 INFO - 1499531812306 Marionette TRACE 366 <- [1,2,null,{}]
09:36:52 INFO - 1499531812308 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:52 INFO - 1499531812310 Marionette TRACE 366 <- [1,3,null,{}]
09:36:52 INFO - 1499531812312 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:52 INFO - 1499531812314 Marionette TRACE 366 <- [1,4,null,{}]
09:36:52 INFO - 1499531812316 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}]
09:36:52 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499531812326 Marionette TRACE 366 <- [1,5,null,{"value":null}]
09:36:52 INFO - 1499531812362 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812367 Marionette TRACE 366 <- [1,6,null,{}]
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812391 Marionette DEBUG Closed connection 366
09:36:52 INFO - 1499531812393 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49914
09:36:52 INFO - 1499531812430 Marionette DEBUG Closed connection 367
09:36:52 INFO - 1499531812432 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49915
09:36:52 INFO - 1499531812438 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:52 INFO - 1499531812444 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:52 INFO - 1499531812489 Marionette DEBUG Register listener.js for window 12
09:36:52 INFO - 1499531812506 Marionette TRACE 368 <- [1,1,null,{"sessionId":"8bf38d80-6fe9-43a2-ae0f-ae9340c94c06","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:52 INFO - 1499531812517 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812522 Marionette TRACE 368 <- [1,2,null,{}]
09:36:52 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:52 INFO - 1499531812538 Marionette DEBUG Closed connection 368
09:36:52 INFO - 1499531812543 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49916
09:36:52 INFO - 1499531812564 Marionette DEBUG Closed connection 369
09:36:52 INFO - 1499531812566 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49917
09:36:52 INFO - 1499531812569 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:52 INFO - 1499531812572 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:52 INFO - 1499531812616 Marionette DEBUG Register listener.js for window 12
09:36:52 INFO - 1499531812631 Marionette TRACE 370 <- [1,1,null,{"sessionId":"5b6bb340-ef4c-438b-b4b6-53367c145816","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:52 INFO - 1499531812838 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"}]
09:36:52 INFO - 1499531812845 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"
09:36:52 INFO - 1499531812855 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"
09:36:52 INFO - 1499531812857 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"
09:36:52 INFO - ++DOMWINDOW == 32 (0000006382DA3000) [pid = 1796] [serial = 47] [outer = 0000006382DB1800]
09:36:52 INFO - 1499531812913 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"
09:36:52 INFO - 1499531812931 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"
09:36:52 INFO - 1499531812952 Marionette TRACE 370 <- [1,2,null,{}]
09:36:52 INFO - 1499531812965 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
09:36:52 INFO - 1499531812979 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8f7179ed-dd2a-4f52-a5a7-b12f42f3d06f","ELEMENT":"8f7179ed-dd2a-4f52-a5a7-b12f42f3d06f"}}]
09:36:52 INFO - 1499531812983 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"8f7179ed-dd2a-4f52-a5a7-b12f42f3d06f"}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
09:36:53 INFO - 1499531813446 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:36:53 INFO - 1499531813450 Marionette TRACE 370 <- [1,4,null,{}]
09:36:53 INFO - 1499531813455 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"8f7179ed-dd2a-4f52-a5a7-b12f42f3d06f","name":"selected"}]
09:36:53 INFO - 1499531813488 Marionette TRACE 370 <- [1,5,null,{"value":true}]
09:36:53 INFO - 1499531813497 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}]
09:36:53 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499531813507 Marionette TRACE 370 <- [1,6,null,{"value":null}]
09:36:53 INFO - 1499531813543 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813553 Marionette TRACE 370 <- [1,7,null,{}]
09:36:53 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1349ms
09:36:53 INFO - TEST-START | test_click.py TestClick.test_css_transforms
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813564 Marionette DEBUG Closed connection 370
09:36:53 INFO - 1499531813567 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49918
09:36:53 INFO - 1499531813592 Marionette DEBUG Closed connection 371
09:36:53 INFO - 1499531813594 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49919
09:36:53 INFO - 1499531813601 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:53 INFO - 1499531813611 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:53 INFO - 1499531813634 Marionette DEBUG Register listener.js for window 12
09:36:53 INFO - 1499531813652 Marionette TRACE 372 <- [1,1,null,{"sessionId":"2ef79463-e037-4a66-829d-a2930867ad73","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:53 INFO - 1499531813664 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
09:36:53 INFO - 1499531813666 Marionette TRACE 372 <- [1,2,null,{}]
09:36:53 INFO - 1499531813669 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:53 INFO - 1499531813671 Marionette TRACE 372 <- [1,3,null,{}]
09:36:53 INFO - 1499531813674 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:53 INFO - 1499531813676 Marionette TRACE 372 <- [1,4,null,{}]
09:36:53 INFO - 1499531813684 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}]
09:36:53 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499531813697 Marionette TRACE 372 <- [1,5,null,{"value":null}]
09:36:53 INFO - 1499531813705 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813711 Marionette TRACE 372 <- [1,6,null,{}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813735 Marionette DEBUG Closed connection 372
09:36:53 INFO - 1499531813738 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49920
09:36:53 INFO - 1499531813740 Marionette DEBUG Closed connection 373
09:36:53 INFO - 1499531813742 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49921
09:36:53 INFO - 1499531813744 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:53 INFO - 1499531813747 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:53 INFO - 1499531813770 Marionette DEBUG Register listener.js for window 12
09:36:53 INFO - 1499531813787 Marionette TRACE 374 <- [1,1,null,{"sessionId":"73277757-30d8-4775-9c11-874971ef72df","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:53 INFO - --DOMWINDOW == 31 (00000063F645B800) [pid = 1796] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - --DOMWINDOW == 30 (0000006381A57800) [pid = 1796] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - --DOMWINDOW == 29 (000000638701E800) [pid = 1796] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - --DOMWINDOW == 28 (0000006382DB9800) [pid = 1796] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - --DOMWINDOW == 27 (000000638407D800) [pid = 1796] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - --DOMWINDOW == 26 (0000006387024000) [pid = 1796] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49450/test_accessibility.html]
09:36:53 INFO - 1499531813812 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813818 Marionette TRACE 374 <- [1,2,null,{}]
09:36:53 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:53 INFO - 1499531813841 Marionette DEBUG Closed connection 374
09:36:53 INFO - 1499531813843 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49922
09:36:53 INFO - 1499531813845 Marionette DEBUG Closed connection 375
09:36:53 INFO - 1499531813847 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49923
09:36:53 INFO - 1499531813849 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:53 INFO - 1499531813853 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:53 INFO - 1499531813875 Marionette DEBUG Register listener.js for window 12
09:36:53 INFO - 1499531813909 Marionette TRACE 376 <- [1,1,null,{"sessionId":"d660a498-4e59-4bf2-a39b-409ce7e6bd34","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:53 INFO - 1499531813932 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"}]
09:36:53 INFO - 1499531813937 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"
09:36:53 INFO - 1499531813945 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"
09:36:53 INFO - 1499531813946 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"
09:36:53 INFO - ++DOMWINDOW == 27 (000000638406C800) [pid = 1796] [serial = 48] [outer = 0000006382DB1800]
09:36:54 INFO - 1499531814006 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"
09:36:54 INFO - 1499531814013 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"
09:36:54 INFO - 1499531814025 Marionette TRACE 376 <- [1,2,null,{}]
09:36:54 INFO - 1499531814035 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
09:36:54 INFO - 1499531814043 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c121b145-8f8e-4ddf-8c83-695c2571fc61","ELEMENT":"c121b145-8f8e-4ddf-8c83-695c2571fc61"}}]
09:36:54 INFO - 1499531814047 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"c121b145-8f8e-4ddf-8c83-695c2571fc61"}]
09:36:55 INFO - 1499531815236 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:36:55 INFO - 1499531815257 Marionette TRACE 376 <- [1,4,null,{}]
09:36:55 INFO - 1499531815263 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}]
09:36:55 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499531815271 Marionette TRACE 376 <- [1,5,null,{"value":null}]
09:36:55 INFO - 1499531815317 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815322 Marionette TRACE 376 <- [1,6,null,{}]
09:36:55 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1768ms
09:36:55 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815383 Marionette DEBUG Closed connection 376
09:36:55 INFO - 1499531815385 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49924
09:36:55 INFO - 1499531815389 Marionette DEBUG Closed connection 377
09:36:55 INFO - 1499531815391 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49925
09:36:55 INFO - 1499531815442 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:55 INFO - 1499531815445 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:55 INFO - 1499531815468 Marionette DEBUG Register listener.js for window 12
09:36:55 INFO - 1499531815494 Marionette TRACE 378 <- [1,1,null,{"sessionId":"7045d94d-e603-4bbd-b7ad-53a7bb578a8c","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:55 INFO - 1499531815502 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
09:36:55 INFO - 1499531815504 Marionette TRACE 378 <- [1,2,null,{}]
09:36:55 INFO - 1499531815608 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:55 INFO - 1499531815609 Marionette TRACE 378 <- [1,3,null,{}]
09:36:55 INFO - 1499531815638 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:55 INFO - 1499531815639 Marionette TRACE 378 <- [1,4,null,{}]
09:36:55 INFO - 1499531815661 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}]
09:36:55 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499531815673 Marionette TRACE 378 <- [1,5,null,{"value":null}]
09:36:55 INFO - 1499531815675 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815679 Marionette TRACE 378 <- [1,6,null,{}]
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815704 Marionette DEBUG Closed connection 378
09:36:55 INFO - 1499531815706 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49926
09:36:55 INFO - 1499531815711 Marionette DEBUG Closed connection 379
09:36:55 INFO - 1499531815713 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49927
09:36:55 INFO - 1499531815715 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:55 INFO - 1499531815721 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:55 INFO - 1499531815744 Marionette DEBUG Register listener.js for window 12
09:36:55 INFO - 1499531815758 Marionette TRACE 380 <- [1,1,null,{"sessionId":"4679801e-9626-44d3-ba1c-005d6e1bb79f","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:55 INFO - 1499531815768 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815773 Marionette TRACE 380 <- [1,2,null,{}]
09:36:55 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:55 INFO - 1499531815797 Marionette DEBUG Closed connection 380
09:36:55 INFO - 1499531815801 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49928
09:36:55 INFO - 1499531815806 Marionette DEBUG Closed connection 381
09:36:55 INFO - 1499531815808 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49929
09:36:55 INFO - 1499531815810 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:55 INFO - 1499531815813 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:55 INFO - 1499531815836 Marionette DEBUG Register listener.js for window 12
09:36:55 INFO - 1499531815849 Marionette TRACE 382 <- [1,1,null,{"sessionId":"e84fc788-2625-4d2d-893b-335ec9cc0602","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:55 INFO - 1499531815859 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"}]
09:36:55 INFO - 1499531815863 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"
09:36:55 INFO - 1499531815870 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"
09:36:55 INFO - 1499531815871 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"
09:36:55 INFO - ++DOMWINDOW == 28 (00000063875BF800) [pid = 1796] [serial = 49] [outer = 0000006382DB1800]
09:36:55 INFO - 1499531815929 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"
09:36:55 INFO - 1499531815935 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"
09:36:55 INFO - 1499531815953 Marionette TRACE 382 <- [1,2,null,{}]
09:36:55 INFO - 1499531815960 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
09:36:55 INFO - 1499531815968 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"87ac0bdb-93f9-486f-93f9-db4d0c85f620","ELEMENT":"87ac0bdb-93f9-486f-93f9-db4d0c85f620"}}]
09:36:55 INFO - 1499531815970 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"87ac0bdb-93f9-486f-93f9-db4d0c85f620"}]
09:36:56 INFO - 1499531816441 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:36:56 INFO - 1499531816442 Marionette TRACE 382 <- [1,4,null,{}]
09:36:56 INFO - 1499531816445 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}]
09:36:56 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499531816453 Marionette TRACE 382 <- [1,5,null,{"value":null}]
09:36:56 INFO - 1499531816455 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816459 Marionette TRACE 382 <- [1,6,null,{}]
09:36:56 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1136ms
09:36:56 INFO - TEST-START | test_click.py TestClick.test_input_file
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816465 Marionette DEBUG Closed connection 382
09:36:56 INFO - 1499531816467 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49930
09:36:56 INFO - 1499531816468 Marionette DEBUG Closed connection 383
09:36:56 INFO - 1499531816469 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49931
09:36:56 INFO - 1499531816472 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:56 INFO - 1499531816474 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:56 INFO - 1499531816498 Marionette DEBUG Register listener.js for window 12
09:36:56 INFO - 1499531816510 Marionette TRACE 384 <- [1,1,null,{"sessionId":"3234a47f-1a77-4248-a574-4a5d39f6485a","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:56 INFO - 1499531816545 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
09:36:56 INFO - 1499531816547 Marionette TRACE 384 <- [1,2,null,{}]
09:36:56 INFO - 1499531816549 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:56 INFO - 1499531816551 Marionette TRACE 384 <- [1,3,null,{}]
09:36:56 INFO - 1499531816553 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:56 INFO - 1499531816554 Marionette TRACE 384 <- [1,4,null,{}]
09:36:56 INFO - 1499531816557 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}]
09:36:56 INFO - TEST-START: test_click.py TestClick.test_input_file1499531816566 Marionette TRACE 384 <- [1,5,null,{"value":null}]
09:36:56 INFO - 1499531816568 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816573 Marionette TRACE 384 <- [1,6,null,{}]
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816579 Marionette DEBUG Closed connection 384
09:36:56 INFO - 1499531816581 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49932
09:36:56 INFO - 1499531816605 Marionette DEBUG Closed connection 385
09:36:56 INFO - 1499531816608 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49933
09:36:56 INFO - 1499531816611 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:56 INFO - 1499531816614 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:56 INFO - 1499531816638 Marionette DEBUG Register listener.js for window 12
09:36:56 INFO - 1499531816650 Marionette TRACE 386 <- [1,1,null,{"sessionId":"b7f6e159-2ac9-4b45-af35-14b354216795","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:56 INFO - 1499531816661 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816665 Marionette TRACE 386 <- [1,2,null,{}]
09:36:56 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:56 INFO - 1499531816671 Marionette DEBUG Closed connection 386
09:36:56 INFO - 1499531816673 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49934
09:36:56 INFO - 1499531816674 Marionette DEBUG Closed connection 387
09:36:56 INFO - 1499531816676 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49935
09:36:56 INFO - 1499531816678 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:56 INFO - 1499531816681 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:56 INFO - 1499531816705 Marionette DEBUG Register listener.js for window 12
09:36:56 INFO - 1499531816717 Marionette TRACE 388 <- [1,1,null,{"sessionId":"007caa39-377c-4ed3-83d0-05c7b564a1db","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:56 INFO - 1499531816746 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
09:36:56 INFO - 1499531816750 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"
09:36:56 INFO - 1499531816760 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"
09:36:56 INFO - 1499531816762 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"
09:36:56 INFO - ++DOMWINDOW == 29 (0000006389456000) [pid = 1796] [serial = 50] [outer = 0000006382DB1800]
09:36:56 INFO - 1499531816812 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:36:56 INFO - 1499531816822 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:36:56 INFO - 1499531816838 Marionette TRACE 388 <- [1,2,null,{}]
09:36:56 INFO - 1499531816845 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
09:36:56 INFO - 1499531816855 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"12bebf14-008e-41a7-b54c-ff4c3ea51e68","ELEMENT":"12bebf14-008e-41a7-b54c-ff4c3ea51e68"}}]
09:36:56 INFO - 1499531816857 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"12bebf14-008e-41a7-b54c-ff4c3ea51e68"}]
09:36:57 INFO - 1499531817020 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:36:57 INFO - 1499531817040 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}]
09:36:57 INFO - TEST-END: test_click.py TestClick.test_input_file1499531817048 Marionette TRACE 388 <- [1,5,null,{"value":null}]
09:36:57 INFO - 1499531817052 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817056 Marionette TRACE 388 <- [1,6,null,{}]
09:36:57 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 597ms
09:36:57 INFO - TEST-START | test_click.py TestClick.test_obscured_element
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817078 Marionette DEBUG Closed connection 388
09:36:57 INFO - 1499531817080 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49936
09:36:57 INFO - 1499531817084 Marionette DEBUG Closed connection 389
09:36:57 INFO - 1499531817085 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49937
09:36:57 INFO - 1499531817088 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:57 INFO - 1499531817090 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:57 INFO - 1499531817113 Marionette DEBUG Register listener.js for window 12
09:36:57 INFO - 1499531817125 Marionette TRACE 390 <- [1,1,null,{"sessionId":"50081f86-2c8a-476c-9d7b-fdf327635bcb","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:57 INFO - 1499531817135 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
09:36:57 INFO - 1499531817136 Marionette TRACE 390 <- [1,2,null,{}]
09:36:57 INFO - 1499531817138 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:57 INFO - 1499531817140 Marionette TRACE 390 <- [1,3,null,{}]
09:36:57 INFO - 1499531817142 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:57 INFO - 1499531817144 Marionette TRACE 390 <- [1,4,null,{}]
09:36:57 INFO - 1499531817146 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}]
09:36:57 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499531817154 Marionette TRACE 390 <- [1,5,null,{"value":null}]
09:36:57 INFO - 1499531817155 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817159 Marionette TRACE 390 <- [1,6,null,{}]
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817185 Marionette DEBUG Closed connection 390
09:36:57 INFO - 1499531817186 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49938
09:36:57 INFO - 1499531817190 Marionette DEBUG Closed connection 391
09:36:57 INFO - 1499531817191 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49939
09:36:57 INFO - 1499531817193 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:57 INFO - 1499531817197 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:57 INFO - 1499531817224 Marionette DEBUG Register listener.js for window 12
09:36:57 INFO - 1499531817238 Marionette TRACE 392 <- [1,1,null,{"sessionId":"55dfb90c-c8d4-482b-bdb4-1007890f60b8","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:57 INFO - 1499531817249 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817253 Marionette TRACE 392 <- [1,2,null,{}]
09:36:57 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:57 INFO - 1499531817275 Marionette DEBUG Closed connection 392
09:36:57 INFO - 1499531817277 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49940
09:36:57 INFO - 1499531817281 Marionette DEBUG Closed connection 393
09:36:57 INFO - 1499531817282 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49941
09:36:57 INFO - 1499531817285 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:57 INFO - 1499531817287 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:57 INFO - 1499531817311 Marionette DEBUG Register listener.js for window 12
09:36:57 INFO - 1499531817330 Marionette TRACE 394 <- [1,1,null,{"sessionId":"0af627f8-50f3-40ff-80ad-185e5ae3dd95","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:57 INFO - 1499531817343 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"}]
09:36:57 INFO - 1499531817347 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:36:57 INFO - 1499531817361 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:36:57 INFO - 1499531817362 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
09:36:57 INFO - ++DOMWINDOW == 30 (000000638B394000) [pid = 1796] [serial = 51] [outer = 0000006382DB1800]
09:36:57 INFO - 1499531817415 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"
09:36:57 INFO - 1499531817422 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"
09:36:57 INFO - 1499531817435 Marionette TRACE 394 <- [1,2,null,{}]
09:36:57 INFO - 1499531817441 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
09:36:57 INFO - 1499531817448 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a4cc4e86-c3ed-4f3d-8560-f98eb77317a3","ELEMENT":"a4cc4e86-c3ed-4f3d-8560-f98eb77317a3"}}]
09:36:57 INFO - 1499531817451 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
09:36:57 INFO - 1499531817458 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0f4cb955-df3b-489c-9973-8e01504ea4c1","ELEMENT":"0f4cb955-df3b-489c-9973-8e01504ea4c1"}}]
09:36:57 INFO - 1499531817460 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"a4cc4e86-c3ed-4f3d-8560-f98eb77317a3"}]
09:36:58 INFO - 1499531818398 Marionette DEBUG Canceled page load listener because no navigation has been detected
09:36:58 INFO - 1499531818412 Marionette TRACE 394 <- [1,5,null,{}]
09:36:58 INFO - 1499531818416 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"0f4cb955-df3b-489c-9973-8e01504ea4c1"}]
09:36:58 INFO - 1499531818593 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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
09:36:58 INFO - 1499531818597 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
09:36:58 INFO - 1499531818605 Marionette TRACE 394 <- [1,7,null,{"value":false}]
09:36:58 INFO - 1499531818652 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}]
09:36:58 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499531818659 Marionette TRACE 394 <- [1,8,null,{"value":null}]
09:36:58 INFO - 1499531818688 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
09:36:58 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:58 INFO - 1499531818692 Marionette TRACE 394 <- [1,9,null,{}]
09:36:58 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1636ms
09:36:58 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
09:36:58 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:58 INFO - 1499531818698 Marionette DEBUG Closed connection 394
09:36:58 INFO - 1499531818699 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49942
09:36:58 INFO - 1499531818744 Marionette DEBUG Closed connection 395
09:36:58 INFO - 1499531818747 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49943
09:36:58 INFO - 1499531818752 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:58 INFO - 1499531818762 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:58 INFO - 1499531818811 Marionette DEBUG Register listener.js for window 12
09:36:58 INFO - 1499531818833 Marionette TRACE 396 <- [1,1,null,{"sessionId":"eb95cf8e-01cb-48c8-bb16-5a214e1fa3d6","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:58 INFO - 1499531818897 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
09:36:58 INFO - 1499531818900 Marionette TRACE 396 <- [1,2,null,{}]
09:36:58 INFO - 1499531818909 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
09:36:58 INFO - 1499531818912 Marionette TRACE 396 <- [1,3,null,{}]
09:36:58 INFO - 1499531818916 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
09:36:58 INFO - 1499531818921 Marionette TRACE 396 <- [1,4,null,{}]
09:36:58 INFO - 1499531818975 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}]
09:36:58 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499531818989 Marionette TRACE 396 <- [1,5,null,{"value":null}]
09:36:58 INFO - 1499531818995 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
09:36:59 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:59 INFO - 1499531819002 Marionette TRACE 396 <- [1,6,null,{}]
09:36:59 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:59 INFO - 1499531819061 Marionette DEBUG Closed connection 396
09:36:59 INFO - 1499531819064 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49944
09:36:59 INFO - 1499531819086 Marionette DEBUG Closed connection 397
09:36:59 INFO - 1499531819090 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49945
09:36:59 INFO - 1499531819094 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
09:36:59 INFO - 1499531819099 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:59 INFO - 1499531819147 Marionette DEBUG Register listener.js for window 12
09:36:59 INFO - 1499531819170 Marionette TRACE 398 <- [1,1,null,{"sessionId":"9b871134-4fc1-41dc-8d89-0f5e7cb719eb","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:59 INFO - 1499531819194 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
09:36:59 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:59 INFO - 1499531819199 Marionette TRACE 398 <- [1,2,null,{}]
09:36:59 INFO - [1796] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
09:36:59 INFO - 1499531819225 Marionette DEBUG Closed connection 398
09:36:59 INFO - 1499531819227 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49946
09:36:59 INFO - 1499531819256 Marionette DEBUG Closed connection 399
09:36:59 INFO - 1499531819259 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49947
09:36:59 INFO - 1499531819280 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
09:36:59 INFO - 1499531819284 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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}
09:36:59 INFO - 1499531819333 Marionette DEBUG Register listener.js for window 12
09:36:59 INFO - 1499531819349 Marionette TRACE 400 <- [1,1,null,{"sessionId":"53dac685-7508-4c1f-a34e-779a4a2086be","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":1796,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-178.001\\AppData\\Local\\Temp\\tmp2bhpss.mozrunner","moz:accessibilityChecks":false}}]
09:36:59 INFO - 1499531819371 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"}]
09:36:59 INFO - 1499531819377 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"
09:36:59 INFO - 1499531819402 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"
09:36:59 INFO - 1499531819404 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"
09:36:59 INFO - ++DOMWINDOW == 31 (0000006385F1B800) [pid = 1796] [serial = 52] [outer = 0000006382DB1800]
09:36:59 INFO - 1499531819485 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"
09:36:59 INFO - 1499531819493 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"
09:36:59 INFO - 1499531819513 Marionette TRACE 400 <- [1,2,null,{}]
09:36:59 INFO - 1499531819522 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
09:36:59 INFO - 1499531819536 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"88a4e1d3-dde3-4470-92e0-d76cc7492f89","ELEMENT":"88a4e1d3-dde3-4470-92e0-d76cc7492f89"}}]
09:36:59 INFO - 1499531819539 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"88a4e1d3-dde3-4470-92e0-d76cc7492f89"}]
09:36:59 INFO - 1499531819747 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
09:36:59 INFO - 1499531819766 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"88a4e1d3-dde3-4470-92e0-d76cc7492f89"}]
09:37:00 INFO - 1499531820071 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element