could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:36:50 INFO - 1500658610752 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:36:50 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500658610759 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:36:50 INFO - 1500658610761 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610765 Marionette TRACE 352 <- [1,6,null,{}]
10:36:50 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 467ms
10:36:50 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610769 Marionette DEBUG Closed connection 352
10:36:50 INFO - 1500658610770 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49797
10:36:50 INFO - 1500658610772 Marionette DEBUG Closed connection 353
10:36:50 INFO - 1500658610773 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49798
10:36:50 INFO - 1500658610775 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:50 INFO - 1500658610777 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:50 INFO - 1500658610798 Marionette DEBUG Register listener.js for window 6442450945
10:36:50 INFO - 1500658610809 Marionette TRACE 354 <- [1,1,null,{"sessionId":"8caa9be7-fc93-4616-b7f1-010e8e1b540c","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:50 INFO - 1500658610812 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:36:50 INFO - 1500658610813 Marionette TRACE 354 <- [1,2,null,{}]
10:36:50 INFO - 1500658610815 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:50 INFO - 1500658610816 Marionette TRACE 354 <- [1,3,null,{}]
10:36:50 INFO - 1500658610818 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:50 INFO - 1500658610820 Marionette TRACE 354 <- [1,4,null,{}]
10:36:50 INFO - 1500658610823 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:36:50 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500658610830 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:36:50 INFO - 1500658610832 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610836 Marionette TRACE 354 <- [1,6,null,{}]
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610840 Marionette DEBUG Closed connection 354
10:36:50 INFO - 1500658610842 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49799
10:36:50 INFO - 1500658610843 Marionette DEBUG Closed connection 355
10:36:50 INFO - 1500658610845 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49800
10:36:50 INFO - 1500658610847 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:50 INFO - 1500658610850 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:50 INFO - 1500658610879 Marionette DEBUG Register listener.js for window 6442450945
10:36:50 INFO - 1500658610890 Marionette TRACE 356 <- [1,1,null,{"sessionId":"79b0f6c0-036a-4294-ae50-2e700d1e0e2e","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:50 INFO - 1500658610893 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610897 Marionette TRACE 356 <- [1,2,null,{}]
10:36:50 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:50 INFO - 1500658610903 Marionette DEBUG Closed connection 356
10:36:50 INFO - 1500658610905 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49801
10:36:50 INFO - 1500658610906 Marionette DEBUG Closed connection 357
10:36:50 INFO - 1500658610908 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49802
10:36:50 INFO - 1500658610910 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:50 INFO - 1500658610912 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:50 INFO - 1500658610933 Marionette DEBUG Register listener.js for window 6442450945
10:36:50 INFO - 1500658610944 Marionette TRACE 358 <- [1,1,null,{"sessionId":"5c93f5b1-1dae-4324-986b-331569a3ef57","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:50 INFO - 1500658610946 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
10:36:50 INFO - 1500658610951 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
10:36:50 INFO - 1500658610965 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
10:36:50 INFO - 1500658610966 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
10:36:50 INFO - ++DOMWINDOW == 17 (0000003C822F7000) [pid = 3396] [serial = 24] [outer = 0000003CF3E2B000]
10:36:51 INFO - 1500658610996 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
10:36:51 INFO - 1500658611001 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
10:36:51 INFO - 1500658611003 Marionette TRACE 358 <- [1,2,null,{}]
10:36:51 INFO - 1500658611016 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:36:51 INFO - 1500658611028 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"67bc6e67-7d71-40a4-96a5-757444fd1916","ELEMENT":"67bc6e67-7d71-40a4-96a5-757444fd1916"}}]
10:36:51 INFO - 1500658611031 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"67bc6e67-7d71-40a4-96a5-757444fd1916"}]
10:36:51 INFO - 1500658611244 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
10:36:51 INFO - 1500658611472 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
10:36:51 INFO - 1500658611473 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
10:36:51 INFO - ++DOMWINDOW == 18 (0000003C82495800) [pid = 3396] [serial = 25] [outer = 0000003CF3E2B000]
10:36:51 INFO - 1500658611501 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
10:36:51 INFO - 1500658611505 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
10:36:51 INFO - 1500658611513 Marionette TRACE 358 <- [1,4,null,{}]
10:36:51 INFO - 1500658611522 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:36:51 INFO - 1500658611532 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c05fd1cc-236e-4104-a5b2-89bef68800a9","ELEMENT":"c05fd1cc-236e-4104-a5b2-89bef68800a9"}}]
10:36:51 INFO - 1500658611537 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:36:51 INFO - 1500658611539 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:36:51 INFO - 1500658611541 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:36:51 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500658611548 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:36:51 INFO - 1500658611550 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611555 Marionette TRACE 358 <- [1,8,null,{}]
10:36:51 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 789ms
10:36:51 INFO - TEST-START | test_click.py TestClick.test_container_element
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611559 Marionette DEBUG Closed connection 358
10:36:51 INFO - 1500658611561 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49805
10:36:51 INFO - 1500658611567 Marionette DEBUG Closed connection 359
10:36:51 INFO - 1500658611569 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49806
10:36:51 INFO - 1500658611571 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:51 INFO - 1500658611573 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:51 INFO - 1500658611594 Marionette DEBUG Register listener.js for window 6442450945
10:36:51 INFO - 1500658611604 Marionette TRACE 360 <- [1,1,null,{"sessionId":"12072acf-9013-42b1-8357-4a32318430ae","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:51 INFO - 1500658611609 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:36:51 INFO - 1500658611611 Marionette TRACE 360 <- [1,2,null,{}]
10:36:51 INFO - 1500658611614 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:51 INFO - 1500658611615 Marionette TRACE 360 <- [1,3,null,{}]
10:36:51 INFO - 1500658611617 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:51 INFO - 1500658611619 Marionette TRACE 360 <- [1,4,null,{}]
10:36:51 INFO - 1500658611621 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:36:51 INFO - TEST-START: test_click.py TestClick.test_container_element1500658611628 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:36:51 INFO - 1500658611630 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611634 Marionette TRACE 360 <- [1,6,null,{}]
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611638 Marionette DEBUG Closed connection 360
10:36:51 INFO - 1500658611640 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49807
10:36:51 INFO - 1500658611647 Marionette DEBUG Closed connection 361
10:36:51 INFO - 1500658611648 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49808
10:36:51 INFO - 1500658611650 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:51 INFO - 1500658611652 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:51 INFO - 1500658611674 Marionette DEBUG Register listener.js for window 6442450945
10:36:51 INFO - 1500658611685 Marionette TRACE 362 <- [1,1,null,{"sessionId":"e154a0c8-9001-4862-b54d-d519d57aef5b","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:51 INFO - 1500658611688 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611692 Marionette TRACE 362 <- [1,2,null,{}]
10:36:51 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:51 INFO - 1500658611696 Marionette DEBUG Closed connection 362
10:36:51 INFO - 1500658611697 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49809
10:36:51 INFO - 1500658611699 Marionette DEBUG Closed connection 363
10:36:51 INFO - 1500658611700 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49810
10:36:51 INFO - 1500658611702 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:51 INFO - 1500658611705 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:51 INFO - 1500658611726 Marionette DEBUG Register listener.js for window 6442450945
10:36:51 INFO - 1500658611738 Marionette TRACE 364 <- [1,1,null,{"sessionId":"877c718d-ac9b-4e83-a6a7-f1037adbc5a3","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:51 INFO - 1500658611741 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:36:51 INFO - 1500658611745 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
10:36:51 INFO - 1500658611749 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
10:36:51 INFO - 1500658611750 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
10:36:51 INFO - ++DOMWINDOW == 19 (0000003C823A5000) [pid = 3396] [serial = 26] [outer = 0000003CF3E2B000]
10:36:51 INFO - 1500658611771 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:51 INFO - 1500658611779 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:51 INFO - 1500658611790 Marionette TRACE 364 <- [1,2,null,{}]
10:36:51 INFO - 1500658611797 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:36:51 INFO - 1500658611805 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9b2de7ec-658a-49a9-8b25-68ecd9fef1f1","ELEMENT":"9b2de7ec-658a-49a9-8b25-68ecd9fef1f1"}}]
10:36:51 INFO - 1500658611814 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"9b2de7ec-658a-49a9-8b25-68ecd9fef1f1"}]
10:36:52 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:36:52 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:36:52 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:36:52 INFO - 1500658612244 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:36:52 INFO - 1500658612246 Marionette TRACE 364 <- [1,4,null,{}]
10:36:52 INFO - 1500658612249 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"9b2de7ec-658a-49a9-8b25-68ecd9fef1f1","name":"selected"}]
10:36:52 INFO - 1500658612276 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:36:52 INFO - 1500658612278 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:36:52 INFO - TEST-END: test_click.py TestClick.test_container_element1500658612285 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:36:52 INFO - 1500658612287 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612291 Marionette TRACE 364 <- [1,7,null,{}]
10:36:52 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 737ms
10:36:52 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612300 Marionette DEBUG Closed connection 364
10:36:52 INFO - 1500658612302 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49811
10:36:52 INFO - 1500658612305 Marionette DEBUG Closed connection 365
10:36:52 INFO - 1500658612306 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49812
10:36:52 INFO - 1500658612308 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:52 INFO - 1500658612310 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:52 INFO - 1500658612331 Marionette DEBUG Register listener.js for window 6442450945
10:36:52 INFO - 1500658612691 Marionette TRACE 366 <- [1,1,null,{"sessionId":"7f16e950-0626-4316-80ee-390e12873266","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:52 INFO - 1500658612694 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:36:52 INFO - 1500658612696 Marionette TRACE 366 <- [1,2,null,{}]
10:36:52 INFO - 1500658612698 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:52 INFO - 1500658612700 Marionette TRACE 366 <- [1,3,null,{}]
10:36:52 INFO - 1500658612702 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:52 INFO - 1500658612703 Marionette TRACE 366 <- [1,4,null,{}]
10:36:52 INFO - 1500658612706 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:36:52 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500658612713 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:36:52 INFO - 1500658612715 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612719 Marionette TRACE 366 <- [1,6,null,{}]
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612723 Marionette DEBUG Closed connection 366
10:36:52 INFO - 1500658612725 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49813
10:36:52 INFO - 1500658612726 Marionette DEBUG Closed connection 367
10:36:52 INFO - 1500658612727 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49814
10:36:52 INFO - 1500658612730 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:52 INFO - 1500658612732 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:52 INFO - 1500658612752 Marionette DEBUG Register listener.js for window 6442450945
10:36:52 INFO - 1500658612775 Marionette TRACE 368 <- [1,1,null,{"sessionId":"27f5c0cf-ca3f-4a62-bbae-a5f2de7dec9a","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:52 INFO - 1500658612778 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612782 Marionette TRACE 368 <- [1,2,null,{}]
10:36:52 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:52 INFO - 1500658612786 Marionette DEBUG Closed connection 368
10:36:52 INFO - 1500658612787 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49815
10:36:52 INFO - 1500658612789 Marionette DEBUG Closed connection 369
10:36:52 INFO - 1500658612791 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49816
10:36:52 INFO - 1500658612793 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:52 INFO - 1500658612795 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:52 INFO - 1500658612817 Marionette DEBUG Register listener.js for window 6442450945
10:36:52 INFO - 1500658612827 Marionette TRACE 370 <- [1,1,null,{"sessionId":"b0a4bf6a-1cfd-45e4-a95b-5333ca89bc52","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:52 INFO - 1500658612830 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:36:52 INFO - 1500658612834 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:52 INFO - 1500658612839 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:52 INFO - 1500658612839 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:52 INFO - ++DOMWINDOW == 20 (0000003C82398800) [pid = 3396] [serial = 27] [outer = 0000003CF3E2B000]
10:36:52 INFO - 1500658612861 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:52 INFO - 1500658612868 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:52 INFO - 1500658612886 Marionette TRACE 370 <- [1,2,null,{}]
10:36:52 INFO - 1500658612897 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:36:52 INFO - 1500658612903 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"64f094a8-2941-474a-9f92-ea8bfacb9976","ELEMENT":"64f094a8-2941-474a-9f92-ea8bfacb9976"}}]
10:36:52 INFO - 1500658612905 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"64f094a8-2941-474a-9f92-ea8bfacb9976"}]
10:36:53 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:36:53 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:36:53 INFO - [Child 3396] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:36:53 INFO - 1500658613557 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:36:53 INFO - 1500658613559 Marionette TRACE 370 <- [1,4,null,{}]
10:36:53 INFO - 1500658613561 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"64f094a8-2941-474a-9f92-ea8bfacb9976","name":"selected"}]
10:36:53 INFO - 1500658613588 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:36:53 INFO - 1500658613591 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:36:53 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500658613598 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:36:53 INFO - 1500658613600 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1311ms
10:36:53 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:36:53 INFO - 1500658613604 Marionette TRACE 370 <- [1,7,null,{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - 1500658613608 Marionette DEBUG Closed connection 370
10:36:53 INFO - 1500658613610 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49817
10:36:53 INFO - 1500658613611 Marionette DEBUG Closed connection 371
10:36:53 INFO - 1500658613612 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49818
10:36:53 INFO - 1500658613615 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:53 INFO - 1500658613616 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:53 INFO - 1500658613637 Marionette DEBUG Register listener.js for window 6442450945
10:36:53 INFO - 1500658613648 Marionette TRACE 372 <- [1,1,null,{"sessionId":"2f8545ac-be0e-4ac6-9748-3b42cd0f7fdf","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:53 INFO - 1500658613651 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:36:53 INFO - 1500658613652 Marionette TRACE 372 <- [1,2,null,{}]
10:36:53 INFO - 1500658613654 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:53 INFO - 1500658613656 Marionette TRACE 372 <- [1,3,null,{}]
10:36:53 INFO - 1500658613658 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:53 INFO - 1500658613659 Marionette TRACE 372 <- [1,4,null,{}]
10:36:53 INFO - 1500658613663 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:36:53 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500658613675 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:36:53 INFO - 1500658613677 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - 1500658613681 Marionette TRACE 372 <- [1,6,null,{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - 1500658613685 Marionette DEBUG Closed connection 372
10:36:53 INFO - 1500658613687 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49819
10:36:53 INFO - 1500658613688 Marionette DEBUG Closed connection 373
10:36:53 INFO - 1500658613690 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49820
10:36:53 INFO - 1500658613692 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:53 INFO - 1500658613694 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:53 INFO - 1500658613715 Marionette DEBUG Register listener.js for window 6442450945
10:36:53 INFO - 1500658613726 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c95eb5a5-7fde-4663-9733-7636cf5fbbc6","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:53 INFO - 1500658613728 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - 1500658613732 Marionette TRACE 374 <- [1,2,null,{}]
10:36:53 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:53 INFO - 1500658613736 Marionette DEBUG Closed connection 374
10:36:53 INFO - 1500658613738 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49821
10:36:53 INFO - 1500658613739 Marionette DEBUG Closed connection 375
10:36:53 INFO - 1500658613741 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49822
10:36:53 INFO - 1500658613743 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:53 INFO - 1500658613745 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:53 INFO - 1500658613766 Marionette DEBUG Register listener.js for window 6442450945
10:36:53 INFO - 1500658613777 Marionette TRACE 376 <- [1,1,null,{"sessionId":"6e927dc3-375c-45c3-9567-44ddf79c819b","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:53 INFO - 1500658613780 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:36:53 INFO - 1500658613794 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:53 INFO - 1500658613798 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:53 INFO - 1500658613799 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:53 INFO - ++DOMWINDOW == 21 (0000003C823AD800) [pid = 3396] [serial = 28] [outer = 0000003CF3E2B000]
10:36:53 INFO - 1500658613820 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:36:53 INFO - 1500658613826 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:36:53 INFO - 1500658613836 Marionette TRACE 376 <- [1,2,null,{}]
10:36:53 INFO - 1500658613857 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:36:53 INFO - 1500658613863 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3e5c547d-ab02-47c7-b054-80c481d42d06","ELEMENT":"3e5c547d-ab02-47c7-b054-80c481d42d06"}}]
10:36:53 INFO - 1500658613865 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"3e5c547d-ab02-47c7-b054-80c481d42d06"}]
10:36:54 INFO - 1500658614282 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:36:54 INFO - 1500658614284 Marionette TRACE 376 <- [1,4,null,{}]
10:36:54 INFO - 1500658614287 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:36:54 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500658614294 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:36:54 INFO - 1500658614296 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614300 Marionette TRACE 376 <- [1,6,null,{}]
10:36:54 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 696ms
10:36:54 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614304 Marionette DEBUG Closed connection 376
10:36:54 INFO - 1500658614305 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49823
10:36:54 INFO - 1500658614307 Marionette DEBUG Closed connection 377
10:36:54 INFO - 1500658614308 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49824
10:36:54 INFO - 1500658614311 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:54 INFO - 1500658614313 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:54 INFO - 1500658614335 Marionette DEBUG Register listener.js for window 6442450945
10:36:54 INFO - 1500658614346 Marionette TRACE 378 <- [1,1,null,{"sessionId":"efe6e83c-2766-46c1-b057-8867e6e4b44c","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:54 INFO - 1500658614349 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:36:54 INFO - 1500658614350 Marionette TRACE 378 <- [1,2,null,{}]
10:36:54 INFO - 1500658614352 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:54 INFO - 1500658614353 Marionette TRACE 378 <- [1,3,null,{}]
10:36:54 INFO - 1500658614355 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:54 INFO - 1500658614357 Marionette TRACE 378 <- [1,4,null,{}]
10:36:54 INFO - 1500658614359 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:36:54 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500658614366 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:36:54 INFO - 1500658614368 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614373 Marionette TRACE 378 <- [1,6,null,{}]
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614377 Marionette DEBUG Closed connection 378
10:36:54 INFO - 1500658614378 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49825
10:36:54 INFO - 1500658614380 Marionette DEBUG Closed connection 379
10:36:54 INFO - 1500658614381 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49826
10:36:54 INFO - 1500658614383 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:54 INFO - 1500658614385 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:54 INFO - 1500658614407 Marionette DEBUG Register listener.js for window 6442450945
10:36:54 INFO - 1500658614418 Marionette TRACE 380 <- [1,1,null,{"sessionId":"d576478e-0d30-4a1f-aacc-29c90245dc1d","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:54 INFO - 1500658614421 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614425 Marionette TRACE 380 <- [1,2,null,{}]
10:36:54 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:54 INFO - 1500658614429 Marionette DEBUG Closed connection 380
10:36:54 INFO - 1500658614431 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49827
10:36:54 INFO - 1500658614432 Marionette DEBUG Closed connection 381
10:36:54 INFO - 1500658614434 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49828
10:36:54 INFO - 1500658614437 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:54 INFO - 1500658614439 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:54 INFO - 1500658614913 Marionette DEBUG Register listener.js for window 6442450945
10:36:54 INFO - 1500658614924 Marionette TRACE 382 <- [1,1,null,{"sessionId":"8ef856a0-3c25-484f-9b97-41a4ca97bae2","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:54 INFO - 1500658614928 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:36:55 INFO - 1500658614983 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:36:55 INFO - 1500658614987 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:36:55 INFO - 1500658614988 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:36:55 INFO - ++DOMWINDOW == 22 (0000003C84E67000) [pid = 3396] [serial = 29] [outer = 0000003CF3E2B000]
10:36:55 INFO - 1500658615013 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:55 INFO - 1500658615017 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:55 INFO - 1500658615026 Marionette TRACE 382 <- [1,2,null,{}]
10:36:55 INFO - 1500658615034 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:36:55 INFO - 1500658615073 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d273218a-b177-4ea6-ac0f-3bfcc4c80678","ELEMENT":"d273218a-b177-4ea6-ac0f-3bfcc4c80678"}}]
10:36:55 INFO - 1500658615076 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"d273218a-b177-4ea6-ac0f-3bfcc4c80678"}]
10:36:55 INFO - 1500658615554 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:36:55 INFO - 1500658615556 Marionette TRACE 382 <- [1,4,null,{}]
10:36:55 INFO - 1500658615559 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:36:55 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500658615677 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:36:55 INFO - 1500658615679 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:36:55 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1383ms
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615684 Marionette TRACE 382 <- [1,6,null,{}]
10:36:55 INFO - TEST-START | test_click.py TestClick.test_input_file
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615688 Marionette DEBUG Closed connection 382
10:36:55 INFO - 1500658615689 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49829
10:36:55 INFO - 1500658615691 Marionette DEBUG Closed connection 383
10:36:55 INFO - 1500658615694 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49830
10:36:55 INFO - 1500658615696 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:55 INFO - 1500658615698 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:55 INFO - 1500658615732 Marionette DEBUG Register listener.js for window 6442450945
10:36:55 INFO - 1500658615746 Marionette TRACE 384 <- [1,1,null,{"sessionId":"6b2ff220-513c-4903-be79-000c28d10a7a","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:55 INFO - 1500658615749 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:36:55 INFO - 1500658615751 Marionette TRACE 384 <- [1,2,null,{}]
10:36:55 INFO - 1500658615753 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:55 INFO - 1500658615754 Marionette TRACE 384 <- [1,3,null,{}]
10:36:55 INFO - 1500658615756 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:55 INFO - 1500658615758 Marionette TRACE 384 <- [1,4,null,{}]
10:36:55 INFO - 1500658615764 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:36:55 INFO - TEST-START: test_click.py TestClick.test_input_file1500658615772 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:36:55 INFO - 1500658615774 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615779 Marionette TRACE 384 <- [1,6,null,{}]
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615783 Marionette DEBUG Closed connection 384
10:36:55 INFO - 1500658615785 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49831
10:36:55 INFO - 1500658615787 Marionette DEBUG Closed connection 385
10:36:55 INFO - --DOMWINDOW == 21 (0000003CFCED4800) [pid = 3396] [serial = 14] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - 1500658615788 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49832
10:36:55 INFO - 1500658615790 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:55 INFO - --DOMWINDOW == 20 (0000003C81F24800) [pid = 3396] [serial = 16] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 19 (0000003C81F0E000) [pid = 3396] [serial = 15] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 18 (0000003C81680000) [pid = 3396] [serial = 9] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 17 (0000003CF6BC3000) [pid = 3396] [serial = 13] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 16 (0000003C80693000) [pid = 3396] [serial = 12] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 15 (0000003C8172E800) [pid = 3396] [serial = 11] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - --DOMWINDOW == 14 (0000003C80222000) [pid = 3396] [serial = 10] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
10:36:55 INFO - 1500658615793 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:55 INFO - 1500658615815 Marionette DEBUG Register listener.js for window 6442450945
10:36:55 INFO - 1500658615825 Marionette TRACE 386 <- [1,1,null,{"sessionId":"a7148098-84bd-4b63-b1dc-9f140302d240","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:55 INFO - 1500658615828 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615833 Marionette TRACE 386 <- [1,2,null,{}]
10:36:55 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:55 INFO - 1500658615838 Marionette DEBUG Closed connection 386
10:36:55 INFO - 1500658615840 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49833
10:36:55 INFO - 1500658615842 Marionette DEBUG Closed connection 387
10:36:55 INFO - 1500658615843 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49834
10:36:55 INFO - 1500658615846 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:55 INFO - 1500658615848 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:56 INFO - 1500658616207 Marionette DEBUG Register listener.js for window 6442450945
10:36:56 INFO - 1500658616218 Marionette TRACE 388 <- [1,1,null,{"sessionId":"5a939922-940a-498b-b09b-e3a173636c18","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:56 INFO - 1500658616221 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:36:56 INFO - 1500658616234 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:56 INFO - 1500658616238 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:56 INFO - 1500658616239 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:36:56 INFO - ++DOMWINDOW == 15 (0000003C80695000) [pid = 3396] [serial = 30] [outer = 0000003CF3E2B000]
10:36:56 INFO - 1500658616267 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:36:56 INFO - 1500658616271 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:36:56 INFO - 1500658616276 Marionette TRACE 388 <- [1,2,null,{}]
10:36:56 INFO - 1500658616284 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:36:56 INFO - 1500658616305 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a02c88cf-0c12-4513-afe9-1bb30f7a3a7b","ELEMENT":"a02c88cf-0c12-4513-afe9-1bb30f7a3a7b"}}]
10:36:56 INFO - 1500658616308 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"a02c88cf-0c12-4513-afe9-1bb30f7a3a7b"}]
10:36:56 INFO - 1500658616487 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:36:56 INFO - 1500658616489 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:36:56 INFO - TEST-END: test_click.py TestClick.test_input_file1500658616525 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:36:56 INFO - 1500658616527 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 847ms
10:36:56 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:36:56 INFO - 1500658616532 Marionette TRACE 388 <- [1,6,null,{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - 1500658616536 Marionette DEBUG Closed connection 388
10:36:56 INFO - 1500658616538 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49835
10:36:56 INFO - 1500658616539 Marionette DEBUG Closed connection 389
10:36:56 INFO - 1500658616541 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49836
10:36:56 INFO - 1500658616544 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:56 INFO - 1500658616546 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:56 INFO - 1500658616580 Marionette DEBUG Register listener.js for window 6442450945
10:36:56 INFO - 1500658616591 Marionette TRACE 390 <- [1,1,null,{"sessionId":"4b2c91f1-651f-4a78-96e7-658f08dc219c","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:56 INFO - 1500658616594 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:36:56 INFO - 1500658616595 Marionette TRACE 390 <- [1,2,null,{}]
10:36:56 INFO - 1500658616597 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:56 INFO - 1500658616599 Marionette TRACE 390 <- [1,3,null,{}]
10:36:56 INFO - 1500658616601 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:56 INFO - 1500658616602 Marionette TRACE 390 <- [1,4,null,{}]
10:36:56 INFO - 1500658616605 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:36:56 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500658616647 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:36:56 INFO - 1500658616649 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - 1500658616654 Marionette TRACE 390 <- [1,6,null,{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - 1500658616658 Marionette DEBUG Closed connection 390
10:36:56 INFO - 1500658616659 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49837
10:36:56 INFO - 1500658616661 Marionette DEBUG Closed connection 391
10:36:56 INFO - 1500658616662 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49838
10:36:56 INFO - 1500658616665 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:56 INFO - 1500658616667 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:56 INFO - 1500658616701 Marionette DEBUG Register listener.js for window 6442450945
10:36:56 INFO - 1500658616712 Marionette TRACE 392 <- [1,1,null,{"sessionId":"1f15925b-ebe7-4b1d-bee7-2e99e943b76b","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:56 INFO - 1500658616714 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - 1500658616719 Marionette TRACE 392 <- [1,2,null,{}]
10:36:56 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:56 INFO - 1500658616723 Marionette DEBUG Closed connection 392
10:36:56 INFO - 1500658616724 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49839
10:36:56 INFO - 1500658616726 Marionette DEBUG Closed connection 393
10:36:56 INFO - 1500658616727 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49840
10:36:56 INFO - 1500658616730 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:56 INFO - 1500658616732 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:56 INFO - 1500658616772 Marionette DEBUG Register listener.js for window 6442450945
10:36:56 INFO - 1500658616783 Marionette TRACE 394 <- [1,1,null,{"sessionId":"3954d0d7-d105-4640-a982-c0726ccbb383","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:56 INFO - 1500658616786 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:36:56 INFO - 1500658616790 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:36:56 INFO - 1500658616794 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:36:56 INFO - 1500658616795 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:36:56 INFO - ++DOMWINDOW == 16 (0000003C80222000) [pid = 3396] [serial = 31] [outer = 0000003CF3E2B000]
10:36:56 INFO - 1500658616820 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:36:56 INFO - 1500658616824 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:36:56 INFO - 1500658616834 Marionette TRACE 394 <- [1,2,null,{}]
10:36:56 INFO - 1500658616850 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:36:56 INFO - 1500658616856 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d1f8dc65-0c3f-4d2c-ac33-a2e0e550a3a5","ELEMENT":"d1f8dc65-0c3f-4d2c-ac33-a2e0e550a3a5"}}]
10:36:56 INFO - 1500658616858 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:36:56 INFO - 1500658616863 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f40400f6-42c8-4f9c-a3f3-4dd64909fd19","ELEMENT":"f40400f6-42c8-4f9c-a3f3-4dd64909fd19"}}]
10:36:56 INFO - 1500658616865 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"d1f8dc65-0c3f-4d2c-ac33-a2e0e550a3a5"}]
10:36:57 INFO - 1500658617287 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:36:57 INFO - 1500658617289 Marionette TRACE 394 <- [1,5,null,{}]
10:36:57 INFO - 1500658617291 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"f40400f6-42c8-4f9c-a3f3-4dd64909fd19"}]
10:36:57 INFO - 1500658617417 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:36:57 INFO - 1500658617420 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
10:36:57 INFO - 1500658617435 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:36:57 INFO - 1500658617437 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:36:57 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500658617444 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:36:57 INFO - 1500658617446 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617450 Marionette TRACE 394 <- [1,9,null,{}]
10:36:57 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 919ms
10:36:57 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617454 Marionette DEBUG Closed connection 394
10:36:57 INFO - 1500658617456 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49841
10:36:57 INFO - 1500658617457 Marionette DEBUG Closed connection 395
10:36:57 INFO - 1500658617459 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49842
10:36:57 INFO - 1500658617461 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:57 INFO - 1500658617463 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:57 INFO - 1500658617485 Marionette DEBUG Register listener.js for window 6442450945
10:36:57 INFO - 1500658617508 Marionette TRACE 396 <- [1,1,null,{"sessionId":"9bd11e9d-c9f3-4ff7-a255-d87610dc74c0","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:57 INFO - 1500658617511 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:36:57 INFO - 1500658617513 Marionette TRACE 396 <- [1,2,null,{}]
10:36:57 INFO - 1500658617515 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:36:57 INFO - 1500658617516 Marionette TRACE 396 <- [1,3,null,{}]
10:36:57 INFO - 1500658617518 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:36:57 INFO - 1500658617520 Marionette TRACE 396 <- [1,4,null,{}]
10:36:57 INFO - 1500658617523 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:36:57 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500658617530 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:36:57 INFO - 1500658617532 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617537 Marionette TRACE 396 <- [1,6,null,{}]
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617541 Marionette DEBUG Closed connection 396
10:36:57 INFO - 1500658617542 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49843
10:36:57 INFO - 1500658617544 Marionette DEBUG Closed connection 397
10:36:57 INFO - 1500658617545 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49844
10:36:57 INFO - 1500658617547 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:36:57 INFO - 1500658617549 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:57 INFO - 1500658617571 Marionette DEBUG Register listener.js for window 6442450945
10:36:57 INFO - 1500658617582 Marionette TRACE 398 <- [1,1,null,{"sessionId":"04cb3523-5a8d-477b-ad2c-3fb235b2f785","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:57 INFO - 1500658617585 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617589 Marionette TRACE 398 <- [1,2,null,{}]
10:36:57 INFO - [Parent 3744] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:36:57 INFO - 1500658617593 Marionette DEBUG Closed connection 398
10:36:57 INFO - 1500658617594 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49845
10:36:57 INFO - 1500658617596 Marionette DEBUG Closed connection 399
10:36:57 INFO - 1500658617597 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49846
10:36:57 INFO - 1500658617599 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:36:57 INFO - 1500658617602 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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}
10:36:57 INFO - 1500658617624 Marionette DEBUG Register listener.js for window 6442450945
10:36:57 INFO - 1500658617635 Marionette TRACE 400 <- [1,1,null,{"sessionId":"ac4100d9-8c0f-48ed-b796-ab48e30140bf","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":3744,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-060.000\\AppData\\Local\\Temp\\tmp6thcuz.mozrunner","moz:accessibilityChecks":false}}]
10:36:57 INFO - 1500658617637 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:36:57 INFO - 1500658617641 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:36:57 INFO - 1500658617646 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:36:57 INFO - 1500658617647 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:36:57 INFO - ++DOMWINDOW == 17 (0000003C83817800) [pid = 3396] [serial = 32] [outer = 0000003CF3E2B000]
10:36:57 INFO - 1500658617669 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:36:57 INFO - 1500658617675 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:36:57 INFO - 1500658617682 Marionette TRACE 400 <- [1,2,null,{}]
10:36:57 INFO - 1500658617690 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:36:57 INFO - 1500658617710 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ed0af8b9-a10f-4d42-a10f-d792907fcbd7","ELEMENT":"ed0af8b9-a10f-4d42-a10f-d792907fcbd7"}}]
10:36:57 INFO - 1500658617712 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"ed0af8b9-a10f-4d42-a10f-d792907fcbd7"}]
10:36:57 INFO - 1500658617843 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:36:57 INFO - 1500658617845 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"ed0af8b9-a10f-4d42-a10f-d792907fcbd7"}]
10:36:57 INFO - 1500658617974 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element