could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
19:37:56 INFO - 1501036676600 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}]
19:37:56 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1501036676608 Marionette TRACE 352 <- [1,5,null,{"value":null}]
19:37:56 INFO - 1501036676610 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676614 Marionette TRACE 352 <- [1,6,null,{}]
19:37:56 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 648ms
19:37:56 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676620 Marionette DEBUG Closed connection 352
19:37:56 INFO - 1501036676622 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49794
19:37:56 INFO - 1501036676643 Marionette DEBUG Closed connection 353
19:37:56 INFO - 1501036676644 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49795
19:37:56 INFO - 1501036676647 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:56 INFO - 1501036676649 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:56 INFO - 1501036676671 Marionette DEBUG Register listener.js for window 12
19:37:56 INFO - 1501036676682 Marionette TRACE 354 <- [1,1,null,{"sessionId":"d0ff9134-6408-4ad5-9f88-f5890877698f","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:56 INFO - 1501036676692 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
19:37:56 INFO - 1501036676694 Marionette TRACE 354 <- [1,2,null,{}]
19:37:56 INFO - 1501036676696 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:37:56 INFO - 1501036676698 Marionette TRACE 354 <- [1,3,null,{}]
19:37:56 INFO - 1501036676700 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
19:37:56 INFO - 1501036676701 Marionette TRACE 354 <- [1,4,null,{}]
19:37:56 INFO - 1501036676703 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}]
19:37:56 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1501036676711 Marionette TRACE 354 <- [1,5,null,{"value":null}]
19:37:56 INFO - 1501036676713 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676718 Marionette TRACE 354 <- [1,6,null,{}]
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676743 Marionette DEBUG Closed connection 354
19:37:56 INFO - 1501036676744 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49796
19:37:56 INFO - 1501036676748 Marionette DEBUG Closed connection 355
19:37:56 INFO - 1501036676749 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49797
19:37:56 INFO - 1501036676752 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:56 INFO - 1501036676754 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:56 INFO - 1501036676775 Marionette DEBUG Register listener.js for window 12
19:37:56 INFO - 1501036676786 Marionette TRACE 356 <- [1,1,null,{"sessionId":"6347e2c8-3494-4569-8829-60e608c6e71c","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:56 INFO - 1501036676793 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676797 Marionette TRACE 356 <- [1,2,null,{}]
19:37:56 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:56 INFO - 1501036676822 Marionette DEBUG Closed connection 356
19:37:56 INFO - 1501036676824 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49798
19:37:56 INFO - 1501036676828 Marionette DEBUG Closed connection 357
19:37:56 INFO - 1501036676829 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49799
19:37:56 INFO - 1501036676850 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:37:56 INFO - 1501036676863 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:56 INFO - 1501036676903 Marionette DEBUG Register listener.js for window 12
19:37:56 INFO - 1501036676926 Marionette TRACE 358 <- [1,1,null,{"sessionId":"f10a9167-208f-470c-a54b-d97fabe7ae42","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:56 INFO - 1501036676943 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49346/clicks.html"}]
19:37:56 INFO - 1501036676950 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49346/hidden.html"
19:37:56 INFO - 1501036676978 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49346/hidden.html"
19:37:56 INFO - 1501036676979 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49346/hidden.html"
19:37:56 INFO - ++DOMWINDOW == 28 (000000C8A6F49800) [pid = 340] [serial = 41] [outer = 000000C8B2161000]
19:37:57 INFO - 1501036677060 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49346/clicks.html"
19:37:57 INFO - 1501036677067 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49346/clicks.html"
19:37:57 INFO - 1501036677092 Marionette TRACE 358 <- [1,2,null,{}]
19:37:57 INFO - 1501036677107 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
19:37:57 INFO - 1501036677121 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4c857b92-9ea7-4713-a46c-60296413b5eb","ELEMENT":"4c857b92-9ea7-4713-a46c-60296413b5eb"}}]
19:37:57 INFO - 1501036677125 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"4c857b92-9ea7-4713-a46c-60296413b5eb"}]
19:37:57 INFO - 1501036677523 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49346/clicks.html"
19:37:57 INFO - [Parent 340] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
19:37:57 INFO - 1501036677543 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49346/clicks.html"
19:37:57 INFO - 1501036677545 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49346/clicks.html"
19:37:57 INFO - ++DOMWINDOW == 29 (000000C8B1444800) [pid = 340] [serial = 42] [outer = 000000C8B2161000]
19:37:57 INFO - 1501036677631 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49346/test.html"
19:37:57 INFO - 1501036677638 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49346/test.html"
19:37:57 INFO - 1501036677660 Marionette TRACE 358 <- [1,4,null,{}]
19:37:57 INFO - 1501036677668 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
19:37:57 INFO - 1501036677679 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"894d8b60-4fdd-499d-bf9a-a22928878cab","ELEMENT":"894d8b60-4fdd-499d-bf9a-a22928878cab"}}]
19:37:57 INFO - 1501036677714 Marionette TRACE 358 -> [0,6,"getTitle",{}]
19:37:57 INFO - 1501036677718 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
19:37:57 INFO - 1501036677722 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}]
19:37:57 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1501036677745 Marionette TRACE 358 <- [1,7,null,{"value":null}]
19:37:57 INFO - 1501036677749 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
19:37:57 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:57 INFO - 1501036677755 Marionette TRACE 358 <- [1,8,null,{}]
19:37:57 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1141ms
19:37:57 INFO - TEST-START | test_click.py TestClick.test_container_element
19:37:57 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:57 INFO - 1501036677781 Marionette DEBUG Closed connection 358
19:37:57 INFO - 1501036677784 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49802
19:37:57 INFO - 1501036677790 Marionette DEBUG Closed connection 359
19:37:57 INFO - 1501036677792 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49803
19:37:57 INFO - 1501036677845 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:57 INFO - 1501036677849 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:57 INFO - 1501036677889 Marionette DEBUG Register listener.js for window 12
19:37:57 INFO - 1501036677908 Marionette TRACE 360 <- [1,1,null,{"sessionId":"af6b5897-9d2b-4cd5-a829-9f94d87e2cf4","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:57 INFO - 1501036677919 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
19:37:57 INFO - 1501036677921 Marionette TRACE 360 <- [1,2,null,{}]
19:37:57 INFO - 1501036677933 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:37:57 INFO - 1501036677939 Marionette TRACE 360 <- [1,3,null,{}]
19:37:57 INFO - 1501036677972 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
19:37:57 INFO - 1501036677974 Marionette TRACE 360 <- [1,4,null,{}]
19:37:57 INFO - 1501036677981 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}]
19:37:57 INFO - TEST-START: test_click.py TestClick.test_container_element1501036677991 Marionette TRACE 360 <- [1,5,null,{"value":null}]
19:37:58 INFO - 1501036678043 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:58 INFO - 1501036678048 Marionette TRACE 360 <- [1,6,null,{}]
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:58 INFO - 1501036678073 Marionette DEBUG Closed connection 360
19:37:58 INFO - 1501036678076 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49804
19:37:58 INFO - 1501036678078 Marionette DEBUG Closed connection 361
19:37:58 INFO - 1501036678080 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49805
19:37:58 INFO - 1501036678083 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:58 INFO - 1501036678087 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:58 INFO - 1501036678126 Marionette DEBUG Register listener.js for window 12
19:37:58 INFO - 1501036678146 Marionette TRACE 362 <- [1,1,null,{"sessionId":"3f3d28df-3efa-4de7-a430-f78f0ceb62e8","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:58 INFO - 1501036678155 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:58 INFO - 1501036678160 Marionette TRACE 362 <- [1,2,null,{}]
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:58 INFO - 1501036678168 Marionette DEBUG Closed connection 362
19:37:58 INFO - 1501036678170 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49806
19:37:58 INFO - 1501036678173 Marionette DEBUG Closed connection 363
19:37:58 INFO - 1501036678175 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49807
19:37:58 INFO - 1501036678189 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:37:58 INFO - 1501036678193 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:58 INFO - 1501036678233 Marionette DEBUG Register listener.js for window 12
19:37:58 INFO - 1501036678248 Marionette TRACE 364 <- [1,1,null,{"sessionId":"31436f67-122b-4a74-914e-4d8b600df328","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:58 INFO - 1501036678257 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"}]
19:37:58 INFO - 1501036678263 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49346/test.html"
19:37:58 INFO - 1501036678270 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49346/test.html"
19:37:58 INFO - 1501036678271 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49346/test.html"
19:37:58 INFO - ++DOMWINDOW == 30 (000000C8BA8E8000) [pid = 340] [serial = 43] [outer = 000000C8B2161000]
19:37:58 INFO - 1501036678351 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"
19:37:58 INFO - 1501036678358 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"
19:37:58 INFO - 1501036678377 Marionette TRACE 364 <- [1,2,null,{}]
19:37:58 INFO - 1501036678413 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
19:37:58 INFO - 1501036678424 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"74a87a24-3756-4470-b9ee-62538057af55","ELEMENT":"74a87a24-3756-4470-b9ee-62538057af55"}}]
19:37:58 INFO - 1501036678426 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"74a87a24-3756-4470-b9ee-62538057af55"}]
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
19:37:58 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
19:37:59 INFO - 1501036679183 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:37:59 INFO - 1501036679189 Marionette TRACE 364 <- [1,4,null,{}]
19:37:59 INFO - 1501036679195 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"74a87a24-3756-4470-b9ee-62538057af55","name":"selected"}]
19:37:59 INFO - 1501036679236 Marionette TRACE 364 <- [1,5,null,{"value":true}]
19:37:59 INFO - 1501036679241 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}]
19:37:59 INFO - TEST-END: test_click.py TestClick.test_container_element1501036679254 Marionette TRACE 364 <- [1,6,null,{"value":null}]
19:37:59 INFO - 1501036679265 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679275 Marionette TRACE 364 <- [1,7,null,{}]
19:37:59 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1535ms
19:37:59 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679302 Marionette DEBUG Closed connection 364
19:37:59 INFO - 1501036679305 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49808
19:37:59 INFO - 1501036679319 Marionette DEBUG Closed connection 365
19:37:59 INFO - 1501036679323 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49809
19:37:59 INFO - 1501036679372 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:59 INFO - 1501036679383 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:59 INFO - 1501036679408 Marionette DEBUG Register listener.js for window 12
19:37:59 INFO - 1501036679432 Marionette TRACE 366 <- [1,1,null,{"sessionId":"757d3dc0-4e48-4745-a43f-8bdd9e142985","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:59 INFO - 1501036679460 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
19:37:59 INFO - 1501036679465 Marionette TRACE 366 <- [1,2,null,{}]
19:37:59 INFO - 1501036679471 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:37:59 INFO - 1501036679473 Marionette TRACE 366 <- [1,3,null,{}]
19:37:59 INFO - 1501036679476 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
19:37:59 INFO - 1501036679479 Marionette TRACE 366 <- [1,4,null,{}]
19:37:59 INFO - 1501036679482 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}]
19:37:59 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1501036679493 Marionette TRACE 366 <- [1,5,null,{"value":null}]
19:37:59 INFO - 1501036679497 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679503 Marionette TRACE 366 <- [1,6,null,{}]
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679564 Marionette DEBUG Closed connection 366
19:37:59 INFO - 1501036679567 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49810
19:37:59 INFO - 1501036679589 Marionette DEBUG Closed connection 367
19:37:59 INFO - 1501036679591 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49811
19:37:59 INFO - 1501036679594 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:37:59 INFO - 1501036679597 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:59 INFO - 1501036679622 Marionette DEBUG Register listener.js for window 12
19:37:59 INFO - 1501036679638 Marionette TRACE 368 <- [1,1,null,{"sessionId":"2d6d3b39-f6d8-4e89-9bee-3b922fe9d46f","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:59 INFO - 1501036679668 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679677 Marionette TRACE 368 <- [1,2,null,{}]
19:37:59 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:37:59 INFO - 1501036679705 Marionette DEBUG Closed connection 368
19:37:59 INFO - 1501036679707 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49812
19:37:59 INFO - 1501036679712 Marionette DEBUG Closed connection 369
19:37:59 INFO - 1501036679714 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49813
19:37:59 INFO - 1501036679720 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:37:59 INFO - 1501036679724 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:37:59 INFO - 1501036679747 Marionette DEBUG Register listener.js for window 12
19:37:59 INFO - 1501036679762 Marionette TRACE 370 <- [1,1,null,{"sessionId":"1f5309bf-bf73-45b7-b253-02c1857ae8f2","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:37:59 INFO - 1501036679771 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"}]
19:37:59 INFO - 1501036679776 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"
19:37:59 INFO - 1501036679785 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"
19:37:59 INFO - 1501036679786 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"
19:37:59 INFO - ++DOMWINDOW == 31 (000000C8A5E67800) [pid = 340] [serial = 44] [outer = 000000C8B2161000]
19:37:59 INFO - 1501036679843 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"
19:37:59 INFO - 1501036679854 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"
19:37:59 INFO - 1501036679867 Marionette TRACE 370 <- [1,2,null,{}]
19:37:59 INFO - 1501036679882 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
19:37:59 INFO - 1501036679895 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"efe91b9c-f6f2-4065-95f7-ef0a2e1224cb","ELEMENT":"efe91b9c-f6f2-4065-95f7-ef0a2e1224cb"}}]
19:37:59 INFO - 1501036679897 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"efe91b9c-f6f2-4065-95f7-ef0a2e1224cb"}]
19:38:00 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
19:38:00 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
19:38:00 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
19:38:00 INFO - --DOMWINDOW == 30 (000000C8BA237000) [pid = 340] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 29 (000000C8B74B2000) [pid = 340] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 28 (000000C8B1972800) [pid = 340] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 27 (000000C8AB3DD000) [pid = 340] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 26 (000000C8B722B800) [pid = 340] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 25 (000000C8B1AC2000) [pid = 340] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:00 INFO - --DOMWINDOW == 24 (000000C8B216B000) [pid = 340] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49346/test_accessibility.html]
19:38:01 INFO - 1501036681073 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:38:01 INFO - 1501036681095 Marionette TRACE 370 <- [1,4,null,{}]
19:38:01 INFO - 1501036681142 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"efe91b9c-f6f2-4065-95f7-ef0a2e1224cb","name":"selected"}]
19:38:01 INFO - 1501036681176 Marionette TRACE 370 <- [1,5,null,{"value":true}]
19:38:01 INFO - 1501036681228 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}]
19:38:01 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1501036681238 Marionette TRACE 370 <- [1,6,null,{"value":null}]
19:38:01 INFO - 1501036681240 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681244 Marionette TRACE 370 <- [1,7,null,{}]
19:38:01 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1954ms
19:38:01 INFO - TEST-START | test_click.py TestClick.test_css_transforms
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681302 Marionette DEBUG Closed connection 370
19:38:01 INFO - 1501036681304 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49814
19:38:01 INFO - 1501036681356 Marionette DEBUG Closed connection 371
19:38:01 INFO - 1501036681359 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49815
19:38:01 INFO - 1501036681412 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:01 INFO - 1501036681415 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:01 INFO - 1501036681438 Marionette DEBUG Register listener.js for window 12
19:38:01 INFO - 1501036681452 Marionette TRACE 372 <- [1,1,null,{"sessionId":"c030b63a-5416-45b4-b79c-f534683ab409","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:01 INFO - 1501036681510 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
19:38:01 INFO - 1501036681512 Marionette TRACE 372 <- [1,2,null,{}]
19:38:01 INFO - 1501036681521 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:38:01 INFO - 1501036681523 Marionette TRACE 372 <- [1,3,null,{}]
19:38:01 INFO - 1501036681544 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
19:38:01 INFO - 1501036681546 Marionette TRACE 372 <- [1,4,null,{}]
19:38:01 INFO - 1501036681550 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}]
19:38:01 INFO - TEST-START: test_click.py TestClick.test_css_transforms1501036681559 Marionette TRACE 372 <- [1,5,null,{"value":null}]
19:38:01 INFO - 1501036681562 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681566 Marionette TRACE 372 <- [1,6,null,{}]
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681588 Marionette DEBUG Closed connection 372
19:38:01 INFO - 1501036681590 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49816
19:38:01 INFO - 1501036681594 Marionette DEBUG Closed connection 373
19:38:01 INFO - 1501036681596 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49817
19:38:01 INFO - 1501036681598 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:01 INFO - 1501036681603 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:01 INFO - 1501036681627 Marionette DEBUG Register listener.js for window 12
19:38:01 INFO - 1501036681642 Marionette TRACE 374 <- [1,1,null,{"sessionId":"06dec107-47e0-4d4f-8166-00edc47d887a","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:01 INFO - 1501036681653 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681658 Marionette TRACE 374 <- [1,2,null,{}]
19:38:01 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:01 INFO - 1501036681682 Marionette DEBUG Closed connection 374
19:38:01 INFO - 1501036681688 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49818
19:38:01 INFO - 1501036681693 Marionette DEBUG Closed connection 375
19:38:01 INFO - 1501036681694 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49819
19:38:01 INFO - 1501036681697 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:38:01 INFO - 1501036681700 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:01 INFO - 1501036681724 Marionette DEBUG Register listener.js for window 12
19:38:01 INFO - 1501036681739 Marionette TRACE 376 <- [1,1,null,{"sessionId":"8bfcab74-38f5-4f02-9df8-5171b2a8c5fb","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:01 INFO - 1501036681745 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"}]
19:38:01 INFO - 1501036681751 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"
19:38:01 INFO - 1501036681760 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"
19:38:01 INFO - 1501036681761 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"
19:38:01 INFO - ++DOMWINDOW == 25 (000000C8B1006000) [pid = 340] [serial = 45] [outer = 000000C8B2161000]
19:38:01 INFO - 1501036681824 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"
19:38:01 INFO - 1501036681830 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"
19:38:01 INFO - 1501036681852 Marionette TRACE 376 <- [1,2,null,{}]
19:38:01 INFO - 1501036681855 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
19:38:01 INFO - 1501036681865 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3005eb6d-1c86-40d4-ae09-9e2dff662637","ELEMENT":"3005eb6d-1c86-40d4-ae09-9e2dff662637"}}]
19:38:01 INFO - 1501036681868 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"3005eb6d-1c86-40d4-ae09-9e2dff662637"}]
19:38:02 INFO - 1501036682339 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:38:02 INFO - 1501036682341 Marionette TRACE 376 <- [1,4,null,{}]
19:38:02 INFO - 1501036682344 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}]
19:38:02 INFO - TEST-END: test_click.py TestClick.test_css_transforms1501036682352 Marionette TRACE 376 <- [1,5,null,{"value":null}]
19:38:02 INFO - 1501036682354 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682358 Marionette TRACE 376 <- [1,6,null,{}]
19:38:02 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1113ms
19:38:02 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682365 Marionette DEBUG Closed connection 376
19:38:02 INFO - 1501036682366 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49820
19:38:02 INFO - 1501036682368 Marionette DEBUG Closed connection 377
19:38:02 INFO - 1501036682369 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49821
19:38:02 INFO - 1501036682372 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:02 INFO - 1501036682374 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:02 INFO - 1501036682398 Marionette DEBUG Register listener.js for window 12
19:38:02 INFO - 1501036682426 Marionette TRACE 378 <- [1,1,null,{"sessionId":"0b0ec5c7-737e-4898-84ae-e24efe815ab4","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:02 INFO - 1501036682462 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
19:38:02 INFO - 1501036682464 Marionette TRACE 378 <- [1,2,null,{}]
19:38:02 INFO - 1501036682466 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:38:02 INFO - 1501036682468 Marionette TRACE 378 <- [1,3,null,{}]
19:38:02 INFO - 1501036682470 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
19:38:02 INFO - 1501036682472 Marionette TRACE 378 <- [1,4,null,{}]
19:38:02 INFO - 1501036682474 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}]
19:38:02 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1501036682483 Marionette TRACE 378 <- [1,5,null,{"value":null}]
19:38:02 INFO - 1501036682485 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682489 Marionette TRACE 378 <- [1,6,null,{}]
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682495 Marionette DEBUG Closed connection 378
19:38:02 INFO - 1501036682497 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49822
19:38:02 INFO - 1501036682499 Marionette DEBUG Closed connection 379
19:38:02 INFO - 1501036682502 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49823
19:38:02 INFO - 1501036682504 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:02 INFO - 1501036682507 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:02 INFO - 1501036682530 Marionette DEBUG Register listener.js for window 12
19:38:02 INFO - 1501036682542 Marionette TRACE 380 <- [1,1,null,{"sessionId":"79c35320-b2ee-46ee-a781-ac86841e9b5c","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:02 INFO - 1501036682572 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682576 Marionette TRACE 380 <- [1,2,null,{}]
19:38:02 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:02 INFO - 1501036682598 Marionette DEBUG Closed connection 380
19:38:02 INFO - 1501036682599 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49824
19:38:02 INFO - 1501036682604 Marionette DEBUG Closed connection 381
19:38:02 INFO - 1501036682605 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49825
19:38:02 INFO - 1501036682608 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:38:02 INFO - 1501036682611 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:02 INFO - 1501036682634 Marionette DEBUG Register listener.js for window 12
19:38:02 INFO - 1501036682646 Marionette TRACE 382 <- [1,1,null,{"sessionId":"4c8730f0-f5f9-4a64-b85d-a71c6cd0a6f8","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:02 INFO - 1501036682656 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"}]
19:38:02 INFO - 1501036682660 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"
19:38:02 INFO - 1501036682666 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"
19:38:02 INFO - 1501036682667 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"
19:38:02 INFO - ++DOMWINDOW == 26 (000000C8B6511800) [pid = 340] [serial = 46] [outer = 000000C8B2161000]
19:38:02 INFO - 1501036682724 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"
19:38:02 INFO - 1501036682729 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"
19:38:02 INFO - 1501036682746 Marionette TRACE 382 <- [1,2,null,{}]
19:38:02 INFO - 1501036682753 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
19:38:02 INFO - 1501036682777 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"eba651ae-5b6d-496c-a012-652a6401b8ac","ELEMENT":"eba651ae-5b6d-496c-a012-652a6401b8ac"}}]
19:38:02 INFO - 1501036682780 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"eba651ae-5b6d-496c-a012-652a6401b8ac"}]
19:38:03 INFO - 1501036683263 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:38:03 INFO - 1501036683265 Marionette TRACE 382 <- [1,4,null,{}]
19:38:03 INFO - 1501036683268 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}]
19:38:03 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1501036683276 Marionette TRACE 382 <- [1,5,null,{"value":null}]
19:38:03 INFO - 1501036683278 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683283 Marionette TRACE 382 <- [1,6,null,{}]
19:38:03 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 924ms
19:38:03 INFO - TEST-START | test_click.py TestClick.test_input_file
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683289 Marionette DEBUG Closed connection 382
19:38:03 INFO - 1501036683290 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49826
19:38:03 INFO - 1501036683292 Marionette DEBUG Closed connection 383
19:38:03 INFO - 1501036683293 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49827
19:38:03 INFO - 1501036683295 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:03 INFO - 1501036683298 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:03 INFO - 1501036683321 Marionette DEBUG Register listener.js for window 12
19:38:03 INFO - 1501036683333 Marionette TRACE 384 <- [1,1,null,{"sessionId":"2074f884-f02b-4f48-b7c2-e0d855dfa06d","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:03 INFO - 1501036683339 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
19:38:03 INFO - 1501036683341 Marionette TRACE 384 <- [1,2,null,{}]
19:38:03 INFO - 1501036683370 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:38:03 INFO - 1501036683372 Marionette TRACE 384 <- [1,3,null,{}]
19:38:03 INFO - 1501036683374 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
19:38:03 INFO - 1501036683375 Marionette TRACE 384 <- [1,4,null,{}]
19:38:03 INFO - 1501036683378 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}]
19:38:03 INFO - TEST-START: test_click.py TestClick.test_input_file1501036683386 Marionette TRACE 384 <- [1,5,null,{"value":null}]
19:38:03 INFO - 1501036683388 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683393 Marionette TRACE 384 <- [1,6,null,{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683399 Marionette DEBUG Closed connection 384
19:38:03 INFO - 1501036683400 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49828
19:38:03 INFO - 1501036683402 Marionette DEBUG Closed connection 385
19:38:03 INFO - 1501036683403 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49829
19:38:03 INFO - 1501036683406 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:03 INFO - 1501036683409 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:03 INFO - 1501036683437 Marionette DEBUG Register listener.js for window 12
19:38:03 INFO - 1501036683451 Marionette TRACE 386 <- [1,1,null,{"sessionId":"4869e0eb-326b-43c0-9c2a-12111975d64b","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:03 INFO - 1501036683481 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683486 Marionette TRACE 386 <- [1,2,null,{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683507 Marionette DEBUG Closed connection 386
19:38:03 INFO - 1501036683509 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49830
19:38:03 INFO - 1501036683513 Marionette DEBUG Closed connection 387
19:38:03 INFO - 1501036683514 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49831
19:38:03 INFO - 1501036683517 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:38:03 INFO - 1501036683520 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:03 INFO - 1501036683543 Marionette DEBUG Register listener.js for window 12
19:38:03 INFO - 1501036683555 Marionette TRACE 388 <- [1,1,null,{"sessionId":"65e29f84-837a-4cad-b198-f5b1d52bd013","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:03 INFO - 1501036683565 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
19:38:03 INFO - 1501036683569 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"
19:38:03 INFO - 1501036683578 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"
19:38:03 INFO - 1501036683580 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"
19:38:03 INFO - ++DOMWINDOW == 27 (000000C8B7222800) [pid = 340] [serial = 47] [outer = 000000C8B2161000]
19:38:03 INFO - 1501036683638 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:38:03 INFO - 1501036683643 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:38:03 INFO - 1501036683661 Marionette TRACE 388 <- [1,2,null,{}]
19:38:03 INFO - 1501036683669 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
19:38:03 INFO - 1501036683677 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c2a9e573-990e-49c2-8aab-c4c811545912","ELEMENT":"c2a9e573-990e-49c2-8aab-c4c811545912"}}]
19:38:03 INFO - 1501036683679 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"c2a9e573-990e-49c2-8aab-c4c811545912"}]
19:38:03 INFO - 1501036683849 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
19:38:03 INFO - 1501036683852 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}]
19:38:03 INFO - TEST-END: test_click.py TestClick.test_input_file1501036683860 Marionette TRACE 388 <- [1,5,null,{"value":null}]
19:38:03 INFO - 1501036683862 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683866 Marionette TRACE 388 <- [1,6,null,{}]
19:38:03 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 584ms
19:38:03 INFO - TEST-START | test_click.py TestClick.test_obscured_element
19:38:03 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:03 INFO - 1501036683872 Marionette DEBUG Closed connection 388
19:38:03 INFO - 1501036683874 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49832
19:38:03 INFO - 1501036683876 Marionette DEBUG Closed connection 389
19:38:03 INFO - 1501036683877 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49833
19:38:03 INFO - 1501036683899 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:03 INFO - 1501036683902 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:03 INFO - 1501036683925 Marionette DEBUG Register listener.js for window 12
19:38:03 INFO - 1501036683945 Marionette TRACE 390 <- [1,1,null,{"sessionId":"ba039951-0f3f-4696-9c1a-e6ad35a0fd57","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:03 INFO - 1501036683955 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
19:38:03 INFO - 1501036683957 Marionette TRACE 390 <- [1,2,null,{}]
19:38:03 INFO - 1501036683961 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:38:03 INFO - 1501036683962 Marionette TRACE 390 <- [1,3,null,{}]
19:38:03 INFO - 1501036683964 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
19:38:03 INFO - 1501036683966 Marionette TRACE 390 <- [1,4,null,{}]
19:38:04 INFO - 1501036684586 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}]
19:38:04 INFO - TEST-START: test_click.py TestClick.test_obscured_element1501036684596 Marionette TRACE 390 <- [1,5,null,{"value":null}]
19:38:04 INFO - 1501036684644 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
19:38:04 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:04 INFO - 1501036684649 Marionette TRACE 390 <- [1,6,null,{}]
19:38:04 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:04 INFO - 1501036684655 Marionette DEBUG Closed connection 390
19:38:04 INFO - 1501036684657 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49834
19:38:04 INFO - 1501036684708 Marionette DEBUG Closed connection 391
19:38:04 INFO - 1501036684710 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49835
19:38:04 INFO - 1501036684753 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:04 INFO - 1501036684765 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:04 INFO - 1501036684809 Marionette DEBUG Register listener.js for window 12
19:38:04 INFO - 1501036684832 Marionette TRACE 392 <- [1,1,null,{"sessionId":"4858b2ac-1872-4882-a143-10d360234888","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:04 INFO - 1501036684846 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
19:38:04 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:04 INFO - 1501036684853 Marionette TRACE 392 <- [1,2,null,{}]
19:38:04 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:04 INFO - 1501036684874 Marionette DEBUG Closed connection 392
19:38:04 INFO - 1501036684877 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49836
19:38:04 INFO - 1501036684901 Marionette DEBUG Closed connection 393
19:38:04 INFO - 1501036684904 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49837
19:38:04 INFO - 1501036684910 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:38:04 INFO - 1501036684916 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:04 INFO - 1501036684961 Marionette DEBUG Register listener.js for window 12
19:38:05 INFO - 1501036684992 Marionette TRACE 394 <- [1,1,null,{"sessionId":"2609d9ed-29e1-4275-a285-832f8aa63a5b","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:05 INFO - 1501036685007 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"}]
19:38:05 INFO - 1501036685014 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:38:05 INFO - 1501036685025 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:38:05 INFO - 1501036685026 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
19:38:05 INFO - ++DOMWINDOW == 28 (000000C8A8941000) [pid = 340] [serial = 48] [outer = 000000C8B2161000]
19:38:05 INFO - 1501036685100 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"
19:38:05 INFO - 1501036685108 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"
19:38:05 INFO - 1501036685141 Marionette TRACE 394 <- [1,2,null,{}]
19:38:05 INFO - 1501036685150 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
19:38:05 INFO - 1501036685163 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"30446aac-555e-4e87-8b52-99a58e96bbcf","ELEMENT":"30446aac-555e-4e87-8b52-99a58e96bbcf"}}]
19:38:05 INFO - 1501036685166 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
19:38:05 INFO - 1501036685176 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a6fb07e7-dd7a-4a8d-8b82-4eaa0fec3d40","ELEMENT":"a6fb07e7-dd7a-4a8d-8b82-4eaa0fec3d40"}}]
19:38:05 INFO - 1501036685179 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"30446aac-555e-4e87-8b52-99a58e96bbcf"}]
19:38:05 INFO - 1501036685793 Marionette DEBUG Canceled page load listener because no navigation has been detected
19:38:05 INFO - 1501036685795 Marionette TRACE 394 <- [1,5,null,{}]
19:38:05 INFO - 1501036685799 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"a6fb07e7-dd7a-4a8d-8b82-4eaa0fec3d40"}]
19:38:06 INFO - 1501036686101 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:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
19:38:06 INFO - 1501036686108 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
19:38:06 INFO - 1501036686122 Marionette TRACE 394 <- [1,7,null,{"value":false}]
19:38:06 INFO - 1501036686126 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}]
19:38:06 INFO - TEST-END: test_click.py TestClick.test_obscured_element1501036686138 Marionette TRACE 394 <- [1,8,null,{"value":null}]
19:38:06 INFO - 1501036686173 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686183 Marionette TRACE 394 <- [1,9,null,{}]
19:38:06 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 2327ms
19:38:06 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686218 Marionette DEBUG Closed connection 394
19:38:06 INFO - 1501036686221 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49838
19:38:06 INFO - 1501036686225 Marionette DEBUG Closed connection 395
19:38:06 INFO - 1501036686228 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49839
19:38:06 INFO - 1501036686280 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:06 INFO - 1501036686284 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:06 INFO - 1501036686329 Marionette DEBUG Register listener.js for window 12
19:38:06 INFO - 1501036686347 Marionette TRACE 396 <- [1,1,null,{"sessionId":"b3504364-7fa1-4ed4-9a67-ca569e450d23","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:06 INFO - 1501036686360 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
19:38:06 INFO - 1501036686363 Marionette TRACE 396 <- [1,2,null,{}]
19:38:06 INFO - 1501036686414 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
19:38:06 INFO - 1501036686417 Marionette TRACE 396 <- [1,3,null,{}]
19:38:06 INFO - 1501036686420 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
19:38:06 INFO - 1501036686422 Marionette TRACE 396 <- [1,4,null,{}]
19:38:06 INFO - 1501036686425 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}]
19:38:06 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1501036686436 Marionette TRACE 396 <- [1,5,null,{"value":null}]
19:38:06 INFO - 1501036686477 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686483 Marionette TRACE 396 <- [1,6,null,{}]
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686508 Marionette DEBUG Closed connection 396
19:38:06 INFO - 1501036686511 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49840
19:38:06 INFO - 1501036686516 Marionette DEBUG Closed connection 397
19:38:06 INFO - 1501036686518 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49841
19:38:06 INFO - 1501036686688 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
19:38:06 INFO - 1501036686702 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:06 INFO - 1501036686732 Marionette DEBUG Register listener.js for window 12
19:38:06 INFO - 1501036686755 Marionette TRACE 398 <- [1,1,null,{"sessionId":"f7f02741-8d70-4928-b0b4-02adbeaf6490","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:06 INFO - 1501036686772 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686779 Marionette TRACE 398 <- [1,2,null,{}]
19:38:06 INFO - [Parent 340] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
19:38:06 INFO - 1501036686838 Marionette DEBUG Closed connection 398
19:38:06 INFO - 1501036686840 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49842
19:38:06 INFO - 1501036686864 Marionette DEBUG Closed connection 399
19:38:06 INFO - 1501036686867 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49843
19:38:06 INFO - 1501036686873 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
19:38:06 INFO - 1501036686879 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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}
19:38:06 INFO - 1501036686908 Marionette DEBUG Register listener.js for window 12
19:38:06 INFO - 1501036686927 Marionette TRACE 400 <- [1,1,null,{"sessionId":"00bcb069-169b-49f0-acb8-4dffc89b0f21","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":340,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-334.001\\AppData\\Local\\Temp\\tmpst7vlq.mozrunner","moz:accessibilityChecks":false}}]
19:38:06 INFO - 1501036686970 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"}]
19:38:06 INFO - 1501036686978 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"
19:38:06 INFO - 1501036686988 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"
19:38:06 INFO - 1501036686989 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"
19:38:06 INFO - ++DOMWINDOW == 29 (000000C8ACB93800) [pid = 340] [serial = 49] [outer = 000000C8B2161000]
19:38:07 INFO - 1501036687053 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"
19:38:07 INFO - 1501036687059 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"
19:38:07 INFO - 1501036687078 Marionette TRACE 400 <- [1,2,null,{}]
19:38:07 INFO - 1501036687092 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
19:38:07 INFO - 1501036687103 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"88a18dcc-05d4-425c-a6c8-42c4abdf6208","ELEMENT":"88a18dcc-05d4-425c-a6c8-42c4abdf6208"}}]
19:38:07 INFO - 1501036687106 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"88a18dcc-05d4-425c-a6c8-42c4abdf6208"}]
19:38:07 INFO - 1501036687245 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
19:38:07 INFO - 1501036687249 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"88a18dcc-05d4-425c-a6c8-42c4abdf6208"}]
19:38:07 INFO - 1501036687410 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element