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]
01:52:01 INFO - 1501059121708 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}]
01:52:01 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1501059121715 Marionette TRACE 352 <- [1,5,null,{"value":null}]
01:52:01 INFO - 1501059121717 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 451ms
01:52:01 INFO - 1501059121721 Marionette TRACE 352 <- [1,6,null,{}]
01:52:01 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - 1501059121725 Marionette DEBUG Closed connection 352
01:52:01 INFO - 1501059121727 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49798
01:52:01 INFO - 1501059121728 Marionette DEBUG Closed connection 353
01:52:01 INFO - 1501059121729 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49799
01:52:01 INFO - 1501059121732 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:01 INFO - 1501059121734 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:01 INFO - 1501059121753 Marionette DEBUG Register listener.js for window 4294967297
01:52:01 INFO - 1501059121764 Marionette TRACE 354 <- [1,1,null,{"sessionId":"cdf045b7-e301-49db-91ae-9304163efd3f","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:01 INFO - 1501059121767 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
01:52:01 INFO - 1501059121769 Marionette TRACE 354 <- [1,2,null,{}]
01:52:01 INFO - 1501059121771 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:01 INFO - 1501059121772 Marionette TRACE 354 <- [1,3,null,{}]
01:52:01 INFO - 1501059121774 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:01 INFO - 1501059121775 Marionette TRACE 354 <- [1,4,null,{}]
01:52:01 INFO - 1501059121778 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}]
01:52:01 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1501059121785 Marionette TRACE 354 <- [1,5,null,{"value":null}]
01:52:01 INFO - 1501059121787 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - 1501059121791 Marionette TRACE 354 <- [1,6,null,{}]
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - 1501059121795 Marionette DEBUG Closed connection 354
01:52:01 INFO - 1501059121796 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49800
01:52:01 INFO - 1501059121798 Marionette DEBUG Closed connection 355
01:52:01 INFO - 1501059121799 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49801
01:52:01 INFO - 1501059121801 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:01 INFO - 1501059121803 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:01 INFO - 1501059121823 Marionette DEBUG Register listener.js for window 4294967297
01:52:01 INFO - 1501059121835 Marionette TRACE 356 <- [1,1,null,{"sessionId":"61c8c166-c937-4dc9-9d94-ec29966735fd","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:01 INFO - 1501059121838 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - 1501059121842 Marionette TRACE 356 <- [1,2,null,{}]
01:52:01 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:01 INFO - 1501059121846 Marionette DEBUG Closed connection 356
01:52:01 INFO - 1501059121848 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49802
01:52:01 INFO - 1501059121849 Marionette DEBUG Closed connection 357
01:52:01 INFO - 1501059121851 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49803
01:52:01 INFO - 1501059121853 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:01 INFO - 1501059121855 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:01 INFO - 1501059121876 Marionette DEBUG Register listener.js for window 4294967297
01:52:01 INFO - 1501059121887 Marionette TRACE 358 <- [1,1,null,{"sessionId":"0585e982-e22a-48fd-83fd-698bbdd3455e","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:01 INFO - 1501059121890 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49343/clicks.html"}]
01:52:01 INFO - 1501059121894 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49343/hidden.html"
01:52:01 INFO - 1501059121912 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49343/hidden.html"
01:52:01 INFO - 1501059121913 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49343/hidden.html"
01:52:01 INFO - ++DOMWINDOW == 15 (000000B056411800) [pid = 56] [serial = 25] [outer = 000000B0453CB800]
01:52:01 INFO - 1501059121942 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49343/clicks.html"
01:52:01 INFO - 1501059121947 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49343/clicks.html"
01:52:01 INFO - 1501059121948 Marionette TRACE 358 <- [1,2,null,{}]
01:52:01 INFO - 1501059121963 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
01:52:01 INFO - 1501059121970 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f0d546c3-acd7-4a7d-8be6-1d8b61a1226f","ELEMENT":"f0d546c3-acd7-4a7d-8be6-1d8b61a1226f"}}]
01:52:01 INFO - 1501059121972 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"f0d546c3-acd7-4a7d-8be6-1d8b61a1226f"}]
01:52:02 INFO - 1501059122200 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49343/clicks.html"
01:52:02 INFO - 1501059122219 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49343/clicks.html"
01:52:02 INFO - 1501059122220 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49343/clicks.html"
01:52:02 INFO - ++DOMWINDOW == 16 (000000B056419000) [pid = 56] [serial = 26] [outer = 000000B0453CB800]
01:52:02 INFO - 1501059122248 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49343/test.html"
01:52:02 INFO - 1501059122252 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49343/test.html"
01:52:02 INFO - 1501059122262 Marionette TRACE 358 <- [1,4,null,{}]
01:52:02 INFO - 1501059122278 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
01:52:02 INFO - 1501059122383 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1c670e93-1354-4de4-94b7-2e14a0bcdaae","ELEMENT":"1c670e93-1354-4de4-94b7-2e14a0bcdaae"}}]
01:52:02 INFO - 1501059122385 Marionette TRACE 358 -> [0,6,"getTitle",{}]
01:52:02 INFO - 1501059122387 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
01:52:02 INFO - 1501059122389 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}]
01:52:02 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1501059122398 Marionette TRACE 358 <- [1,7,null,{"value":null}]
01:52:02 INFO - 1501059122400 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
01:52:02 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 682ms
01:52:02 INFO - TEST-START | test_click.py TestClick.test_container_element
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122404 Marionette TRACE 358 <- [1,8,null,{}]
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122408 Marionette DEBUG Closed connection 358
01:52:02 INFO - 1501059122410 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49806
01:52:02 INFO - 1501059122411 Marionette DEBUG Closed connection 359
01:52:02 INFO - 1501059122412 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49807
01:52:02 INFO - 1501059122414 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:02 INFO - 1501059122416 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:02 INFO - 1501059122436 Marionette DEBUG Register listener.js for window 4294967297
01:52:02 INFO - 1501059122447 Marionette TRACE 360 <- [1,1,null,{"sessionId":"b9e91dd1-21be-455e-9be1-296932a5c960","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:02 INFO - 1501059122450 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
01:52:02 INFO - 1501059122451 Marionette TRACE 360 <- [1,2,null,{}]
01:52:02 INFO - 1501059122453 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:02 INFO - 1501059122454 Marionette TRACE 360 <- [1,3,null,{}]
01:52:02 INFO - 1501059122456 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:02 INFO - 1501059122457 Marionette TRACE 360 <- [1,4,null,{}]
01:52:02 INFO - 1501059122460 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}]
01:52:02 INFO - TEST-START: test_click.py TestClick.test_container_element1501059122473 Marionette TRACE 360 <- [1,5,null,{"value":null}]
01:52:02 INFO - 1501059122475 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122479 Marionette TRACE 360 <- [1,6,null,{}]
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122483 Marionette DEBUG Closed connection 360
01:52:02 INFO - 1501059122485 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49808
01:52:02 INFO - 1501059122486 Marionette DEBUG Closed connection 361
01:52:02 INFO - 1501059122487 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49809
01:52:02 INFO - 1501059122489 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:02 INFO - 1501059122492 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:02 INFO - 1501059122511 Marionette DEBUG Register listener.js for window 4294967297
01:52:02 INFO - 1501059122522 Marionette TRACE 362 <- [1,1,null,{"sessionId":"64d7607b-f1dc-415a-a321-154fa54e27a6","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:02 INFO - 1501059122525 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122529 Marionette TRACE 362 <- [1,2,null,{}]
01:52:02 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:02 INFO - 1501059122533 Marionette DEBUG Closed connection 362
01:52:02 INFO - 1501059122534 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49810
01:52:02 INFO - 1501059122536 Marionette DEBUG Closed connection 363
01:52:02 INFO - 1501059122537 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49811
01:52:02 INFO - 1501059122539 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:02 INFO - 1501059122541 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:02 INFO - 1501059122561 Marionette DEBUG Register listener.js for window 4294967297
01:52:02 INFO - 1501059122572 Marionette TRACE 364 <- [1,1,null,{"sessionId":"b594d8d5-259c-4f8e-ba32-20668d3e8b41","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:02 INFO - 1501059122575 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"}]
01:52:02 INFO - 1501059122590 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49343/test.html"
01:52:02 INFO - 1501059122595 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49343/test.html"
01:52:02 INFO - 1501059122595 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49343/test.html"
01:52:02 INFO - ++DOMWINDOW == 17 (000000B056422000) [pid = 56] [serial = 27] [outer = 000000B0453CB800]
01:52:02 INFO - 1501059122618 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"
01:52:02 INFO - 1501059122625 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"
01:52:02 INFO - 1501059122645 Marionette TRACE 364 <- [1,2,null,{}]
01:52:02 INFO - 1501059122661 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
01:52:02 INFO - 1501059122668 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"84282c74-2b73-4049-8793-c05158cf801e","ELEMENT":"84282c74-2b73-4049-8793-c05158cf801e"}}]
01:52:02 INFO - 1501059122670 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"84282c74-2b73-4049-8793-c05158cf801e"}]
01:52:02 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
01:52:02 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
01:52:02 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
01:52:03 INFO - 1501059123093 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:52:03 INFO - 1501059123095 Marionette TRACE 364 <- [1,4,null,{}]
01:52:03 INFO - 1501059123097 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"84282c74-2b73-4049-8793-c05158cf801e","name":"selected"}]
01:52:03 INFO - 1501059123124 Marionette TRACE 364 <- [1,5,null,{"value":true}]
01:52:03 INFO - 1501059123126 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}]
01:52:03 INFO - TEST-END: test_click.py TestClick.test_container_element1501059123133 Marionette TRACE 364 <- [1,6,null,{"value":null}]
01:52:03 INFO - 1501059123135 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123139 Marionette TRACE 364 <- [1,7,null,{}]
01:52:03 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 736ms
01:52:03 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123143 Marionette DEBUG Closed connection 364
01:52:03 INFO - 1501059123145 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49812
01:52:03 INFO - 1501059123146 Marionette DEBUG Closed connection 365
01:52:03 INFO - 1501059123147 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49813
01:52:03 INFO - 1501059123150 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:03 INFO - 1501059123152 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:03 INFO - 1501059123173 Marionette DEBUG Register listener.js for window 4294967297
01:52:03 INFO - 1501059123184 Marionette TRACE 366 <- [1,1,null,{"sessionId":"630a9c04-83a0-4bed-b408-5c0924bfdf4c","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:03 INFO - 1501059123187 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
01:52:03 INFO - 1501059123188 Marionette TRACE 366 <- [1,2,null,{}]
01:52:03 INFO - 1501059123190 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:03 INFO - 1501059123191 Marionette TRACE 366 <- [1,3,null,{}]
01:52:03 INFO - 1501059123193 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:03 INFO - 1501059123195 Marionette TRACE 366 <- [1,4,null,{}]
01:52:03 INFO - 1501059123197 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}]
01:52:03 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1501059123595 Marionette TRACE 366 <- [1,5,null,{"value":null}]
01:52:03 INFO - 1501059123597 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123602 Marionette TRACE 366 <- [1,6,null,{}]
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123606 Marionette DEBUG Closed connection 366
01:52:03 INFO - 1501059123607 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49814
01:52:03 INFO - 1501059123609 Marionette DEBUG Closed connection 367
01:52:03 INFO - 1501059123610 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49815
01:52:03 INFO - 1501059123613 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:03 INFO - 1501059123615 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:03 INFO - 1501059123653 Marionette DEBUG Register listener.js for window 4294967297
01:52:03 INFO - 1501059123664 Marionette TRACE 368 <- [1,1,null,{"sessionId":"3ba4dc90-f7db-4d16-aef4-6d98e575b8b4","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:03 INFO - 1501059123667 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123671 Marionette TRACE 368 <- [1,2,null,{}]
01:52:03 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:03 INFO - 1501059123675 Marionette DEBUG Closed connection 368
01:52:03 INFO - 1501059123677 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49816
01:52:03 INFO - 1501059123679 Marionette DEBUG Closed connection 369
01:52:03 INFO - 1501059123680 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49817
01:52:03 INFO - 1501059123682 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:03 INFO - 1501059123685 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:03 INFO - 1501059123722 Marionette DEBUG Register listener.js for window 4294967297
01:52:03 INFO - 1501059123733 Marionette TRACE 370 <- [1,1,null,{"sessionId":"36a064dc-1fb0-4117-8891-11be37ef144c","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:03 INFO - 1501059123736 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"}]
01:52:03 INFO - 1501059123782 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"
01:52:03 INFO - 1501059123786 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"
01:52:03 INFO - 1501059123787 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"
01:52:03 INFO - ++DOMWINDOW == 18 (000000B0564AA800) [pid = 56] [serial = 28] [outer = 000000B0453CB800]
01:52:03 INFO - 1501059123811 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"
01:52:03 INFO - 1501059123815 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"
01:52:03 INFO - 1501059123825 Marionette TRACE 370 <- [1,2,null,{}]
01:52:03 INFO - 1501059123833 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
01:52:03 INFO - 1501059123872 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"876b4a66-956d-471d-8e0c-44fb00298a35","ELEMENT":"876b4a66-956d-471d-8e0c-44fb00298a35"}}]
01:52:03 INFO - 1501059123874 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"876b4a66-956d-471d-8e0c-44fb00298a35"}]
01:52:04 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
01:52:04 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
01:52:04 INFO - [Child 56] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
01:52:04 INFO - 1501059124359 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:52:04 INFO - 1501059124361 Marionette TRACE 370 <- [1,4,null,{}]
01:52:04 INFO - 1501059124363 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"876b4a66-956d-471d-8e0c-44fb00298a35","name":"selected"}]
01:52:04 INFO - 1501059124390 Marionette TRACE 370 <- [1,5,null,{"value":true}]
01:52:04 INFO - 1501059124393 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}]
01:52:04 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1501059124400 Marionette TRACE 370 <- [1,6,null,{"value":null}]
01:52:04 INFO - 1501059124402 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124406 Marionette TRACE 370 <- [1,7,null,{}]
01:52:04 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1267ms
01:52:04 INFO - TEST-START | test_click.py TestClick.test_css_transforms
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124410 Marionette DEBUG Closed connection 370
01:52:04 INFO - 1501059124411 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49818
01:52:04 INFO - 1501059124413 Marionette DEBUG Closed connection 371
01:52:04 INFO - 1501059124414 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49819
01:52:04 INFO - 1501059124417 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:04 INFO - 1501059124419 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:04 INFO - 1501059124439 Marionette DEBUG Register listener.js for window 4294967297
01:52:04 INFO - 1501059124464 Marionette TRACE 372 <- [1,1,null,{"sessionId":"618e2f28-128b-4421-8bda-ccfb71590340","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:04 INFO - 1501059124468 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
01:52:04 INFO - 1501059124469 Marionette TRACE 372 <- [1,2,null,{}]
01:52:04 INFO - 1501059124471 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:04 INFO - 1501059124472 Marionette TRACE 372 <- [1,3,null,{}]
01:52:04 INFO - 1501059124474 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:04 INFO - 1501059124475 Marionette TRACE 372 <- [1,4,null,{}]
01:52:04 INFO - 1501059124478 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}]
01:52:04 INFO - TEST-START: test_click.py TestClick.test_css_transforms1501059124485 Marionette TRACE 372 <- [1,5,null,{"value":null}]
01:52:04 INFO - 1501059124487 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124494 Marionette TRACE 372 <- [1,6,null,{}]
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124498 Marionette DEBUG Closed connection 372
01:52:04 INFO - 1501059124500 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49820
01:52:04 INFO - 1501059124502 Marionette DEBUG Closed connection 373
01:52:04 INFO - 1501059124503 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49821
01:52:04 INFO - 1501059124505 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:04 INFO - 1501059124507 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:04 INFO - 1501059124529 Marionette DEBUG Register listener.js for window 4294967297
01:52:04 INFO - 1501059124540 Marionette TRACE 374 <- [1,1,null,{"sessionId":"a90f9d6f-e4cf-444a-b21d-a5508fea41e2","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:04 INFO - 1501059124542 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124546 Marionette TRACE 374 <- [1,2,null,{}]
01:52:04 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:04 INFO - 1501059124550 Marionette DEBUG Closed connection 374
01:52:04 INFO - 1501059124552 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49822
01:52:04 INFO - 1501059124553 Marionette DEBUG Closed connection 375
01:52:04 INFO - 1501059124554 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49823
01:52:04 INFO - 1501059124556 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:04 INFO - 1501059124559 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:04 INFO - 1501059124579 Marionette DEBUG Register listener.js for window 4294967297
01:52:04 INFO - 1501059124740 Marionette TRACE 376 <- [1,1,null,{"sessionId":"2ddbc3ab-c5b7-4ce9-b5e1-1c5c0be6728c","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:04 INFO - 1501059124743 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"}]
01:52:04 INFO - 1501059124748 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"
01:52:04 INFO - 1501059124753 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"
01:52:04 INFO - 1501059124753 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"
01:52:04 INFO - ++DOMWINDOW == 19 (000000B0564B7800) [pid = 56] [serial = 29] [outer = 000000B0453CB800]
01:52:04 INFO - 1501059124775 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"
01:52:04 INFO - 1501059124781 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"
01:52:04 INFO - 1501059124795 Marionette TRACE 376 <- [1,2,null,{}]
01:52:04 INFO - 1501059124815 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
01:52:04 INFO - 1501059124822 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a2846d39-abb7-493d-9a58-76909601fd5c","ELEMENT":"a2846d39-abb7-493d-9a58-76909601fd5c"}}]
01:52:04 INFO - 1501059124823 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"a2846d39-abb7-493d-9a58-76909601fd5c"}]
01:52:05 INFO - 1501059125247 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:52:05 INFO - 1501059125512 Marionette TRACE 376 <- [1,4,null,{}]
01:52:05 INFO - 1501059125517 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}]
01:52:05 INFO - TEST-END: test_click.py TestClick.test_css_transforms1501059125661 Marionette TRACE 376 <- [1,5,null,{"value":null}]
01:52:05 INFO - 1501059125664 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125668 Marionette TRACE 376 <- [1,6,null,{}]
01:52:05 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1261ms
01:52:05 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125673 Marionette DEBUG Closed connection 376
01:52:05 INFO - 1501059125674 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49824
01:52:05 INFO - 1501059125676 Marionette DEBUG Closed connection 377
01:52:05 INFO - 1501059125677 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49825
01:52:05 INFO - 1501059125680 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:05 INFO - 1501059125682 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:05 INFO - 1501059125718 Marionette DEBUG Register listener.js for window 4294967297
01:52:05 INFO - 1501059125729 Marionette TRACE 378 <- [1,1,null,{"sessionId":"1b5d88d7-db00-4916-8788-875b5625b7e5","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:05 INFO - 1501059125732 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
01:52:05 INFO - 1501059125734 Marionette TRACE 378 <- [1,2,null,{}]
01:52:05 INFO - 1501059125735 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:05 INFO - 1501059125737 Marionette TRACE 378 <- [1,3,null,{}]
01:52:05 INFO - 1501059125739 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:05 INFO - 1501059125740 Marionette TRACE 378 <- [1,4,null,{}]
01:52:05 INFO - 1501059125743 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}]
01:52:05 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1501059125788 Marionette TRACE 378 <- [1,5,null,{"value":null}]
01:52:05 INFO - 1501059125790 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125794 Marionette TRACE 378 <- [1,6,null,{}]
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125798 Marionette DEBUG Closed connection 378
01:52:05 INFO - 1501059125800 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49826
01:52:05 INFO - 1501059125802 Marionette DEBUG Closed connection 379
01:52:05 INFO - 1501059125804 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49827
01:52:05 INFO - 1501059125807 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:05 INFO - 1501059125810 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:05 INFO - 1501059125838 Marionette DEBUG Register listener.js for window 4294967297
01:52:05 INFO - 1501059125850 Marionette TRACE 380 <- [1,1,null,{"sessionId":"d83e4c82-7d0e-41f5-8136-2d5f4084064f","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:05 INFO - 1501059125853 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125858 Marionette TRACE 380 <- [1,2,null,{}]
01:52:05 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:05 INFO - 1501059125862 Marionette DEBUG Closed connection 380
01:52:05 INFO - 1501059125863 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49828
01:52:05 INFO - 1501059125865 Marionette DEBUG Closed connection 381
01:52:05 INFO - 1501059125867 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49829
01:52:05 INFO - 1501059125869 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:05 INFO - 1501059125872 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:05 INFO - 1501059125893 Marionette DEBUG Register listener.js for window 4294967297
01:52:05 INFO - 1501059125904 Marionette TRACE 382 <- [1,1,null,{"sessionId":"95f04ec1-ab22-483e-9d78-a17ef37c4e98","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:05 INFO - 1501059125907 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"}]
01:52:05 INFO - 1501059125910 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"
01:52:05 INFO - 1501059125915 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"
01:52:05 INFO - 1501059125916 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"
01:52:05 INFO - ++DOMWINDOW == 20 (000000B057DBC000) [pid = 56] [serial = 30] [outer = 000000B0453CB800]
01:52:05 INFO - 1501059125941 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"
01:52:05 INFO - 1501059125945 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"
01:52:05 INFO - 1501059125952 Marionette TRACE 382 <- [1,2,null,{}]
01:52:05 INFO - 1501059125967 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
01:52:05 INFO - 1501059125975 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"50936e5c-62f4-4c40-8388-e5dfa5fb9c16","ELEMENT":"50936e5c-62f4-4c40-8388-e5dfa5fb9c16"}}]
01:52:05 INFO - 1501059125977 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"50936e5c-62f4-4c40-8388-e5dfa5fb9c16"}]
01:52:06 INFO - 1501059126420 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:52:06 INFO - 1501059126422 Marionette TRACE 382 <- [1,4,null,{}]
01:52:06 INFO - 1501059126425 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}]
01:52:06 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1501059126432 Marionette TRACE 382 <- [1,5,null,{"value":null}]
01:52:06 INFO - 1501059126433 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
01:52:06 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 768ms
01:52:06 INFO - TEST-START | test_click.py TestClick.test_input_file
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126438 Marionette TRACE 382 <- [1,6,null,{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126442 Marionette DEBUG Closed connection 382
01:52:06 INFO - 1501059126443 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49830
01:52:06 INFO - 1501059126445 Marionette DEBUG Closed connection 383
01:52:06 INFO - 1501059126446 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49831
01:52:06 INFO - 1501059126448 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:06 INFO - 1501059126450 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:06 INFO - 1501059126472 Marionette DEBUG Register listener.js for window 4294967297
01:52:06 INFO - 1501059126482 Marionette TRACE 384 <- [1,1,null,{"sessionId":"2af59f20-56bf-4417-a184-3c9bed73e5f2","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:06 INFO - 1501059126485 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
01:52:06 INFO - 1501059126487 Marionette TRACE 384 <- [1,2,null,{}]
01:52:06 INFO - 1501059126489 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:06 INFO - 1501059126490 Marionette TRACE 384 <- [1,3,null,{}]
01:52:06 INFO - 1501059126492 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:06 INFO - 1501059126493 Marionette TRACE 384 <- [1,4,null,{}]
01:52:06 INFO - 1501059126496 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}]
01:52:06 INFO - TEST-START: test_click.py TestClick.test_input_file1501059126503 Marionette TRACE 384 <- [1,5,null,{"value":null}]
01:52:06 INFO - 1501059126504 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126509 Marionette TRACE 384 <- [1,6,null,{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126513 Marionette DEBUG Closed connection 384
01:52:06 INFO - 1501059126514 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49832
01:52:06 INFO - 1501059126515 Marionette DEBUG Closed connection 385
01:52:06 INFO - 1501059126517 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49833
01:52:06 INFO - 1501059126519 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:06 INFO - 1501059126521 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:06 INFO - 1501059126542 Marionette DEBUG Register listener.js for window 4294967297
01:52:06 INFO - 1501059126552 Marionette TRACE 386 <- [1,1,null,{"sessionId":"c592200a-87c8-463f-a787-15c4cc094796","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:06 INFO - 1501059126555 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126559 Marionette TRACE 386 <- [1,2,null,{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126563 Marionette DEBUG Closed connection 386
01:52:06 INFO - 1501059126565 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49834
01:52:06 INFO - 1501059126566 Marionette DEBUG Closed connection 387
01:52:06 INFO - 1501059126567 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49835
01:52:06 INFO - 1501059126569 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:06 INFO - 1501059126572 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:06 INFO - 1501059126593 Marionette DEBUG Register listener.js for window 4294967297
01:52:06 INFO - 1501059126603 Marionette TRACE 388 <- [1,1,null,{"sessionId":"189e826f-f23c-4556-bf07-65b40ba4f518","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:06 INFO - 1501059126606 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
01:52:06 INFO - 1501059126610 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"
01:52:06 INFO - 1501059126614 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"
01:52:06 INFO - 1501059126615 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"
01:52:06 INFO - ++DOMWINDOW == 21 (000000B057DC7000) [pid = 56] [serial = 31] [outer = 000000B0453CB800]
01:52:06 INFO - 1501059126643 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:52:06 INFO - 1501059126647 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:52:06 INFO - 1501059126651 Marionette TRACE 388 <- [1,2,null,{}]
01:52:06 INFO - 1501059126665 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
01:52:06 INFO - 1501059126672 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"744c1f2d-b732-49b1-b5aa-25f2b1b6d069","ELEMENT":"744c1f2d-b732-49b1-b5aa-25f2b1b6d069"}}]
01:52:06 INFO - 1501059126674 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"744c1f2d-b732-49b1-b5aa-25f2b1b6d069"}]
01:52:06 INFO - 1501059126821 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]
01:52:06 INFO - 1501059126824 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}]
01:52:06 INFO - TEST-END: test_click.py TestClick.test_input_file1501059126831 Marionette TRACE 388 <- [1,5,null,{"value":null}]
01:52:06 INFO - 1501059126834 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126838 Marionette TRACE 388 <- [1,6,null,{}]
01:52:06 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 401ms
01:52:06 INFO - TEST-START | test_click.py TestClick.test_obscured_element
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126843 Marionette DEBUG Closed connection 388
01:52:06 INFO - 1501059126845 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49836
01:52:06 INFO - 1501059126846 Marionette DEBUG Closed connection 389
01:52:06 INFO - 1501059126848 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49837
01:52:06 INFO - 1501059126850 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:06 INFO - 1501059126852 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:06 INFO - 1501059126874 Marionette DEBUG Register listener.js for window 4294967297
01:52:06 INFO - 1501059126885 Marionette TRACE 390 <- [1,1,null,{"sessionId":"2dc4e596-7ef5-4ad9-92d2-93198fc9a813","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:06 INFO - 1501059126888 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
01:52:06 INFO - 1501059126889 Marionette TRACE 390 <- [1,2,null,{}]
01:52:06 INFO - 1501059126891 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:06 INFO - 1501059126892 Marionette TRACE 390 <- [1,3,null,{}]
01:52:06 INFO - 1501059126894 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:06 INFO - 1501059126895 Marionette TRACE 390 <- [1,4,null,{}]
01:52:06 INFO - 1501059126898 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}]
01:52:06 INFO - TEST-START: test_click.py TestClick.test_obscured_element1501059126905 Marionette TRACE 390 <- [1,5,null,{"value":null}]
01:52:06 INFO - 1501059126908 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126914 Marionette TRACE 390 <- [1,6,null,{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126918 Marionette DEBUG Closed connection 390
01:52:06 INFO - 1501059126920 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49838
01:52:06 INFO - 1501059126921 Marionette DEBUG Closed connection 391
01:52:06 INFO - 1501059126923 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49839
01:52:06 INFO - 1501059126926 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:06 INFO - 1501059126929 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:06 INFO - 1501059126950 Marionette DEBUG Register listener.js for window 4294967297
01:52:06 INFO - 1501059126960 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b640db8d-cd7a-49ad-be59-76690345136d","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:06 INFO - 1501059126963 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126967 Marionette TRACE 392 <- [1,2,null,{}]
01:52:06 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:06 INFO - 1501059126971 Marionette DEBUG Closed connection 392
01:52:06 INFO - 1501059126973 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49840
01:52:06 INFO - 1501059126974 Marionette DEBUG Closed connection 393
01:52:06 INFO - 1501059126975 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49841
01:52:06 INFO - 1501059126978 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:06 INFO - 1501059126980 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:07 INFO - 1501059127001 Marionette DEBUG Register listener.js for window 4294967297
01:52:07 INFO - 1501059127012 Marionette TRACE 394 <- [1,1,null,{"sessionId":"6523530b-e189-49e9-b99a-1ffaed4bf3db","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:07 INFO - 1501059127014 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"}]
01:52:07 INFO - 1501059127018 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:52:07 INFO - 1501059127024 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:52:07 INFO - 1501059127025 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:52:07 INFO - ++DOMWINDOW == 22 (000000B057F67000) [pid = 56] [serial = 32] [outer = 000000B0453CB800]
01:52:07 INFO - 1501059127048 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"
01:52:07 INFO - 1501059127054 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"
01:52:07 INFO - 1501059127067 Marionette TRACE 394 <- [1,2,null,{}]
01:52:07 INFO - 1501059127081 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
01:52:07 INFO - 1501059127087 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bec4e537-862d-4a9e-b5f2-36854aba68e7","ELEMENT":"bec4e537-862d-4a9e-b5f2-36854aba68e7"}}]
01:52:07 INFO - 1501059127090 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
01:52:07 INFO - 1501059127095 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bf95b73c-1e1b-4c37-bf8b-7fcf3eff0a81","ELEMENT":"bf95b73c-1e1b-4c37-bf8b-7fcf3eff0a81"}}]
01:52:07 INFO - 1501059127097 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"bec4e537-862d-4a9e-b5f2-36854aba68e7"}]
01:52:07 INFO - 1501059127520 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:52:07 INFO - 1501059127522 Marionette TRACE 394 <- [1,5,null,{}]
01:52:07 INFO - 1501059127525 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"bf95b73c-1e1b-4c37-bf8b-7fcf3eff0a81"}]
01:52:07 INFO - 1501059127650 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]
01:52:07 INFO - 1501059127653 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
01:52:07 INFO - 1501059127660 Marionette TRACE 394 <- [1,7,null,{"value":false}]
01:52:07 INFO - 1501059127662 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}]
01:52:07 INFO - TEST-END: test_click.py TestClick.test_obscured_element1501059127669 Marionette TRACE 394 <- [1,8,null,{"value":null}]
01:52:07 INFO - 1501059127671 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 836ms
01:52:07 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
01:52:07 INFO - 1501059127675 Marionette TRACE 394 <- [1,9,null,{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - 1501059127679 Marionette DEBUG Closed connection 394
01:52:07 INFO - 1501059127681 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49842
01:52:07 INFO - 1501059127682 Marionette DEBUG Closed connection 395
01:52:07 INFO - 1501059127684 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49843
01:52:07 INFO - 1501059127686 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:07 INFO - 1501059127688 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:07 INFO - 1501059127710 Marionette DEBUG Register listener.js for window 4294967297
01:52:07 INFO - 1501059127721 Marionette TRACE 396 <- [1,1,null,{"sessionId":"3796c312-ab54-47aa-8e3d-0933e12f0286","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:07 INFO - 1501059127723 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
01:52:07 INFO - 1501059127725 Marionette TRACE 396 <- [1,2,null,{}]
01:52:07 INFO - 1501059127727 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:52:07 INFO - 1501059127728 Marionette TRACE 396 <- [1,3,null,{}]
01:52:07 INFO - 1501059127730 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
01:52:07 INFO - 1501059127732 Marionette TRACE 396 <- [1,4,null,{}]
01:52:07 INFO - 1501059127734 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}]
01:52:07 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1501059127741 Marionette TRACE 396 <- [1,5,null,{"value":null}]
01:52:07 INFO - 1501059127743 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - 1501059127747 Marionette TRACE 396 <- [1,6,null,{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - 1501059127751 Marionette DEBUG Closed connection 396
01:52:07 INFO - 1501059127753 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49844
01:52:07 INFO - 1501059127754 Marionette DEBUG Closed connection 397
01:52:07 INFO - 1501059127755 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49845
01:52:07 INFO - 1501059127757 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:52:07 INFO - 1501059127759 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:07 INFO - 1501059127781 Marionette DEBUG Register listener.js for window 4294967297
01:52:07 INFO - 1501059127791 Marionette TRACE 398 <- [1,1,null,{"sessionId":"23ef14f1-b98b-4fd1-ae17-65553d34e829","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:07 INFO - 1501059127794 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - 1501059127798 Marionette TRACE 398 <- [1,2,null,{}]
01:52:07 INFO - [Parent 1144] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:52:07 INFO - 1501059127802 Marionette DEBUG Closed connection 398
01:52:07 INFO - 1501059127804 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49846
01:52:07 INFO - 1501059127805 Marionette DEBUG Closed connection 399
01:52:07 INFO - 1501059127807 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49847
01:52:07 INFO - 1501059127809 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:52:07 INFO - 1501059127811 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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}
01:52:07 INFO - 1501059127832 Marionette DEBUG Register listener.js for window 4294967297
01:52:07 INFO - 1501059127856 Marionette TRACE 400 <- [1,1,null,{"sessionId":"6275d6da-bd4d-44df-9ac2-d0c896666713","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":1144,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-299.001\\AppData\\Local\\Temp\\tmpsrilkf.mozrunner","moz:accessibilityChecks":false}}]
01:52:07 INFO - 1501059127859 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"}]
01:52:07 INFO - 1501059127863 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"
01:52:07 INFO - 1501059127868 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"
01:52:07 INFO - 1501059127868 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"
01:52:07 INFO - ++DOMWINDOW == 23 (000000B057139800) [pid = 56] [serial = 33] [outer = 000000B0453CB800]
01:52:07 INFO - 1501059127890 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"
01:52:07 INFO - 1501059127896 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"
01:52:07 INFO - 1501059127911 Marionette TRACE 400 <- [1,2,null,{}]
01:52:07 INFO - 1501059127925 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
01:52:07 INFO - 1501059127931 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0563abea-1c2c-4a1c-9d40-3a9747cd705e","ELEMENT":"0563abea-1c2c-4a1c-9d40-3a9747cd705e"}}]
01:52:07 INFO - 1501059127933 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0563abea-1c2c-4a1c-9d40-3a9747cd705e"}]
01:52:08 INFO - 1501059128065 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
01:52:08 INFO - 1501059128067 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0563abea-1c2c-4a1c-9d40-3a9747cd705e"}]
01:52:08 INFO - 1501059128202 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element