could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
08:43:36 INFO - 1500219816429 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}]
08:43:36 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500219816440 Marionette TRACE 352 <- [1,5,null,{"value":null}]
08:43:36 INFO - 1500219816463 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816469 Marionette TRACE 352 <- [1,6,null,{}]
08:43:36 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 935ms
08:43:36 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816476 Marionette DEBUG Closed connection 352
08:43:36 INFO - 1500219816479 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49813
08:43:36 INFO - 1500219816531 Marionette DEBUG Closed connection 353
08:43:36 INFO - 1500219816534 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49814
08:43:36 INFO - 1500219816553 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:36 INFO - 1500219816560 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:36 INFO - 1500219816597 Marionette DEBUG Register listener.js for window 15
08:43:36 INFO - 1500219816614 Marionette TRACE 354 <- [1,1,null,{"sessionId":"c6a32081-b8ca-42e9-9cde-cb1b93642271","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:36 INFO - 1500219816625 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
08:43:36 INFO - 1500219816627 Marionette TRACE 354 <- [1,2,null,{}]
08:43:36 INFO - 1500219816654 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:36 INFO - 1500219816657 Marionette TRACE 354 <- [1,3,null,{}]
08:43:36 INFO - 1500219816659 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:36 INFO - 1500219816661 Marionette TRACE 354 <- [1,4,null,{}]
08:43:36 INFO - 1500219816664 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}]
08:43:36 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500219816677 Marionette TRACE 354 <- [1,5,null,{"value":null}]
08:43:36 INFO - 1500219816753 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816759 Marionette TRACE 354 <- [1,6,null,{}]
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816782 Marionette DEBUG Closed connection 354
08:43:36 INFO - 1500219816786 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49815
08:43:36 INFO - 1500219816794 Marionette DEBUG Closed connection 355
08:43:36 INFO - 1500219816797 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49816
08:43:36 INFO - 1500219816802 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:36 INFO - 1500219816805 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:36 INFO - 1500219816844 Marionette DEBUG Register listener.js for window 15
08:43:36 INFO - 1500219816860 Marionette TRACE 356 <- [1,1,null,{"sessionId":"80280268-d174-4f1c-87da-94ac4448f56c","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:36 INFO - 1500219816870 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816876 Marionette TRACE 356 <- [1,2,null,{}]
08:43:36 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:36 INFO - 1500219816911 Marionette DEBUG Closed connection 356
08:43:36 INFO - 1500219816916 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49817
08:43:36 INFO - 1500219816936 Marionette DEBUG Closed connection 357
08:43:36 INFO - 1500219816938 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49818
08:43:36 INFO - 1500219816941 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:36 INFO - 1500219816944 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:36 INFO - 1500219816984 Marionette DEBUG Register listener.js for window 15
08:43:37 INFO - 1500219816997 Marionette TRACE 358 <- [1,1,null,{"sessionId":"e40f0c15-944b-48cf-a17d-2aa16a79d28c","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:37 INFO - 1500219817163 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49352/clicks.html"}]
08:43:37 INFO - 1500219817172 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49352/hidden.html"
08:43:37 INFO - 1500219817196 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49352/hidden.html"
08:43:37 INFO - 1500219817197 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49352/hidden.html"
08:43:37 INFO - ++DOMWINDOW == 22 (000000546C806000) [pid = 2792] [serial = 40] [outer = 0000005474EBD800]
08:43:37 INFO - 1500219817262 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49352/clicks.html"
08:43:37 INFO - 1500219817270 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49352/clicks.html"
08:43:37 INFO - 1500219817305 Marionette TRACE 358 <- [1,2,null,{}]
08:43:37 INFO - 1500219817314 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
08:43:37 INFO - 1500219817326 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"564e70c5-0dd0-41cc-90ec-88310003c04b","ELEMENT":"564e70c5-0dd0-41cc-90ec-88310003c04b"}}]
08:43:37 INFO - 1500219817331 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"564e70c5-0dd0-41cc-90ec-88310003c04b"}]
08:43:37 INFO - 1500219817553 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49352/clicks.html"
08:43:37 INFO - [Parent 2792] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
08:43:37 INFO - 1500219817567 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49352/clicks.html"
08:43:37 INFO - 1500219817569 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49352/clicks.html"
08:43:37 INFO - ++DOMWINDOW == 23 (000000546E721800) [pid = 2792] [serial = 41] [outer = 0000005474EBD800]
08:43:37 INFO - 1500219817642 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49352/test.html"
08:43:37 INFO - 1500219817647 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49352/test.html"
08:43:37 INFO - 1500219817667 Marionette TRACE 358 <- [1,4,null,{}]
08:43:37 INFO - 1500219817719 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
08:43:37 INFO - 1500219817729 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"368aa17f-a90b-44ea-8ac8-d446a9bcd599","ELEMENT":"368aa17f-a90b-44ea-8ac8-d446a9bcd599"}}]
08:43:37 INFO - 1500219817738 Marionette TRACE 358 -> [0,6,"getTitle",{}]
08:43:37 INFO - 1500219817740 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
08:43:37 INFO - 1500219817745 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}]
08:43:37 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500219817757 Marionette TRACE 358 <- [1,7,null,{"value":null}]
08:43:37 INFO - 1500219817760 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
08:43:37 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:37 INFO - 1500219817768 Marionette TRACE 358 <- [1,8,null,{}]
08:43:37 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1298ms
08:43:37 INFO - TEST-START | test_click.py TestClick.test_container_element
08:43:37 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:37 INFO - 1500219817777 Marionette DEBUG Closed connection 358
08:43:37 INFO - 1500219817779 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49821
08:43:37 INFO - 1500219817782 Marionette DEBUG Closed connection 359
08:43:37 INFO - 1500219817784 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49822
08:43:37 INFO - 1500219817787 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:37 INFO - 1500219817796 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:37 INFO - 1500219817820 Marionette DEBUG Register listener.js for window 15
08:43:37 INFO - 1500219817849 Marionette TRACE 360 <- [1,1,null,{"sessionId":"782ae905-5197-4730-8d38-410c54c07f98","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:37 INFO - 1500219817862 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
08:43:37 INFO - 1500219817864 Marionette TRACE 360 <- [1,2,null,{}]
08:43:37 INFO - 1500219817868 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:37 INFO - 1500219817870 Marionette TRACE 360 <- [1,3,null,{}]
08:43:37 INFO - 1500219817901 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:37 INFO - 1500219817906 Marionette TRACE 360 <- [1,4,null,{}]
08:43:37 INFO - 1500219817941 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}]
08:43:37 INFO - TEST-START: test_click.py TestClick.test_container_element1500219817951 Marionette TRACE 360 <- [1,5,null,{"value":null}]
08:43:37 INFO - 1500219817956 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
08:43:37 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:37 INFO - 1500219817962 Marionette TRACE 360 <- [1,6,null,{}]
08:43:37 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:37 INFO - 1500219817988 Marionette DEBUG Closed connection 360
08:43:37 INFO - 1500219817991 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49823
08:43:37 INFO - 1500219817993 Marionette DEBUG Closed connection 361
08:43:37 INFO - 1500219817995 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49824
08:43:38 INFO - 1500219818000 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:38 INFO - 1500219818003 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:38 INFO - 1500219818025 Marionette DEBUG Register listener.js for window 15
08:43:38 INFO - 1500219818041 Marionette TRACE 362 <- [1,1,null,{"sessionId":"8f80449a-7db8-4aa1-ae84-1aa6e1528382","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:38 INFO - 1500219818048 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
08:43:38 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:38 INFO - 1500219818054 Marionette TRACE 362 <- [1,2,null,{}]
08:43:38 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:38 INFO - 1500219818060 Marionette DEBUG Closed connection 362
08:43:38 INFO - 1500219818062 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49825
08:43:38 INFO - 1500219818065 Marionette DEBUG Closed connection 363
08:43:38 INFO - 1500219818070 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49826
08:43:38 INFO - 1500219818073 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:38 INFO - 1500219818076 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:38 INFO - 1500219818098 Marionette DEBUG Register listener.js for window 15
08:43:38 INFO - 1500219818113 Marionette TRACE 364 <- [1,1,null,{"sessionId":"159985df-78d8-47cf-8a2e-7d3d340373a6","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:38 INFO - 1500219818148 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"}]
08:43:38 INFO - 1500219818152 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49352/test.html"
08:43:38 INFO - 1500219818159 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49352/test.html"
08:43:38 INFO - 1500219818160 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49352/test.html"
08:43:38 INFO - ++DOMWINDOW == 24 (00000054688F9800) [pid = 2792] [serial = 42] [outer = 0000005474EBD800]
08:43:38 INFO - 1500219818252 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"
08:43:38 INFO - 1500219818258 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"
08:43:38 INFO - 1500219818275 Marionette TRACE 364 <- [1,2,null,{}]
08:43:38 INFO - 1500219818279 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
08:43:38 INFO - 1500219818289 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e8a65015-30a5-4f0f-b2e3-dc1e12759062","ELEMENT":"e8a65015-30a5-4f0f-b2e3-dc1e12759062"}}]
08:43:38 INFO - --DOMWINDOW == 23 (000000546C9D5000) [pid = 2792] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49352/test_accessibility.html]
08:43:38 INFO - --DOMWINDOW == 22 (00000054688E3800) [pid = 2792] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49352/test_accessibility.html]
08:43:38 INFO - --DOMWINDOW == 21 (000000547B8C6000) [pid = 2792] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49352/test_accessibility.html]
08:43:38 INFO - 1500219818299 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"e8a65015-30a5-4f0f-b2e3-dc1e12759062"}]
08:43:38 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
08:43:38 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
08:43:38 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
08:43:39 INFO - 1500219819325 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:39 INFO - 1500219819342 Marionette TRACE 364 <- [1,4,null,{}]
08:43:39 INFO - 1500219819385 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"e8a65015-30a5-4f0f-b2e3-dc1e12759062","name":"selected"}]
08:43:39 INFO - 1500219819409 Marionette TRACE 364 <- [1,5,null,{"value":true}]
08:43:39 INFO - 1500219819412 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}]
08:43:39 INFO - TEST-END: test_click.py TestClick.test_container_element1500219819424 Marionette TRACE 364 <- [1,6,null,{"value":null}]
08:43:39 INFO - 1500219819425 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819430 Marionette TRACE 364 <- [1,7,null,{}]
08:43:39 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1661ms
08:43:39 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819437 Marionette DEBUG Closed connection 364
08:43:39 INFO - 1500219819439 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49827
08:43:39 INFO - 1500219819441 Marionette DEBUG Closed connection 365
08:43:39 INFO - 1500219819443 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49828
08:43:39 INFO - 1500219819445 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:39 INFO - 1500219819448 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:39 INFO - 1500219819469 Marionette DEBUG Register listener.js for window 15
08:43:39 INFO - 1500219819532 Marionette TRACE 366 <- [1,1,null,{"sessionId":"089f137c-1f5c-484e-858b-8d2741eb8fbf","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:39 INFO - 1500219819581 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
08:43:39 INFO - 1500219819583 Marionette TRACE 366 <- [1,2,null,{}]
08:43:39 INFO - 1500219819634 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:39 INFO - 1500219819636 Marionette TRACE 366 <- [1,3,null,{}]
08:43:39 INFO - 1500219819645 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:39 INFO - 1500219819647 Marionette TRACE 366 <- [1,4,null,{}]
08:43:39 INFO - 1500219819659 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}]
08:43:39 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500219819667 Marionette TRACE 366 <- [1,5,null,{"value":null}]
08:43:39 INFO - 1500219819671 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819676 Marionette TRACE 366 <- [1,6,null,{}]
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819696 Marionette DEBUG Closed connection 366
08:43:39 INFO - 1500219819698 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49829
08:43:39 INFO - 1500219819703 Marionette DEBUG Closed connection 367
08:43:39 INFO - 1500219819705 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49830
08:43:39 INFO - 1500219819707 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:39 INFO - 1500219819713 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:39 INFO - 1500219819734 Marionette DEBUG Register listener.js for window 15
08:43:39 INFO - 1500219819749 Marionette TRACE 368 <- [1,1,null,{"sessionId":"7ad92568-973d-4766-8994-35fa97a710a8","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:39 INFO - 1500219819759 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819764 Marionette TRACE 368 <- [1,2,null,{}]
08:43:39 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:39 INFO - 1500219819786 Marionette DEBUG Closed connection 368
08:43:39 INFO - 1500219819791 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49831
08:43:39 INFO - 1500219819795 Marionette DEBUG Closed connection 369
08:43:39 INFO - 1500219819797 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49832
08:43:39 INFO - 1500219819799 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:39 INFO - 1500219819802 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:39 INFO - 1500219819823 Marionette DEBUG Register listener.js for window 15
08:43:39 INFO - 1500219819837 Marionette TRACE 370 <- [1,1,null,{"sessionId":"3357cec0-e099-4109-8d9e-5ecbd5551078","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:39 INFO - 1500219819847 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"}]
08:43:39 INFO - 1500219819851 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"
08:43:39 INFO - 1500219819859 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"
08:43:39 INFO - 1500219819860 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"
08:43:39 INFO - ++DOMWINDOW == 22 (000000547016D000) [pid = 2792] [serial = 43] [outer = 0000005474EBD800]
08:43:39 INFO - 1500219819911 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"
08:43:39 INFO - 1500219819929 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"
08:43:39 INFO - 1500219819947 Marionette TRACE 370 <- [1,2,null,{}]
08:43:39 INFO - 1500219819955 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
08:43:39 INFO - 1500219819964 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"448ead4c-cb2a-40c4-b2a9-a0d77272f598","ELEMENT":"448ead4c-cb2a-40c4-b2a9-a0d77272f598"}}]
08:43:39 INFO - 1500219819966 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"448ead4c-cb2a-40c4-b2a9-a0d77272f598"}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
08:43:40 INFO - 1500219820404 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:40 INFO - 1500219820406 Marionette TRACE 370 <- [1,4,null,{}]
08:43:40 INFO - 1500219820408 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"448ead4c-cb2a-40c4-b2a9-a0d77272f598","name":"selected"}]
08:43:40 INFO - 1500219820430 Marionette TRACE 370 <- [1,5,null,{"value":true}]
08:43:40 INFO - 1500219820432 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}]
08:43:40 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500219820440 Marionette TRACE 370 <- [1,6,null,{"value":null}]
08:43:40 INFO - 1500219820442 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820447 Marionette TRACE 370 <- [1,7,null,{}]
08:43:40 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1016ms
08:43:40 INFO - TEST-START | test_click.py TestClick.test_css_transforms
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820453 Marionette DEBUG Closed connection 370
08:43:40 INFO - 1500219820454 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49833
08:43:40 INFO - 1500219820456 Marionette DEBUG Closed connection 371
08:43:40 INFO - 1500219820457 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49834
08:43:40 INFO - 1500219820459 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:40 INFO - 1500219820462 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:40 INFO - 1500219820483 Marionette DEBUG Register listener.js for window 15
08:43:40 INFO - 1500219820495 Marionette TRACE 372 <- [1,1,null,{"sessionId":"153f3b46-f643-4668-ac66-9d9e8452ee71","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:40 INFO - 1500219820532 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
08:43:40 INFO - 1500219820534 Marionette TRACE 372 <- [1,2,null,{}]
08:43:40 INFO - 1500219820536 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:40 INFO - 1500219820538 Marionette TRACE 372 <- [1,3,null,{}]
08:43:40 INFO - 1500219820540 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:40 INFO - 1500219820541 Marionette TRACE 372 <- [1,4,null,{}]
08:43:40 INFO - 1500219820544 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}]
08:43:40 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500219820553 Marionette TRACE 372 <- [1,5,null,{"value":null}]
08:43:40 INFO - 1500219820555 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820559 Marionette TRACE 372 <- [1,6,null,{}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820565 Marionette DEBUG Closed connection 372
08:43:40 INFO - 1500219820566 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49835
08:43:40 INFO - 1500219820568 Marionette DEBUG Closed connection 373
08:43:40 INFO - 1500219820571 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49836
08:43:40 INFO - 1500219820573 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:40 INFO - 1500219820576 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:40 INFO - 1500219820597 Marionette DEBUG Register listener.js for window 15
08:43:40 INFO - 1500219820609 Marionette TRACE 374 <- [1,1,null,{"sessionId":"c2242ee5-93a3-440d-b90e-063a3d5e3c74","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:40 INFO - 1500219820615 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820619 Marionette TRACE 374 <- [1,2,null,{}]
08:43:40 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:40 INFO - 1500219820625 Marionette DEBUG Closed connection 374
08:43:40 INFO - 1500219820626 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49837
08:43:40 INFO - 1500219820628 Marionette DEBUG Closed connection 375
08:43:40 INFO - 1500219820629 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49838
08:43:40 INFO - 1500219820632 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:40 INFO - 1500219820634 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:40 INFO - 1500219820655 Marionette DEBUG Register listener.js for window 15
08:43:40 INFO - 1500219820667 Marionette TRACE 376 <- [1,1,null,{"sessionId":"8c63335e-37cb-44ad-bef2-c88c72bd5de5","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:40 INFO - 1500219820674 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"}]
08:43:40 INFO - 1500219820677 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"
08:43:40 INFO - 1500219820685 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"
08:43:40 INFO - 1500219820685 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"
08:43:40 INFO - ++DOMWINDOW == 23 (0000005473293800) [pid = 2792] [serial = 44] [outer = 0000005474EBD800]
08:43:40 INFO - 1500219820739 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"
08:43:40 INFO - 1500219820746 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"
08:43:40 INFO - 1500219820762 Marionette TRACE 376 <- [1,2,null,{}]
08:43:40 INFO - 1500219820766 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
08:43:40 INFO - 1500219820773 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"eed663a7-a6b4-4030-a30c-bbdaafc38e4c","ELEMENT":"eed663a7-a6b4-4030-a30c-bbdaafc38e4c"}}]
08:43:40 INFO - 1500219820775 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"eed663a7-a6b4-4030-a30c-bbdaafc38e4c"}]
08:43:41 INFO - 1500219821252 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:41 INFO - 1500219821254 Marionette TRACE 376 <- [1,4,null,{}]
08:43:41 INFO - 1500219821257 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}]
08:43:41 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500219821265 Marionette TRACE 376 <- [1,5,null,{"value":null}]
08:43:41 INFO - 1500219821267 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821271 Marionette TRACE 376 <- [1,6,null,{}]
08:43:41 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 824ms
08:43:41 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821277 Marionette DEBUG Closed connection 376
08:43:41 INFO - 1500219821279 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49839
08:43:41 INFO - 1500219821280 Marionette DEBUG Closed connection 377
08:43:41 INFO - 1500219821282 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49840
08:43:41 INFO - 1500219821284 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:41 INFO - 1500219821286 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:41 INFO - 1500219821308 Marionette DEBUG Register listener.js for window 15
08:43:41 INFO - 1500219821319 Marionette TRACE 378 <- [1,1,null,{"sessionId":"15338c15-037a-4a0b-b352-a747535ec674","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:41 INFO - 1500219821325 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
08:43:41 INFO - 1500219821327 Marionette TRACE 378 <- [1,2,null,{}]
08:43:41 INFO - 1500219821329 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:41 INFO - 1500219821331 Marionette TRACE 378 <- [1,3,null,{}]
08:43:41 INFO - 1500219821333 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:41 INFO - 1500219821334 Marionette TRACE 378 <- [1,4,null,{}]
08:43:41 INFO - 1500219821337 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}]
08:43:41 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500219821370 Marionette TRACE 378 <- [1,5,null,{"value":null}]
08:43:41 INFO - 1500219821372 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821377 Marionette TRACE 378 <- [1,6,null,{}]
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821384 Marionette DEBUG Closed connection 378
08:43:41 INFO - 1500219821386 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49841
08:43:41 INFO - 1500219821405 Marionette DEBUG Closed connection 379
08:43:41 INFO - 1500219821406 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49842
08:43:41 INFO - 1500219821409 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:41 INFO - 1500219821412 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:41 INFO - 1500219821438 Marionette DEBUG Register listener.js for window 15
08:43:41 INFO - 1500219821452 Marionette TRACE 380 <- [1,1,null,{"sessionId":"2a3c5c56-dae7-41ea-8eba-e90616245b34","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:41 INFO - 1500219821458 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821463 Marionette TRACE 380 <- [1,2,null,{}]
08:43:41 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:41 INFO - 1500219821469 Marionette DEBUG Closed connection 380
08:43:41 INFO - 1500219821470 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49843
08:43:41 INFO - 1500219821472 Marionette DEBUG Closed connection 381
08:43:41 INFO - 1500219821473 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49844
08:43:41 INFO - 1500219821476 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:41 INFO - 1500219821478 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:41 INFO - 1500219821500 Marionette DEBUG Register listener.js for window 15
08:43:41 INFO - 1500219821511 Marionette TRACE 382 <- [1,1,null,{"sessionId":"219024a3-d0ca-4e7a-8412-68eb9a3e5c3b","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:41 INFO - 1500219821517 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"}]
08:43:41 INFO - 1500219821521 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"
08:43:41 INFO - 1500219821530 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"
08:43:41 INFO - 1500219821531 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"
08:43:41 INFO - ++DOMWINDOW == 24 (0000005478CC7000) [pid = 2792] [serial = 45] [outer = 0000005474EBD800]
08:43:41 INFO - 1500219821591 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"
08:43:41 INFO - 1500219821598 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"
08:43:41 INFO - 1500219821615 Marionette TRACE 382 <- [1,2,null,{}]
08:43:41 INFO - 1500219821647 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
08:43:41 INFO - 1500219821654 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e7ffcefa-4d17-47f4-8d6e-25f0b7fe0264","ELEMENT":"e7ffcefa-4d17-47f4-8d6e-25f0b7fe0264"}}]
08:43:41 INFO - 1500219821656 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"e7ffcefa-4d17-47f4-8d6e-25f0b7fe0264"}]
08:43:42 INFO - 1500219822606 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:42 INFO - 1500219822622 Marionette TRACE 382 <- [1,4,null,{}]
08:43:42 INFO - 1500219822639 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}]
08:43:42 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500219822646 Marionette TRACE 382 <- [1,5,null,{"value":null}]
08:43:42 INFO - 1500219822649 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
08:43:42 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:42 INFO - 1500219822654 Marionette TRACE 382 <- [1,6,null,{}]
08:43:42 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1382ms
08:43:42 INFO - TEST-START | test_click.py TestClick.test_input_file
08:43:42 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:42 INFO - 1500219822675 Marionette DEBUG Closed connection 382
08:43:42 INFO - 1500219822676 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49845
08:43:42 INFO - 1500219822681 Marionette DEBUG Closed connection 383
08:43:42 INFO - 1500219822682 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49846
08:43:42 INFO - 1500219822685 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:42 INFO - 1500219822687 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:42 INFO - 1500219822710 Marionette DEBUG Register listener.js for window 15
08:43:42 INFO - 1500219822721 Marionette TRACE 384 <- [1,1,null,{"sessionId":"b2c2370f-e310-421e-9cc5-304f5682c907","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:42 INFO - 1500219822734 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
08:43:42 INFO - 1500219822735 Marionette TRACE 384 <- [1,2,null,{}]
08:43:42 INFO - 1500219822756 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:42 INFO - 1500219822761 Marionette TRACE 384 <- [1,3,null,{}]
08:43:42 INFO - 1500219822765 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:42 INFO - 1500219822770 Marionette TRACE 384 <- [1,4,null,{}]
08:43:42 INFO - 1500219822775 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}]
08:43:42 INFO - TEST-START: test_click.py TestClick.test_input_file1500219822789 Marionette TRACE 384 <- [1,5,null,{"value":null}]
08:43:42 INFO - 1500219822793 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
08:43:42 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:42 INFO - 1500219822802 Marionette TRACE 384 <- [1,6,null,{}]
08:43:42 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:42 INFO - 1500219822829 Marionette DEBUG Closed connection 384
08:43:42 INFO - 1500219822832 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49847
08:43:42 INFO - 1500219822840 Marionette DEBUG Closed connection 385
08:43:42 INFO - 1500219822844 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49848
08:43:42 INFO - 1500219822848 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:42 INFO - 1500219822857 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:42 INFO - 1500219822901 Marionette DEBUG Register listener.js for window 15
08:43:42 INFO - 1500219822935 Marionette TRACE 386 <- [1,1,null,{"sessionId":"0548e8e4-8c58-4651-8e0c-bbb5a789cefd","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:42 INFO - 1500219822952 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
08:43:42 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:42 INFO - 1500219822960 Marionette TRACE 386 <- [1,2,null,{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823020 Marionette DEBUG Closed connection 386
08:43:43 INFO - 1500219823023 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49849
08:43:43 INFO - 1500219823043 Marionette DEBUG Closed connection 387
08:43:43 INFO - 1500219823046 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49850
08:43:43 INFO - 1500219823050 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:43 INFO - 1500219823055 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:43 INFO - 1500219823098 Marionette DEBUG Register listener.js for window 15
08:43:43 INFO - 1500219823117 Marionette TRACE 388 <- [1,1,null,{"sessionId":"80fe7dac-c240-469b-9d74-5d0e37103def","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:43 INFO - 1500219823129 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
08:43:43 INFO - 1500219823135 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"
08:43:43 INFO - 1500219823146 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"
08:43:43 INFO - 1500219823148 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"
08:43:43 INFO - ++DOMWINDOW == 25 (000000546C91D000) [pid = 2792] [serial = 46] [outer = 0000005474EBD800]
08:43:43 INFO - 1500219823227 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:43 INFO - 1500219823235 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:43 INFO - 1500219823256 Marionette TRACE 388 <- [1,2,null,{}]
08:43:43 INFO - 1500219823260 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
08:43:43 INFO - 1500219823272 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"40336f87-8b08-4dd3-89be-c5b12b36118c","ELEMENT":"40336f87-8b08-4dd3-89be-c5b12b36118c"}}]
08:43:43 INFO - 1500219823274 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"40336f87-8b08-4dd3-89be-c5b12b36118c"}]
08:43:43 INFO - 1500219823495 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
08:43:43 INFO - 1500219823523 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}]
08:43:43 INFO - TEST-END: test_click.py TestClick.test_input_file1500219823538 Marionette TRACE 388 <- [1,5,null,{"value":null}]
08:43:43 INFO - 1500219823541 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823548 Marionette TRACE 388 <- [1,6,null,{}]
08:43:43 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 893ms
08:43:43 INFO - TEST-START | test_click.py TestClick.test_obscured_element
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823572 Marionette DEBUG Closed connection 388
08:43:43 INFO - 1500219823574 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49851
08:43:43 INFO - 1500219823621 Marionette DEBUG Closed connection 389
08:43:43 INFO - 1500219823623 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49852
08:43:43 INFO - 1500219823629 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:43 INFO - 1500219823633 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:43 INFO - 1500219823675 Marionette DEBUG Register listener.js for window 15
08:43:43 INFO - 1500219823693 Marionette TRACE 390 <- [1,1,null,{"sessionId":"c32395cd-e447-462f-8656-414bb15bd3c1","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:43 INFO - 1500219823705 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
08:43:43 INFO - 1500219823708 Marionette TRACE 390 <- [1,2,null,{}]
08:43:43 INFO - 1500219823760 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:43 INFO - 1500219823762 Marionette TRACE 390 <- [1,3,null,{}]
08:43:43 INFO - 1500219823765 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:43 INFO - 1500219823767 Marionette TRACE 390 <- [1,4,null,{}]
08:43:43 INFO - 1500219823770 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}]
08:43:43 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500219823781 Marionette TRACE 390 <- [1,5,null,{"value":null}]
08:43:43 INFO - 1500219823832 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823838 Marionette TRACE 390 <- [1,6,null,{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823862 Marionette DEBUG Closed connection 390
08:43:43 INFO - 1500219823864 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49853
08:43:43 INFO - 1500219823866 Marionette DEBUG Closed connection 391
08:43:43 INFO - 1500219823869 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49854
08:43:43 INFO - 1500219823872 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:43 INFO - 1500219823875 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:43 INFO - 1500219823917 Marionette DEBUG Register listener.js for window 15
08:43:43 INFO - 1500219823935 Marionette TRACE 392 <- [1,1,null,{"sessionId":"65da1ed2-1e51-4537-883e-38dc185d4bd3","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:43 INFO - 1500219823944 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823948 Marionette TRACE 392 <- [1,2,null,{}]
08:43:43 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:43 INFO - 1500219823955 Marionette DEBUG Closed connection 392
08:43:43 INFO - 1500219823957 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49855
08:43:43 INFO - 1500219823959 Marionette DEBUG Closed connection 393
08:43:43 INFO - 1500219823961 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49856
08:43:43 INFO - 1500219823964 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:43 INFO - 1500219823971 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:44 INFO - 1500219824015 Marionette DEBUG Register listener.js for window 15
08:43:44 INFO - 1500219824045 Marionette TRACE 394 <- [1,1,null,{"sessionId":"959e247c-1ec0-4b47-9259-78b449b99ece","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:44 INFO - 1500219824080 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"}]
08:43:44 INFO - 1500219824085 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:44 INFO - 1500219824095 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:44 INFO - 1500219824096 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
08:43:44 INFO - ++DOMWINDOW == 26 (000000547B5AC000) [pid = 2792] [serial = 47] [outer = 0000005474EBD800]
08:43:44 INFO - 1500219824207 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"
08:43:44 INFO - 1500219824215 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"
08:43:44 INFO - 1500219824234 Marionette TRACE 394 <- [1,2,null,{}]
08:43:44 INFO - 1500219824242 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
08:43:44 INFO - 1500219824252 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4d0dd904-0d9f-403e-88a2-2fc0f4c7895c","ELEMENT":"4d0dd904-0d9f-403e-88a2-2fc0f4c7895c"}}]
08:43:44 INFO - 1500219824254 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
08:43:44 INFO - 1500219824263 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"49110b62-f6f6-4df7-8e08-c347d6dd7b31","ELEMENT":"49110b62-f6f6-4df7-8e08-c347d6dd7b31"}}]
08:43:44 INFO - 1500219824265 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"4d0dd904-0d9f-403e-88a2-2fc0f4c7895c"}]
08:43:44 INFO - 1500219824785 Marionette DEBUG Canceled page load listener because no navigation has been detected
08:43:44 INFO - 1500219824787 Marionette TRACE 394 <- [1,5,null,{}]
08:43:44 INFO - 1500219824961 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"49110b62-f6f6-4df7-8e08-c347d6dd7b31"}]
08:43:45 INFO - 1500219825085 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
08:43:45 INFO - 1500219825115 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
08:43:45 INFO - 1500219825129 Marionette TRACE 394 <- [1,7,null,{"value":false}]
08:43:45 INFO - 1500219825134 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}]
08:43:45 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500219825146 Marionette TRACE 394 <- [1,8,null,{"value":null}]
08:43:45 INFO - 1500219825150 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1611ms
08:43:45 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
08:43:45 INFO - 1500219825159 Marionette TRACE 394 <- [1,9,null,{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - 1500219825188 Marionette DEBUG Closed connection 394
08:43:45 INFO - 1500219825191 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49857
08:43:45 INFO - 1500219825219 Marionette DEBUG Closed connection 395
08:43:45 INFO - 1500219825223 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49858
08:43:45 INFO - 1500219825251 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:45 INFO - 1500219825261 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:45 INFO - 1500219825287 Marionette DEBUG Register listener.js for window 15
08:43:45 INFO - 1500219825307 Marionette TRACE 396 <- [1,1,null,{"sessionId":"60fc7d9b-7701-46b8-9e33-a953c0cea366","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:45 INFO - 1500219825324 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
08:43:45 INFO - 1500219825327 Marionette TRACE 396 <- [1,2,null,{}]
08:43:45 INFO - 1500219825341 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
08:43:45 INFO - 1500219825344 Marionette TRACE 396 <- [1,3,null,{}]
08:43:45 INFO - 1500219825347 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
08:43:45 INFO - 1500219825350 Marionette TRACE 396 <- [1,4,null,{}]
08:43:45 INFO - 1500219825353 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}]
08:43:45 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500219825369 Marionette TRACE 396 <- [1,5,null,{"value":null}]
08:43:45 INFO - 1500219825385 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - 1500219825391 Marionette TRACE 396 <- [1,6,null,{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - 1500219825406 Marionette DEBUG Closed connection 396
08:43:45 INFO - 1500219825408 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49859
08:43:45 INFO - 1500219825463 Marionette DEBUG Closed connection 397
08:43:45 INFO - 1500219825465 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49860
08:43:45 INFO - 1500219825504 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
08:43:45 INFO - 1500219825509 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:45 INFO - 1500219825533 Marionette DEBUG Register listener.js for window 15
08:43:45 INFO - 1500219825549 Marionette TRACE 398 <- [1,1,null,{"sessionId":"5983ab43-81a1-416a-98f7-db5bca331345","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:45 INFO - 1500219825570 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - 1500219825576 Marionette TRACE 398 <- [1,2,null,{}]
08:43:45 INFO - [Parent 2792] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
08:43:45 INFO - 1500219825596 Marionette DEBUG Closed connection 398
08:43:45 INFO - 1500219825598 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49861
08:43:45 INFO - 1500219825606 Marionette DEBUG Closed connection 399
08:43:45 INFO - 1500219825608 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49862
08:43:45 INFO - 1500219825634 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
08:43:45 INFO - 1500219825637 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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}
08:43:45 INFO - 1500219825661 Marionette DEBUG Register listener.js for window 15
08:43:45 INFO - 1500219825675 Marionette TRACE 400 <- [1,1,null,{"sessionId":"757cf7ff-6b86-495e-8108-f61df258535e","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":2792,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-311\\AppData\\Local\\Temp\\tmpk3v_jh.mozrunner","moz:accessibilityChecks":false}}]
08:43:45 INFO - 1500219825686 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"}]
08:43:45 INFO - 1500219825692 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"
08:43:45 INFO - 1500219825703 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"
08:43:45 INFO - 1500219825704 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"
08:43:45 INFO - ++DOMWINDOW == 27 (0000005470165000) [pid = 2792] [serial = 48] [outer = 0000005474EBD800]
08:43:45 INFO - 1500219825777 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"
08:43:45 INFO - 1500219825784 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"
08:43:45 INFO - 1500219825803 Marionette TRACE 400 <- [1,2,null,{}]
08:43:45 INFO - 1500219825805 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
08:43:45 INFO - 1500219825814 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3f0eee0d-adb6-4424-b320-21022146ffbb","ELEMENT":"3f0eee0d-adb6-4424-b320-21022146ffbb"}}]
08:43:45 INFO - 1500219825816 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"3f0eee0d-adb6-4424-b320-21022146ffbb"}]
08:43:45 INFO - 1500219825935 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
08:43:45 INFO - 1500219825944 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"3f0eee0d-adb6-4424-b320-21022146ffbb"}]
08:43:46 INFO - 1500219826057 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element