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]
14:40:19 INFO - 1500932419833 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
14:40:19 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500932419844 Marionette TRACE 352 <- [1,5,null,{"value":null}]
14:40:19 INFO - 1500932419846 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
14:40:19 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:19 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 695ms
14:40:19 INFO - 1500932419851 Marionette TRACE 352 <- [1,6,null,{}]
14:40:19 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
14:40:19 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:19 INFO - 1500932419856 Marionette DEBUG Closed connection 352
14:40:19 INFO - 1500932419857 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49790
14:40:19 INFO - 1500932419859 Marionette DEBUG Closed connection 353
14:40:19 INFO - 1500932419861 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49791
14:40:19 INFO - 1500932419863 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:19 INFO - 1500932419865 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:19 INFO - 1500932419887 Marionette DEBUG Register listener.js for window 4294967297
14:40:19 INFO - 1500932419899 Marionette TRACE 354 <- [1,1,null,{"sessionId":"84b696f2-9a42-4456-bddc-c2cdd8e8533d","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:19 INFO - 1500932419902 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
14:40:19 INFO - 1500932419904 Marionette TRACE 354 <- [1,2,null,{}]
14:40:19 INFO - 1500932419906 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:19 INFO - 1500932419908 Marionette TRACE 354 <- [1,3,null,{}]
14:40:19 INFO - 1500932419910 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:19 INFO - 1500932419912 Marionette TRACE 354 <- [1,4,null,{}]
14:40:19 INFO - 1500932419915 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
14:40:19 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500932419940 Marionette TRACE 354 <- [1,5,null,{"value":null}]
14:40:19 INFO - 1500932419942 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
14:40:19 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:19 INFO - 1500932419947 Marionette TRACE 354 <- [1,6,null,{}]
14:40:19 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:19 INFO - 1500932419952 Marionette DEBUG Closed connection 354
14:40:19 INFO - 1500932419955 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49792
14:40:19 INFO - 1500932419957 Marionette DEBUG Closed connection 355
14:40:19 INFO - 1500932419959 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49793
14:40:19 INFO - 1500932419961 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:19 INFO - 1500932419964 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:19 INFO - 1500932419987 Marionette DEBUG Register listener.js for window 4294967297
14:40:20 INFO - 1500932420014 Marionette TRACE 356 <- [1,1,null,{"sessionId":"2b2cb4c9-c459-48fb-b1bf-2013762e780e","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:20 INFO - 1500932420017 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
14:40:20 INFO - --DOMWINDOW == 17 (0000007F4D9A3800) [pid = 2728] [serial = 9] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
14:40:20 INFO - --DOMWINDOW == 16 (0000007F4E51D000) [pid = 2728] [serial = 10] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
14:40:20 INFO - --DOMWINDOW == 15 (0000007F4DA16000) [pid = 2728] [serial = 11] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
14:40:20 INFO - --DOMWINDOW == 14 (0000007F4E239800) [pid = 2728] [serial = 8] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420022 Marionette TRACE 356 <- [1,2,null,{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420026 Marionette DEBUG Closed connection 356
14:40:20 INFO - 1500932420027 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49794
14:40:20 INFO - 1500932420029 Marionette DEBUG Closed connection 357
14:40:20 INFO - 1500932420030 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49795
14:40:20 INFO - 1500932420032 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:20 INFO - 1500932420035 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:20 INFO - 1500932420056 Marionette DEBUG Register listener.js for window 4294967297
14:40:20 INFO - 1500932420068 Marionette TRACE 358 <- [1,1,null,{"sessionId":"fb1b6e77-594f-4e09-b5a2-242767fc3361","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:20 INFO - 1500932420070 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
14:40:20 INFO - 1500932420075 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
14:40:20 INFO - 1500932420090 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
14:40:20 INFO - 1500932420090 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
14:40:20 INFO - ++DOMWINDOW == 15 (0000007F4D9B7000) [pid = 2728] [serial = 25] [outer = 0000007F43343800]
14:40:20 INFO - 1500932420115 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
14:40:20 INFO - 1500932420126 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
14:40:20 INFO - 1500932420128 Marionette TRACE 358 <- [1,2,null,{}]
14:40:20 INFO - 1500932420141 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
14:40:20 INFO - 1500932420154 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b6afce3f-7455-481b-9382-cc37ae71ed4f","ELEMENT":"b6afce3f-7455-481b-9382-cc37ae71ed4f"}}]
14:40:20 INFO - 1500932420156 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"b6afce3f-7455-481b-9382-cc37ae71ed4f"}]
14:40:20 INFO - 1500932420377 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
14:40:20 INFO - 1500932420395 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
14:40:20 INFO - 1500932420396 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
14:40:20 INFO - ++DOMWINDOW == 16 (0000007F4DA20000) [pid = 2728] [serial = 26] [outer = 0000007F43343800]
14:40:20 INFO - 1500932420426 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
14:40:20 INFO - 1500932420431 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
14:40:20 INFO - 1500932420441 Marionette TRACE 358 <- [1,4,null,{}]
14:40:20 INFO - 1500932420457 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
14:40:20 INFO - 1500932420463 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"24350545-5726-46c9-9714-57ac638c7013","ELEMENT":"24350545-5726-46c9-9714-57ac638c7013"}}]
14:40:20 INFO - 1500932420466 Marionette TRACE 358 -> [0,6,"getTitle",{}]
14:40:20 INFO - 1500932420467 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
14:40:20 INFO - 1500932420469 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
14:40:20 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500932420477 Marionette TRACE 358 <- [1,7,null,{"value":null}]
14:40:20 INFO - 1500932420478 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420483 Marionette TRACE 358 <- [1,8,null,{}]
14:40:20 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 632ms
14:40:20 INFO - TEST-START | test_click.py TestClick.test_container_element
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420488 Marionette DEBUG Closed connection 358
14:40:20 INFO - 1500932420489 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49798
14:40:20 INFO - 1500932420491 Marionette DEBUG Closed connection 359
14:40:20 INFO - 1500932420492 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49799
14:40:20 INFO - 1500932420494 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:20 INFO - 1500932420497 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:20 INFO - 1500932420519 Marionette DEBUG Register listener.js for window 4294967297
14:40:20 INFO - 1500932420530 Marionette TRACE 360 <- [1,1,null,{"sessionId":"9fab756e-d1c4-4d46-93fe-53acdc716017","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:20 INFO - 1500932420533 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
14:40:20 INFO - 1500932420534 Marionette TRACE 360 <- [1,2,null,{}]
14:40:20 INFO - 1500932420536 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:20 INFO - 1500932420537 Marionette TRACE 360 <- [1,3,null,{}]
14:40:20 INFO - 1500932420539 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:20 INFO - 1500932420541 Marionette TRACE 360 <- [1,4,null,{}]
14:40:20 INFO - 1500932420543 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
14:40:20 INFO - TEST-START: test_click.py TestClick.test_container_element1500932420551 Marionette TRACE 360 <- [1,5,null,{"value":null}]
14:40:20 INFO - 1500932420552 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420557 Marionette TRACE 360 <- [1,6,null,{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420561 Marionette DEBUG Closed connection 360
14:40:20 INFO - 1500932420562 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49800
14:40:20 INFO - 1500932420564 Marionette DEBUG Closed connection 361
14:40:20 INFO - 1500932420565 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49801
14:40:20 INFO - 1500932420568 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:20 INFO - 1500932420570 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:20 INFO - 1500932420591 Marionette DEBUG Register listener.js for window 4294967297
14:40:20 INFO - 1500932420603 Marionette TRACE 362 <- [1,1,null,{"sessionId":"abbeef39-a6c0-42a8-8170-66c9dfd28550","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:20 INFO - 1500932420606 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420610 Marionette TRACE 362 <- [1,2,null,{}]
14:40:20 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:20 INFO - 1500932420614 Marionette DEBUG Closed connection 362
14:40:20 INFO - 1500932420615 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49802
14:40:20 INFO - 1500932420617 Marionette DEBUG Closed connection 363
14:40:20 INFO - 1500932420618 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49803
14:40:20 INFO - 1500932420621 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:20 INFO - 1500932420623 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:20 INFO - 1500932420644 Marionette DEBUG Register listener.js for window 4294967297
14:40:20 INFO - 1500932420656 Marionette TRACE 364 <- [1,1,null,{"sessionId":"6a5816b3-f903-4db4-98af-5e94fb8ca4c8","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:20 INFO - 1500932420659 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
14:40:20 INFO - 1500932420663 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
14:40:20 INFO - 1500932420668 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
14:40:20 INFO - 1500932420669 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
14:40:20 INFO - ++DOMWINDOW == 17 (0000007F52509000) [pid = 2728] [serial = 27] [outer = 0000007F43343800]
14:40:20 INFO - 1500932420691 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:20 INFO - 1500932420698 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:20 INFO - 1500932420723 Marionette TRACE 364 <- [1,2,null,{}]
14:40:20 INFO - 1500932420742 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:40:20 INFO - 1500932420750 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"80cfc9ae-c593-42d4-a012-05868c04e501","ELEMENT":"80cfc9ae-c593-42d4-a012-05868c04e501"}}]
14:40:20 INFO - 1500932420752 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"80cfc9ae-c593-42d4-a012-05868c04e501"}]
14:40:20 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
14:40:20 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
14:40:20 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
14:40:21 INFO - 1500932421178 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:40:21 INFO - 1500932421180 Marionette TRACE 364 <- [1,4,null,{}]
14:40:21 INFO - 1500932421182 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"80cfc9ae-c593-42d4-a012-05868c04e501","name":"selected"}]
14:40:21 INFO - 1500932421209 Marionette TRACE 364 <- [1,5,null,{"value":true}]
14:40:21 INFO - 1500932421212 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
14:40:21 INFO - TEST-END: test_click.py TestClick.test_container_element1500932421219 Marionette TRACE 364 <- [1,6,null,{"value":null}]
14:40:21 INFO - 1500932421221 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421225 Marionette TRACE 364 <- [1,7,null,{}]
14:40:21 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 741ms
14:40:21 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421229 Marionette DEBUG Closed connection 364
14:40:21 INFO - 1500932421231 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49804
14:40:21 INFO - 1500932421232 Marionette DEBUG Closed connection 365
14:40:21 INFO - 1500932421234 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49805
14:40:21 INFO - 1500932421236 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:21 INFO - 1500932421238 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:21 INFO - 1500932421260 Marionette DEBUG Register listener.js for window 4294967297
14:40:21 INFO - 1500932421272 Marionette TRACE 366 <- [1,1,null,{"sessionId":"16a4fa4f-70d6-4af4-8e0f-1905a007ee49","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:21 INFO - 1500932421275 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
14:40:21 INFO - 1500932421277 Marionette TRACE 366 <- [1,2,null,{}]
14:40:21 INFO - 1500932421278 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:21 INFO - 1500932421280 Marionette TRACE 366 <- [1,3,null,{}]
14:40:21 INFO - 1500932421282 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:21 INFO - 1500932421283 Marionette TRACE 366 <- [1,4,null,{}]
14:40:21 INFO - 1500932421286 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
14:40:21 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500932421293 Marionette TRACE 366 <- [1,5,null,{"value":null}]
14:40:21 INFO - 1500932421295 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421300 Marionette TRACE 366 <- [1,6,null,{}]
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421304 Marionette DEBUG Closed connection 366
14:40:21 INFO - 1500932421306 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49806
14:40:21 INFO - 1500932421307 Marionette DEBUG Closed connection 367
14:40:21 INFO - 1500932421309 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49807
14:40:21 INFO - 1500932421311 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:21 INFO - 1500932421313 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:21 INFO - 1500932421731 Marionette DEBUG Register listener.js for window 4294967297
14:40:21 INFO - 1500932421743 Marionette TRACE 368 <- [1,1,null,{"sessionId":"eaae2c43-8431-433e-84b0-90ae53a0fe56","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:21 INFO - 1500932421746 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421750 Marionette TRACE 368 <- [1,2,null,{}]
14:40:21 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:21 INFO - 1500932421755 Marionette DEBUG Closed connection 368
14:40:21 INFO - 1500932421756 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49808
14:40:21 INFO - 1500932421758 Marionette DEBUG Closed connection 369
14:40:21 INFO - 1500932421759 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49809
14:40:21 INFO - 1500932421761 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:21 INFO - 1500932421764 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:21 INFO - 1500932421800 Marionette DEBUG Register listener.js for window 4294967297
14:40:21 INFO - 1500932421810 Marionette TRACE 370 <- [1,1,null,{"sessionId":"30cc4744-425e-4fb3-ac42-a2aeb49f1700","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:21 INFO - 1500932421813 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
14:40:21 INFO - 1500932421862 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:21 INFO - 1500932421867 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:21 INFO - 1500932421867 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:21 INFO - ++DOMWINDOW == 18 (0000007F52519800) [pid = 2728] [serial = 28] [outer = 0000007F43343800]
14:40:21 INFO - 1500932421892 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:21 INFO - 1500932421896 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:21 INFO - 1500932421905 Marionette TRACE 370 <- [1,2,null,{}]
14:40:21 INFO - 1500932421922 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
14:40:21 INFO - 1500932421947 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"65343e15-e623-4976-bab2-bd839772a1d0","ELEMENT":"65343e15-e623-4976-bab2-bd839772a1d0"}}]
14:40:21 INFO - 1500932421949 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"65343e15-e623-4976-bab2-bd839772a1d0"}]
14:40:22 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
14:40:22 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
14:40:22 INFO - [Child 2728] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
14:40:22 INFO - 1500932422387 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:40:22 INFO - 1500932422389 Marionette TRACE 370 <- [1,4,null,{}]
14:40:22 INFO - 1500932422392 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"65343e15-e623-4976-bab2-bd839772a1d0","name":"selected"}]
14:40:22 INFO - 1500932422419 Marionette TRACE 370 <- [1,5,null,{"value":true}]
14:40:22 INFO - 1500932422422 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
14:40:22 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500932422430 Marionette TRACE 370 <- [1,6,null,{"value":null}]
14:40:22 INFO - 1500932422432 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1210ms
14:40:22 INFO - 1500932422436 Marionette TRACE 370 <- [1,7,null,{}]
14:40:22 INFO - TEST-START | test_click.py TestClick.test_css_transforms
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - 1500932422440 Marionette DEBUG Closed connection 370
14:40:22 INFO - 1500932422442 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49810
14:40:22 INFO - 1500932422443 Marionette DEBUG Closed connection 371
14:40:22 INFO - 1500932422445 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49811
14:40:22 INFO - 1500932422447 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:22 INFO - 1500932422449 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:22 INFO - 1500932422471 Marionette DEBUG Register listener.js for window 4294967297
14:40:22 INFO - 1500932422482 Marionette TRACE 372 <- [1,1,null,{"sessionId":"dc52445a-4d1d-4b7c-b6b9-76c7d2e1288e","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:22 INFO - 1500932422485 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
14:40:22 INFO - 1500932422486 Marionette TRACE 372 <- [1,2,null,{}]
14:40:22 INFO - 1500932422488 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:22 INFO - 1500932422490 Marionette TRACE 372 <- [1,3,null,{}]
14:40:22 INFO - 1500932422491 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:22 INFO - 1500932422493 Marionette TRACE 372 <- [1,4,null,{}]
14:40:22 INFO - 1500932422495 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
14:40:22 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500932422508 Marionette TRACE 372 <- [1,5,null,{"value":null}]
14:40:22 INFO - 1500932422510 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - 1500932422514 Marionette TRACE 372 <- [1,6,null,{}]
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - 1500932422518 Marionette DEBUG Closed connection 372
14:40:22 INFO - 1500932422519 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49812
14:40:22 INFO - 1500932422521 Marionette DEBUG Closed connection 373
14:40:22 INFO - 1500932422522 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49813
14:40:22 INFO - 1500932422524 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:22 INFO - 1500932422527 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:22 INFO - 1500932422548 Marionette DEBUG Register listener.js for window 4294967297
14:40:22 INFO - 1500932422559 Marionette TRACE 374 <- [1,1,null,{"sessionId":"f8d7d234-a45c-44c6-8a38-326fcae4dab8","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:22 INFO - 1500932422562 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - 1500932422566 Marionette TRACE 374 <- [1,2,null,{}]
14:40:22 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:22 INFO - 1500932422570 Marionette DEBUG Closed connection 374
14:40:22 INFO - 1500932422572 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49814
14:40:22 INFO - 1500932422573 Marionette DEBUG Closed connection 375
14:40:22 INFO - 1500932422574 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49815
14:40:22 INFO - 1500932422576 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:22 INFO - 1500932422579 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:22 INFO - 1500932422601 Marionette DEBUG Register listener.js for window 4294967297
14:40:22 INFO - 1500932422612 Marionette TRACE 376 <- [1,1,null,{"sessionId":"421d6d3f-4071-4e28-8208-70d3c1808b43","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:22 INFO - 1500932422615 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
14:40:22 INFO - 1500932422629 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:22 INFO - 1500932422634 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:22 INFO - 1500932422634 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:22 INFO - ++DOMWINDOW == 19 (0000007F5172E000) [pid = 2728] [serial = 29] [outer = 0000007F43343800]
14:40:22 INFO - 1500932422658 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
14:40:22 INFO - 1500932422663 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
14:40:22 INFO - 1500932422676 Marionette TRACE 376 <- [1,2,null,{}]
14:40:22 INFO - 1500932422691 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
14:40:22 INFO - 1500932422697 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4ad1f460-38a9-4c19-9926-3718db0607fa","ELEMENT":"4ad1f460-38a9-4c19-9926-3718db0607fa"}}]
14:40:22 INFO - 1500932422699 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"4ad1f460-38a9-4c19-9926-3718db0607fa"}]
14:40:23 INFO - 1500932423127 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:40:23 INFO - 1500932423129 Marionette TRACE 376 <- [1,4,null,{}]
14:40:23 INFO - 1500932423134 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
14:40:23 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500932423142 Marionette TRACE 376 <- [1,5,null,{"value":null}]
14:40:23 INFO - 1500932423144 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
14:40:23 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 710ms
14:40:23 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423148 Marionette TRACE 376 <- [1,6,null,{}]
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423152 Marionette DEBUG Closed connection 376
14:40:23 INFO - 1500932423154 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49816
14:40:23 INFO - 1500932423155 Marionette DEBUG Closed connection 377
14:40:23 INFO - 1500932423156 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49817
14:40:23 INFO - 1500932423158 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:23 INFO - 1500932423161 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:23 INFO - 1500932423182 Marionette DEBUG Register listener.js for window 4294967297
14:40:23 INFO - 1500932423194 Marionette TRACE 378 <- [1,1,null,{"sessionId":"ce49b383-4656-49bf-91db-5247bc4bf35a","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:23 INFO - 1500932423197 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
14:40:23 INFO - 1500932423198 Marionette TRACE 378 <- [1,2,null,{}]
14:40:23 INFO - 1500932423200 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:23 INFO - 1500932423202 Marionette TRACE 378 <- [1,3,null,{}]
14:40:23 INFO - 1500932423203 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:23 INFO - 1500932423205 Marionette TRACE 378 <- [1,4,null,{}]
14:40:23 INFO - 1500932423208 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
14:40:23 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500932423215 Marionette TRACE 378 <- [1,5,null,{"value":null}]
14:40:23 INFO - 1500932423217 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423221 Marionette TRACE 378 <- [1,6,null,{}]
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423225 Marionette DEBUG Closed connection 378
14:40:23 INFO - 1500932423227 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49818
14:40:23 INFO - 1500932423228 Marionette DEBUG Closed connection 379
14:40:23 INFO - 1500932423230 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49819
14:40:23 INFO - 1500932423232 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:23 INFO - 1500932423235 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:23 INFO - 1500932423257 Marionette DEBUG Register listener.js for window 4294967297
14:40:23 INFO - 1500932423268 Marionette TRACE 380 <- [1,1,null,{"sessionId":"b074c9d7-2f36-479f-b06b-7eab67cf2da0","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:23 INFO - 1500932423271 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423275 Marionette TRACE 380 <- [1,2,null,{}]
14:40:23 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:23 INFO - 1500932423279 Marionette DEBUG Closed connection 380
14:40:23 INFO - 1500932423281 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49820
14:40:23 INFO - 1500932423282 Marionette DEBUG Closed connection 381
14:40:23 INFO - 1500932423284 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49821
14:40:23 INFO - 1500932423286 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:23 INFO - 1500932423289 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:23 INFO - 1500932423586 Marionette DEBUG Register listener.js for window 4294967297
14:40:23 INFO - 1500932423597 Marionette TRACE 382 <- [1,1,null,{"sessionId":"5dffe438-3374-45f6-9a8a-2d4607e7e93d","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:23 INFO - 1500932423600 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
14:40:23 INFO - 1500932423653 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
14:40:23 INFO - 1500932423658 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
14:40:23 INFO - 1500932423658 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
14:40:23 INFO - ++DOMWINDOW == 20 (0000007F519CB800) [pid = 2728] [serial = 30] [outer = 0000007F43343800]
14:40:23 INFO - 1500932423684 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:23 INFO - 1500932423688 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:23 INFO - 1500932423698 Marionette TRACE 382 <- [1,2,null,{}]
14:40:23 INFO - 1500932423713 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
14:40:23 INFO - 1500932423721 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"283cb9a0-f7de-45d9-a75d-02f8af451626","ELEMENT":"283cb9a0-f7de-45d9-a75d-02f8af451626"}}]
14:40:23 INFO - 1500932423723 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"283cb9a0-f7de-45d9-a75d-02f8af451626"}]
14:40:24 INFO - 1500932424215 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:40:24 INFO - 1500932424406 Marionette TRACE 382 <- [1,4,null,{}]
14:40:24 INFO - 1500932424411 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
14:40:24 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500932424419 Marionette TRACE 382 <- [1,5,null,{"value":null}]
14:40:24 INFO - 1500932424421 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424425 Marionette TRACE 382 <- [1,6,null,{}]
14:40:24 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1277ms
14:40:24 INFO - TEST-START | test_click.py TestClick.test_input_file
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424429 Marionette DEBUG Closed connection 382
14:40:24 INFO - 1500932424431 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49822
14:40:24 INFO - 1500932424432 Marionette DEBUG Closed connection 383
14:40:24 INFO - 1500932424434 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49823
14:40:24 INFO - 1500932424436 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:24 INFO - 1500932424438 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:24 INFO - 1500932424460 Marionette DEBUG Register listener.js for window 4294967297
14:40:24 INFO - 1500932424485 Marionette TRACE 384 <- [1,1,null,{"sessionId":"88af3a78-c11a-44c1-911e-97476138fd58","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:24 INFO - 1500932424488 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
14:40:24 INFO - 1500932424489 Marionette TRACE 384 <- [1,2,null,{}]
14:40:24 INFO - 1500932424491 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:24 INFO - 1500932424493 Marionette TRACE 384 <- [1,3,null,{}]
14:40:24 INFO - 1500932424496 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:24 INFO - 1500932424497 Marionette TRACE 384 <- [1,4,null,{}]
14:40:24 INFO - 1500932424501 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
14:40:24 INFO - TEST-START: test_click.py TestClick.test_input_file1500932424508 Marionette TRACE 384 <- [1,5,null,{"value":null}]
14:40:24 INFO - 1500932424510 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424515 Marionette TRACE 384 <- [1,6,null,{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424519 Marionette DEBUG Closed connection 384
14:40:24 INFO - 1500932424520 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49824
14:40:24 INFO - 1500932424522 Marionette DEBUG Closed connection 385
14:40:24 INFO - 1500932424523 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49825
14:40:24 INFO - 1500932424525 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:24 INFO - 1500932424527 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:24 INFO - 1500932424550 Marionette DEBUG Register listener.js for window 4294967297
14:40:24 INFO - 1500932424561 Marionette TRACE 386 <- [1,1,null,{"sessionId":"4d5ba9aa-2d3f-4269-af04-8e515728b549","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:24 INFO - 1500932424564 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424569 Marionette TRACE 386 <- [1,2,null,{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424574 Marionette DEBUG Closed connection 386
14:40:24 INFO - 1500932424576 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49826
14:40:24 INFO - 1500932424578 Marionette DEBUG Closed connection 387
14:40:24 INFO - 1500932424580 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49827
14:40:24 INFO - 1500932424582 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:24 INFO - 1500932424585 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:24 INFO - 1500932424609 Marionette DEBUG Register listener.js for window 4294967297
14:40:24 INFO - 1500932424620 Marionette TRACE 388 <- [1,1,null,{"sessionId":"6889cfd5-1c4a-447c-a019-241d695ab572","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:24 INFO - 1500932424623 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
14:40:24 INFO - 1500932424627 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:24 INFO - 1500932424632 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:24 INFO - 1500932424633 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
14:40:24 INFO - ++DOMWINDOW == 21 (0000007F524C0800) [pid = 2728] [serial = 31] [outer = 0000007F43343800]
14:40:24 INFO - 1500932424660 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:40:24 INFO - 1500932424664 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:40:24 INFO - 1500932424670 Marionette TRACE 388 <- [1,2,null,{}]
14:40:24 INFO - 1500932424678 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
14:40:24 INFO - 1500932424691 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8cf802c0-8c70-473a-aa2f-e0da191be0d6","ELEMENT":"8cf802c0-8c70-473a-aa2f-e0da191be0d6"}}]
14:40:24 INFO - 1500932424693 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"8cf802c0-8c70-473a-aa2f-e0da191be0d6"}]
14:40:24 INFO - 1500932424842 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]
14:40:24 INFO - 1500932424845 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
14:40:24 INFO - TEST-END: test_click.py TestClick.test_input_file1500932424852 Marionette TRACE 388 <- [1,5,null,{"value":null}]
14:40:24 INFO - 1500932424854 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 435ms
14:40:24 INFO - TEST-START | test_click.py TestClick.test_obscured_element
14:40:24 INFO - 1500932424859 Marionette TRACE 388 <- [1,6,null,{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424863 Marionette DEBUG Closed connection 388
14:40:24 INFO - 1500932424864 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49828
14:40:24 INFO - 1500932424866 Marionette DEBUG Closed connection 389
14:40:24 INFO - 1500932424867 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49829
14:40:24 INFO - 1500932424869 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:24 INFO - 1500932424871 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:24 INFO - 1500932424894 Marionette DEBUG Register listener.js for window 4294967297
14:40:24 INFO - 1500932424905 Marionette TRACE 390 <- [1,1,null,{"sessionId":"8ef76cdc-f0d4-4da8-96ba-1dd122f59c11","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:24 INFO - 1500932424908 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
14:40:24 INFO - 1500932424909 Marionette TRACE 390 <- [1,2,null,{}]
14:40:24 INFO - 1500932424911 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:24 INFO - 1500932424913 Marionette TRACE 390 <- [1,3,null,{}]
14:40:24 INFO - 1500932424915 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:24 INFO - 1500932424916 Marionette TRACE 390 <- [1,4,null,{}]
14:40:24 INFO - 1500932424918 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
14:40:24 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500932424926 Marionette TRACE 390 <- [1,5,null,{"value":null}]
14:40:24 INFO - 1500932424928 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424932 Marionette TRACE 390 <- [1,6,null,{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424936 Marionette DEBUG Closed connection 390
14:40:24 INFO - 1500932424938 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49830
14:40:24 INFO - 1500932424939 Marionette DEBUG Closed connection 391
14:40:24 INFO - 1500932424941 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49831
14:40:24 INFO - 1500932424943 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:24 INFO - 1500932424945 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:24 INFO - 1500932424968 Marionette DEBUG Register listener.js for window 4294967297
14:40:24 INFO - 1500932424978 Marionette TRACE 392 <- [1,1,null,{"sessionId":"56a3791c-6321-4fef-902c-17006f4aba34","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:24 INFO - 1500932424981 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424986 Marionette TRACE 392 <- [1,2,null,{}]
14:40:24 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:24 INFO - 1500932424990 Marionette DEBUG Closed connection 392
14:40:24 INFO - 1500932424991 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49832
14:40:24 INFO - 1500932424993 Marionette DEBUG Closed connection 393
14:40:24 INFO - 1500932424994 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49833
14:40:24 INFO - 1500932424997 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:25 INFO - 1500932424999 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:25 INFO - 1500932425022 Marionette DEBUG Register listener.js for window 4294967297
14:40:25 INFO - 1500932425033 Marionette TRACE 394 <- [1,1,null,{"sessionId":"cf07aec1-4c0b-4335-980b-8d3cab40776c","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:25 INFO - 1500932425036 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
14:40:25 INFO - 1500932425040 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:40:25 INFO - 1500932425046 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:40:25 INFO - 1500932425047 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
14:40:25 INFO - ++DOMWINDOW == 22 (0000007F52513800) [pid = 2728] [serial = 32] [outer = 0000007F43343800]
14:40:25 INFO - 1500932425071 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
14:40:25 INFO - 1500932425077 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
14:40:25 INFO - 1500932425083 Marionette TRACE 394 <- [1,2,null,{}]
14:40:25 INFO - 1500932425099 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
14:40:25 INFO - 1500932425105 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"902d7c0d-1b5d-4e99-888d-26f767812c14","ELEMENT":"902d7c0d-1b5d-4e99-888d-26f767812c14"}}]
14:40:25 INFO - 1500932425107 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
14:40:25 INFO - 1500932425113 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"13bc8af8-1674-4c4d-906f-c42c609198ca","ELEMENT":"13bc8af8-1674-4c4d-906f-c42c609198ca"}}]
14:40:25 INFO - 1500932425114 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"902d7c0d-1b5d-4e99-888d-26f767812c14"}]
14:40:25 INFO - 1500932425547 Marionette DEBUG Canceled page load listener because no navigation has been detected
14:40:25 INFO - 1500932425549 Marionette TRACE 394 <- [1,5,null,{}]
14:40:25 INFO - 1500932425551 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"13bc8af8-1674-4c4d-906f-c42c609198ca"}]
14:40:25 INFO - 1500932425678 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]
14:40:25 INFO - 1500932425681 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
14:40:25 INFO - 1500932425688 Marionette TRACE 394 <- [1,7,null,{"value":false}]
14:40:25 INFO - 1500932425690 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
14:40:25 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500932425697 Marionette TRACE 394 <- [1,8,null,{"value":null}]
14:40:25 INFO - 1500932425699 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
14:40:25 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 843ms
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425703 Marionette TRACE 394 <- [1,9,null,{}]
14:40:25 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425707 Marionette DEBUG Closed connection 394
14:40:25 INFO - 1500932425708 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49834
14:40:25 INFO - 1500932425710 Marionette DEBUG Closed connection 395
14:40:25 INFO - 1500932425711 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49835
14:40:25 INFO - 1500932425713 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:25 INFO - 1500932425716 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:25 INFO - 1500932425748 Marionette DEBUG Register listener.js for window 4294967297
14:40:25 INFO - 1500932425759 Marionette TRACE 396 <- [1,1,null,{"sessionId":"37d81533-1361-43a3-bb31-eb0d9875721d","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:25 INFO - 1500932425762 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
14:40:25 INFO - 1500932425764 Marionette TRACE 396 <- [1,2,null,{}]
14:40:25 INFO - 1500932425766 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
14:40:25 INFO - 1500932425767 Marionette TRACE 396 <- [1,3,null,{}]
14:40:25 INFO - 1500932425769 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
14:40:25 INFO - 1500932425770 Marionette TRACE 396 <- [1,4,null,{}]
14:40:25 INFO - 1500932425773 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
14:40:25 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500932425780 Marionette TRACE 396 <- [1,5,null,{"value":null}]
14:40:25 INFO - 1500932425782 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425786 Marionette TRACE 396 <- [1,6,null,{}]
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425790 Marionette DEBUG Closed connection 396
14:40:25 INFO - 1500932425792 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49836
14:40:25 INFO - 1500932425793 Marionette DEBUG Closed connection 397
14:40:25 INFO - 1500932425795 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49837
14:40:25 INFO - 1500932425797 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
14:40:25 INFO - 1500932425799 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:25 INFO - 1500932425822 Marionette DEBUG Register listener.js for window 4294967297
14:40:25 INFO - 1500932425834 Marionette TRACE 398 <- [1,1,null,{"sessionId":"42d2e91b-3ecf-496d-9a62-4a6e8236acfd","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:25 INFO - 1500932425837 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425841 Marionette TRACE 398 <- [1,2,null,{}]
14:40:25 INFO - [Parent 2700] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/pine-w64-d-0000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
14:40:25 INFO - 1500932425845 Marionette DEBUG Closed connection 398
14:40:25 INFO - 1500932425846 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49838
14:40:25 INFO - 1500932425848 Marionette DEBUG Closed connection 399
14:40:25 INFO - 1500932425849 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49839
14:40:25 INFO - 1500932425852 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
14:40:25 INFO - 1500932425854 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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}
14:40:25 INFO - 1500932425877 Marionette DEBUG Register listener.js for window 4294967297
14:40:25 INFO - 1500932425888 Marionette TRACE 400 <- [1,1,null,{"sessionId":"4a02e884-f410-4e9d-a8cc-9a227aa26a7b","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":2700,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-027.001\\AppData\\Local\\Temp\\tmpoknkvv.mozrunner","moz:accessibilityChecks":false}}]
14:40:25 INFO - 1500932425891 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
14:40:25 INFO - 1500932425895 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
14:40:25 INFO - 1500932425899 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
14:40:25 INFO - 1500932425900 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
14:40:25 INFO - ++DOMWINDOW == 23 (0000007F4FA2B800) [pid = 2728] [serial = 33] [outer = 0000007F43343800]
14:40:25 INFO - 1500932425925 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
14:40:25 INFO - 1500932425929 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
14:40:25 INFO - 1500932425943 Marionette TRACE 400 <- [1,2,null,{}]
14:40:25 INFO - 1500932425958 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
14:40:25 INFO - 1500932425964 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7173e370-075f-4cf0-a820-2c5454cea976","ELEMENT":"7173e370-075f-4cf0-a820-2c5454cea976"}}]
14:40:25 INFO - 1500932425966 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"7173e370-075f-4cf0-a820-2c5454cea976"}]
14:40:26 INFO - 1500932426092 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
14:40:26 INFO - 1500932426094 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"7173e370-075f-4cf0-a820-2c5454cea976"}]
14:40:26 INFO - 1500932426232 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element