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]
17:46:41 INFO - 1499993201312 Marionette TRACE 353 -> [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}]
17:46:41 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499993201319 Marionette TRACE 353 <- [1,5,null,{"value":null}]
17:46:41 INFO - 1499993201322 Marionette TRACE 353 -> [0,6,"deleteSession",{}]
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201326 Marionette TRACE 353 <- [1,6,null,{}]
17:46:41 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1548ms
17:46:41 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201332 Marionette DEBUG Closed connection 353
17:46:41 INFO - 1499993201333 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49795
17:46:41 INFO - 1499993201334 Marionette DEBUG Closed connection 354
17:46:41 INFO - 1499993201336 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49796
17:46:41 INFO - 1499993201338 Marionette TRACE 355 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:41 INFO - 1499993201340 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:41 INFO - 1499993201363 Marionette DEBUG Register listener.js for window 15
17:46:41 INFO - 1499993201374 Marionette TRACE 355 <- [1,1,null,{"sessionId":"b933f0e7-a70e-4e6f-8ba2-0a17fd2f64b0","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:41 INFO - 1499993201430 Marionette TRACE 355 -> [0,2,"setTimeouts",{"script":30000}]
17:46:41 INFO - 1499993201432 Marionette TRACE 355 <- [1,2,null,{}]
17:46:41 INFO - 1499993201434 Marionette TRACE 355 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:41 INFO - 1499993201435 Marionette TRACE 355 <- [1,3,null,{}]
17:46:41 INFO - 1499993201487 Marionette TRACE 355 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:41 INFO - 1499993201489 Marionette TRACE 355 <- [1,4,null,{}]
17:46:41 INFO - 1499993201536 Marionette TRACE 355 -> [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}]
17:46:41 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499993201546 Marionette TRACE 355 <- [1,5,null,{"value":null}]
17:46:41 INFO - 1499993201569 Marionette TRACE 355 -> [0,6,"deleteSession",{}]
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201574 Marionette TRACE 355 <- [1,6,null,{}]
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201634 Marionette DEBUG Closed connection 355
17:46:41 INFO - 1499993201637 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49797
17:46:41 INFO - 1499993201643 Marionette DEBUG Closed connection 356
17:46:41 INFO - 1499993201646 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49798
17:46:41 INFO - 1499993201650 Marionette TRACE 357 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:41 INFO - 1499993201661 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:41 INFO - 1499993201707 Marionette DEBUG Register listener.js for window 15
17:46:41 INFO - 1499993201729 Marionette TRACE 357 <- [1,1,null,{"sessionId":"33a5009b-e07c-4fae-bee1-eab0eaa61aaa","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:41 INFO - 1499993201743 Marionette TRACE 357 -> [0,2,"deleteSession",{}]
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201751 Marionette TRACE 357 <- [1,2,null,{}]
17:46:41 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:41 INFO - 1499993201772 Marionette DEBUG Closed connection 357
17:46:41 INFO - 1499993201777 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49799
17:46:41 INFO - 1499993201822 Marionette DEBUG Closed connection 358
17:46:41 INFO - 1499993201826 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49800
17:46:41 INFO - 1499993201832 Marionette TRACE 359 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:41 INFO - 1499993201837 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:41 INFO - 1499993201882 Marionette DEBUG Register listener.js for window 15
17:46:41 INFO - 1499993201926 Marionette TRACE 359 <- [1,1,null,{"sessionId":"218c5ad7-323d-4b33-a08d-4937152e5958","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:41 INFO - 1499993201943 Marionette TRACE 359 -> [0,2,"get",{"url":"http://127.0.0.1:49331/clicks.html"}]
17:46:41 INFO - 1499993201950 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/hidden.html"
17:46:41 INFO - 1499993201968 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/hidden.html"
17:46:41 INFO - 1499993201969 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/hidden.html"
17:46:41 INFO - ++DOMWINDOW == 29 (000000354CC78000) [pid = 2096] [serial = 40] [outer = 00000035581E1800]
17:46:42 INFO - 1499993202043 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/clicks.html"
17:46:42 INFO - 1499993202051 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/clicks.html"
17:46:42 INFO - 1499993202088 Marionette TRACE 359 <- [1,2,null,{}]
17:46:42 INFO - 1499993202098 Marionette TRACE 359 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
17:46:42 INFO - 1499993202111 Marionette TRACE 359 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a93d694f-a1b8-4aa5-831a-4d7b2e756cfa","ELEMENT":"a93d694f-a1b8-4aa5-831a-4d7b2e756cfa"}}]
17:46:42 INFO - 1499993202114 Marionette TRACE 359 -> [0,4,"clickElement",{"id":"a93d694f-a1b8-4aa5-831a-4d7b2e756cfa"}]
17:46:42 INFO - 1499993202518 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/clicks.html"
17:46:42 INFO - [Parent 2096] 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
17:46:42 INFO - 1499993202538 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/clicks.html"
17:46:42 INFO - 1499993202540 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/clicks.html"
17:46:42 INFO - ++DOMWINDOW == 30 (0000003551321800) [pid = 2096] [serial = 41] [outer = 00000035581E1800]
17:46:42 INFO - 1499993202620 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49331/test.html"
17:46:42 INFO - 1499993202626 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49331/test.html"
17:46:42 INFO - 1499993202649 Marionette TRACE 359 <- [1,4,null,{}]
17:46:42 INFO - 1499993202699 Marionette TRACE 359 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
17:46:42 INFO - 1499993202709 Marionette TRACE 359 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"66bb1d28-f1fc-4efd-92e1-b17189653b42","ELEMENT":"66bb1d28-f1fc-4efd-92e1-b17189653b42"}}]
17:46:42 INFO - 1499993202714 Marionette TRACE 359 -> [0,6,"getTitle",{}]
17:46:42 INFO - 1499993202716 Marionette TRACE 359 <- [1,6,null,{"value":"Marionette Test"}]
17:46:42 INFO - 1499993202719 Marionette TRACE 359 -> [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}]
17:46:42 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499993202732 Marionette TRACE 359 <- [1,7,null,{"value":null}]
17:46:42 INFO - 1499993202735 Marionette TRACE 359 -> [0,8,"deleteSession",{}]
17:46:42 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:42 INFO - 1499993202742 Marionette TRACE 359 <- [1,8,null,{}]
17:46:42 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1415ms
17:46:42 INFO - TEST-START | test_click.py TestClick.test_container_element
17:46:42 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:42 INFO - 1499993202751 Marionette DEBUG Closed connection 359
17:46:42 INFO - 1499993202753 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49803
17:46:42 INFO - 1499993202756 Marionette DEBUG Closed connection 360
17:46:42 INFO - 1499993202758 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49804
17:46:42 INFO - 1499993202777 Marionette TRACE 361 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:42 INFO - 1499993202783 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:42 INFO - 1499993202829 Marionette DEBUG Register listener.js for window 15
17:46:42 INFO - 1499993202848 Marionette TRACE 361 <- [1,1,null,{"sessionId":"c84ab073-e808-40ef-bfe2-0ebf951d87f8","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:42 INFO - 1499993202882 Marionette TRACE 361 -> [0,2,"setTimeouts",{"script":30000}]
17:46:42 INFO - 1499993202884 Marionette TRACE 361 <- [1,2,null,{}]
17:46:42 INFO - 1499993202936 Marionette TRACE 361 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:42 INFO - 1499993202938 Marionette TRACE 361 <- [1,3,null,{}]
17:46:42 INFO - 1499993202941 Marionette TRACE 361 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:42 INFO - 1499993202944 Marionette TRACE 361 <- [1,4,null,{}]
17:46:42 INFO - 1499993202947 Marionette TRACE 361 -> [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}]
17:46:42 INFO - TEST-START: test_click.py TestClick.test_container_element1499993202977 Marionette TRACE 361 <- [1,5,null,{"value":null}]
17:46:43 INFO - 1499993203004 Marionette TRACE 361 -> [0,6,"deleteSession",{}]
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:43 INFO - 1499993203009 Marionette TRACE 361 <- [1,6,null,{}]
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:43 INFO - 1499993203060 Marionette DEBUG Closed connection 361
17:46:43 INFO - 1499993203062 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49805
17:46:43 INFO - 1499993203084 Marionette DEBUG Closed connection 362
17:46:43 INFO - 1499993203087 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49806
17:46:43 INFO - 1499993203092 Marionette TRACE 363 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:43 INFO - 1499993203095 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:43 INFO - 1499993203141 Marionette DEBUG Register listener.js for window 15
17:46:43 INFO - 1499993203156 Marionette TRACE 363 <- [1,1,null,{"sessionId":"05190fc5-8383-4718-a8db-f7b2ecebdf56","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:43 INFO - 1499993203189 Marionette TRACE 363 -> [0,2,"deleteSession",{}]
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:43 INFO - 1499993203195 Marionette TRACE 363 <- [1,2,null,{}]
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:43 INFO - 1499993203222 Marionette DEBUG Closed connection 363
17:46:43 INFO - 1499993203225 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49807
17:46:43 INFO - 1499993203229 Marionette DEBUG Closed connection 364
17:46:43 INFO - 1499993203231 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49808
17:46:43 INFO - 1499993203283 Marionette TRACE 365 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:43 INFO - 1499993203290 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:43 INFO - 1499993203337 Marionette DEBUG Register listener.js for window 15
17:46:43 INFO - 1499993203355 Marionette TRACE 365 <- [1,1,null,{"sessionId":"f9949627-455a-495a-b142-5cb27f7ceb52","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:43 INFO - 1499993203366 Marionette TRACE 365 -> [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"}]
17:46:43 INFO - 1499993203372 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49331/test.html"
17:46:43 INFO - 1499993203379 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49331/test.html"
17:46:43 INFO - 1499993203381 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49331/test.html"
17:46:43 INFO - ++DOMWINDOW == 31 (0000003555E09000) [pid = 2096] [serial = 42] [outer = 00000035581E1800]
17:46:43 INFO - 1499993203441 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"
17:46:43 INFO - 1499993203459 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"
17:46:43 INFO - 1499993203487 Marionette TRACE 365 <- [1,2,null,{}]
17:46:43 INFO - 1499993203490 Marionette TRACE 365 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:46:43 INFO - 1499993203501 Marionette TRACE 365 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3637839c-e8ee-4f6a-b059-bfacac98ab23","ELEMENT":"3637839c-e8ee-4f6a-b059-bfacac98ab23"}}]
17:46:43 INFO - 1499993203503 Marionette TRACE 365 -> [0,4,"clickElement",{"id":"3637839c-e8ee-4f6a-b059-bfacac98ab23"}]
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
17:46:43 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
17:46:44 INFO - 1499993204285 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:46:44 INFO - 1499993204290 Marionette TRACE 365 <- [1,4,null,{}]
17:46:44 INFO - 1499993204298 Marionette TRACE 365 -> [0,5,"getElementProperty",{"id":"3637839c-e8ee-4f6a-b059-bfacac98ab23","name":"selected"}]
17:46:44 INFO - 1499993204338 Marionette TRACE 365 <- [1,5,null,{"value":true}]
17:46:44 INFO - 1499993204343 Marionette TRACE 365 -> [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}]
17:46:44 INFO - TEST-END: test_click.py TestClick.test_container_element1499993204357 Marionette TRACE 365 <- [1,6,null,{"value":null}]
17:46:44 INFO - 1499993204361 Marionette TRACE 365 -> [0,7,"deleteSession",{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1629ms
17:46:44 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
17:46:44 INFO - 1499993204371 Marionette TRACE 365 <- [1,7,null,{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - 1499993204380 Marionette DEBUG Closed connection 365
17:46:44 INFO - 1499993204382 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49809
17:46:44 INFO - 1499993204406 Marionette DEBUG Closed connection 366
17:46:44 INFO - 1499993204410 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49810
17:46:44 INFO - 1499993204452 Marionette TRACE 367 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:44 INFO - 1499993204463 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:44 INFO - 1499993204491 Marionette DEBUG Register listener.js for window 15
17:46:44 INFO - 1499993204513 Marionette TRACE 367 <- [1,1,null,{"sessionId":"a23a6ffd-e503-4d58-812c-bead37b5578a","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:44 INFO - 1499993204530 Marionette TRACE 367 -> [0,2,"setTimeouts",{"script":30000}]
17:46:44 INFO - 1499993204535 Marionette TRACE 367 <- [1,2,null,{}]
17:46:44 INFO - 1499993204552 Marionette TRACE 367 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:44 INFO - 1499993204554 Marionette TRACE 367 <- [1,3,null,{}]
17:46:44 INFO - 1499993204561 Marionette TRACE 367 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:44 INFO - 1499993204563 Marionette TRACE 367 <- [1,4,null,{}]
17:46:44 INFO - 1499993204567 Marionette TRACE 367 -> [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}]
17:46:44 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499993204579 Marionette TRACE 367 <- [1,5,null,{"value":null}]
17:46:44 INFO - 1499993204635 Marionette TRACE 367 -> [0,6,"deleteSession",{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - 1499993204641 Marionette TRACE 367 <- [1,6,null,{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - 1499993204668 Marionette DEBUG Closed connection 367
17:46:44 INFO - 1499993204671 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49811
17:46:44 INFO - 1499993204675 Marionette DEBUG Closed connection 368
17:46:44 INFO - 1499993204677 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49812
17:46:44 INFO - 1499993204702 Marionette TRACE 369 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:44 INFO - 1499993204706 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:44 INFO - 1499993204734 Marionette DEBUG Register listener.js for window 15
17:46:44 INFO - 1499993204751 Marionette TRACE 369 <- [1,1,null,{"sessionId":"ae6fd60f-44b7-4813-b822-8f5afc803231","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:44 INFO - 1499993204769 Marionette TRACE 369 -> [0,2,"deleteSession",{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - 1499993204778 Marionette TRACE 369 <- [1,2,null,{}]
17:46:44 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:44 INFO - 1499993204787 Marionette DEBUG Closed connection 369
17:46:44 INFO - 1499993204789 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49813
17:46:44 INFO - 1499993204811 Marionette DEBUG Closed connection 370
17:46:44 INFO - 1499993204813 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49814
17:46:44 INFO - 1499993204816 Marionette TRACE 371 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:44 INFO - 1499993204820 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:44 INFO - 1499993204845 Marionette DEBUG Register listener.js for window 15
17:46:44 INFO - 1499993204860 Marionette TRACE 371 <- [1,1,null,{"sessionId":"b732e5b2-f81c-403c-9934-57fa6c79e71f","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:44 INFO - 1499993204874 Marionette TRACE 371 -> [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"}]
17:46:44 INFO - 1499993204879 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"
17:46:44 INFO - 1499993204889 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"
17:46:44 INFO - 1499993204890 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"
17:46:44 INFO - ++DOMWINDOW == 32 (000000354C3C6800) [pid = 2096] [serial = 43] [outer = 00000035581E1800]
17:46:44 INFO - 1499993204950 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"
17:46:44 INFO - 1499993204958 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"
17:46:44 INFO - 1499993204980 Marionette TRACE 371 <- [1,2,null,{}]
17:46:44 INFO - 1499993204989 Marionette TRACE 371 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
17:46:45 INFO - 1499993205000 Marionette TRACE 371 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1bd2168e-594b-4a77-858b-1d03f02decb1","ELEMENT":"1bd2168e-594b-4a77-858b-1d03f02decb1"}}]
17:46:45 INFO - 1499993205002 Marionette TRACE 371 -> [0,4,"clickElement",{"id":"1bd2168e-594b-4a77-858b-1d03f02decb1"}]
17:46:45 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
17:46:45 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
17:46:45 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
17:46:45 INFO - --DOMWINDOW == 31 (0000003560EDB800) [pid = 2096] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 30 (000000355C84C000) [pid = 2096] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 29 (0000003557C17000) [pid = 2096] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 28 (0000003553888800) [pid = 2096] [serial = 25] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 27 (000000355239F000) [pid = 2096] [serial = 24] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 26 (000000354F9A4000) [pid = 2096] [serial = 23] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 25 (0000003556922000) [pid = 2096] [serial = 21] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 24 (000000354DB29800) [pid = 2096] [serial = 22] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:45 INFO - --DOMWINDOW == 23 (000000354FE9E000) [pid = 2096] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49331/test_accessibility.html]
17:46:46 INFO - 1499993206140 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:46:46 INFO - 1499993206163 Marionette TRACE 371 <- [1,4,null,{}]
17:46:46 INFO - 1499993206208 Marionette TRACE 371 -> [0,5,"getElementProperty",{"id":"1bd2168e-594b-4a77-858b-1d03f02decb1","name":"selected"}]
17:46:46 INFO - 1499993206238 Marionette TRACE 371 <- [1,5,null,{"value":true}]
17:46:46 INFO - 1499993206290 Marionette TRACE 371 -> [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}]
17:46:46 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499993206302 Marionette TRACE 371 <- [1,6,null,{"value":null}]
17:46:46 INFO - 1499993206304 Marionette TRACE 371 -> [0,7,"deleteSession",{}]
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206309 Marionette TRACE 371 <- [1,7,null,{}]
17:46:46 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1939ms
17:46:46 INFO - TEST-START | test_click.py TestClick.test_css_transforms
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206361 Marionette DEBUG Closed connection 371
17:46:46 INFO - 1499993206363 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49815
17:46:46 INFO - 1499993206415 Marionette DEBUG Closed connection 372
17:46:46 INFO - 1499993206417 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49816
17:46:46 INFO - 1499993206471 Marionette TRACE 373 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:46 INFO - 1499993206474 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:46 INFO - 1499993206500 Marionette DEBUG Register listener.js for window 15
17:46:46 INFO - 1499993206514 Marionette TRACE 373 <- [1,1,null,{"sessionId":"40e914cc-e1f8-46a7-8903-ffb792b13cee","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:46 INFO - 1499993206544 Marionette TRACE 373 -> [0,2,"setTimeouts",{"script":30000}]
17:46:46 INFO - 1499993206546 Marionette TRACE 373 <- [1,2,null,{}]
17:46:46 INFO - 1499993206564 Marionette TRACE 373 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:46 INFO - 1499993206566 Marionette TRACE 373 <- [1,3,null,{}]
17:46:46 INFO - 1499993206570 Marionette TRACE 373 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:46 INFO - 1499993206572 Marionette TRACE 373 <- [1,4,null,{}]
17:46:46 INFO - 1499993206575 Marionette TRACE 373 -> [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}]
17:46:46 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499993206583 Marionette TRACE 373 <- [1,5,null,{"value":null}]
17:46:46 INFO - 1499993206587 Marionette TRACE 373 -> [0,6,"deleteSession",{}]
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206592 Marionette TRACE 373 <- [1,6,null,{}]
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206614 Marionette DEBUG Closed connection 373
17:46:46 INFO - 1499993206615 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49817
17:46:46 INFO - 1499993206620 Marionette DEBUG Closed connection 374
17:46:46 INFO - 1499993206622 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49818
17:46:46 INFO - 1499993206624 Marionette TRACE 375 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:46 INFO - 1499993206629 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:46 INFO - 1499993206654 Marionette DEBUG Register listener.js for window 15
17:46:46 INFO - 1499993206669 Marionette TRACE 375 <- [1,1,null,{"sessionId":"e2e887cc-eb23-434b-8e2a-d73937e55f08","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:46 INFO - 1499993206679 Marionette TRACE 375 -> [0,2,"deleteSession",{}]
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206684 Marionette TRACE 375 <- [1,2,null,{}]
17:46:46 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:46 INFO - 1499993206708 Marionette DEBUG Closed connection 375
17:46:46 INFO - 1499993206713 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49819
17:46:46 INFO - 1499993206717 Marionette DEBUG Closed connection 376
17:46:46 INFO - 1499993206719 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49820
17:46:46 INFO - 1499993206722 Marionette TRACE 377 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:46 INFO - 1499993206725 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:46 INFO - 1499993206749 Marionette DEBUG Register listener.js for window 15
17:46:46 INFO - 1499993206764 Marionette TRACE 377 <- [1,1,null,{"sessionId":"b6785125-5ed1-4e9c-ac08-f21fca6585dd","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:46 INFO - 1499993206774 Marionette TRACE 377 -> [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"}]
17:46:46 INFO - 1499993206779 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"
17:46:46 INFO - 1499993206788 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"
17:46:46 INFO - 1499993206789 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"
17:46:46 INFO - ++DOMWINDOW == 24 (000000354FEA3800) [pid = 2096] [serial = 44] [outer = 00000035581E1800]
17:46:46 INFO - 1499993206856 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"
17:46:46 INFO - 1499993206862 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"
17:46:46 INFO - 1499993206897 Marionette TRACE 377 <- [1,2,null,{}]
17:46:46 INFO - 1499993206903 Marionette TRACE 377 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
17:46:46 INFO - 1499993206914 Marionette TRACE 377 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"feef0c0e-c426-4b0a-9135-126d9056a749","ELEMENT":"feef0c0e-c426-4b0a-9135-126d9056a749"}}]
17:46:46 INFO - 1499993206916 Marionette TRACE 377 -> [0,4,"clickElement",{"id":"feef0c0e-c426-4b0a-9135-126d9056a749"}]
17:46:47 INFO - 1499993207403 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:46:48 INFO - 1499993207405 Marionette TRACE 377 <- [1,4,null,{}]
17:46:48 INFO - 1499993207408 Marionette TRACE 377 -> [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}]
17:46:48 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499993207417 Marionette TRACE 377 <- [1,5,null,{"value":null}]
17:46:48 INFO - 1499993207419 Marionette TRACE 377 -> [0,6,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207423 Marionette TRACE 377 <- [1,6,null,{}]
17:46:48 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1114ms
17:46:48 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207430 Marionette DEBUG Closed connection 377
17:46:48 INFO - 1499993207431 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49821
17:46:48 INFO - 1499993207433 Marionette DEBUG Closed connection 378
17:46:48 INFO - 1499993207434 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49822
17:46:48 INFO - 1499993207436 Marionette TRACE 379 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:48 INFO - 1499993207439 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993207463 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993207475 Marionette TRACE 379 <- [1,1,null,{"sessionId":"c36a017b-7760-4942-adc6-205642d692cf","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:48 INFO - 1499993207509 Marionette TRACE 379 -> [0,2,"setTimeouts",{"script":30000}]
17:46:48 INFO - 1499993207511 Marionette TRACE 379 <- [1,2,null,{}]
17:46:48 INFO - 1499993207513 Marionette TRACE 379 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:48 INFO - 1499993207514 Marionette TRACE 379 <- [1,3,null,{}]
17:46:48 INFO - 1499993207516 Marionette TRACE 379 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:48 INFO - 1499993207518 Marionette TRACE 379 <- [1,4,null,{}]
17:46:48 INFO - 1499993207521 Marionette TRACE 379 -> [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}]
17:46:48 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499993207530 Marionette TRACE 379 <- [1,5,null,{"value":null}]
17:46:48 INFO - 1499993207532 Marionette TRACE 379 -> [0,6,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207537 Marionette TRACE 379 <- [1,6,null,{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207543 Marionette DEBUG Closed connection 379
17:46:48 INFO - 1499993207544 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49823
17:46:48 INFO - 1499993207546 Marionette DEBUG Closed connection 380
17:46:48 INFO - 1499993207548 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49824
17:46:48 INFO - 1499993207551 Marionette TRACE 381 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:48 INFO - 1499993207554 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993207578 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993207590 Marionette TRACE 381 <- [1,1,null,{"sessionId":"c985bd42-fd51-4dbf-88a8-49e79af79fb1","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:48 INFO - 1499993207597 Marionette TRACE 381 -> [0,2,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207601 Marionette TRACE 381 <- [1,2,null,{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993207607 Marionette DEBUG Closed connection 381
17:46:48 INFO - 1499993207608 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49825
17:46:48 INFO - 1499993207610 Marionette DEBUG Closed connection 382
17:46:48 INFO - 1499993207611 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49826
17:46:48 INFO - 1499993207613 Marionette TRACE 383 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:48 INFO - 1499993207617 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993207641 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993207653 Marionette TRACE 383 <- [1,1,null,{"sessionId":"0b10c286-5bb1-46d9-92ca-39bb4689233f","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:48 INFO - 1499993207659 Marionette TRACE 383 -> [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"}]
17:46:48 INFO - 1499993207664 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"
17:46:48 INFO - 1499993207670 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"
17:46:48 INFO - 1499993207671 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"
17:46:48 INFO - ++DOMWINDOW == 25 (0000003551724000) [pid = 2096] [serial = 45] [outer = 00000035581E1800]
17:46:48 INFO - 1499993207724 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"
17:46:48 INFO - 1499993207739 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"
17:46:48 INFO - 1499993207756 Marionette TRACE 383 <- [1,2,null,{}]
17:46:48 INFO - 1499993207759 Marionette TRACE 383 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
17:46:48 INFO - 1499993207768 Marionette TRACE 383 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0c9afa5f-fe7f-4f02-b359-2a311e288ca3","ELEMENT":"0c9afa5f-fe7f-4f02-b359-2a311e288ca3"}}]
17:46:48 INFO - 1499993207770 Marionette TRACE 383 -> [0,4,"clickElement",{"id":"0c9afa5f-fe7f-4f02-b359-2a311e288ca3"}]
17:46:48 INFO - 1499993208315 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:46:48 INFO - 1499993208317 Marionette TRACE 383 <- [1,4,null,{}]
17:46:48 INFO - 1499993208321 Marionette TRACE 383 -> [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}]
17:46:48 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499993208330 Marionette TRACE 383 <- [1,5,null,{"value":null}]
17:46:48 INFO - 1499993208332 Marionette TRACE 383 -> [0,6,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208336 Marionette TRACE 383 <- [1,6,null,{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208343 Marionette DEBUG Closed connection 383
17:46:48 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 912ms
17:46:48 INFO - TEST-START | test_click.py TestClick.test_input_file
17:46:48 INFO - 1499993208660 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49827
17:46:48 INFO - 1499993208662 Marionette DEBUG Closed connection 384
17:46:48 INFO - 1499993208663 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49828
17:46:48 INFO - 1499993208665 Marionette TRACE 385 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:48 INFO - 1499993208668 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993208693 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993208704 Marionette TRACE 385 <- [1,1,null,{"sessionId":"b627bd94-eced-41f3-9194-afcd7e030ed9","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:48 INFO - 1499993208711 Marionette TRACE 385 -> [0,2,"setTimeouts",{"script":30000}]
17:46:48 INFO - 1499993208713 Marionette TRACE 385 <- [1,2,null,{}]
17:46:48 INFO - 1499993208715 Marionette TRACE 385 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:48 INFO - 1499993208717 Marionette TRACE 385 <- [1,3,null,{}]
17:46:48 INFO - 1499993208725 Marionette TRACE 385 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:48 INFO - 1499993208726 Marionette TRACE 385 <- [1,4,null,{}]
17:46:48 INFO - 1499993208729 Marionette TRACE 385 -> [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}]
17:46:48 INFO - TEST-START: test_click.py TestClick.test_input_file1499993208737 Marionette TRACE 385 <- [1,5,null,{"value":null}]
17:46:48 INFO - 1499993208739 Marionette TRACE 385 -> [0,6,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208743 Marionette TRACE 385 <- [1,6,null,{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208768 Marionette DEBUG Closed connection 385
17:46:48 INFO - 1499993208769 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49829
17:46:48 INFO - 1499993208773 Marionette DEBUG Closed connection 386
17:46:48 INFO - 1499993208774 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49830
17:46:48 INFO - 1499993208777 Marionette TRACE 387 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:48 INFO - 1499993208780 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993208809 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993208824 Marionette TRACE 387 <- [1,1,null,{"sessionId":"af22d8c5-7516-4b4f-84e8-9d6d7f7fbdc5","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:48 INFO - 1499993208835 Marionette TRACE 387 -> [0,2,"deleteSession",{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208839 Marionette TRACE 387 <- [1,2,null,{}]
17:46:48 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:48 INFO - 1499993208861 Marionette DEBUG Closed connection 387
17:46:48 INFO - 1499993208862 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49831
17:46:48 INFO - 1499993208868 Marionette DEBUG Closed connection 388
17:46:48 INFO - 1499993208870 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49832
17:46:48 INFO - 1499993208872 Marionette TRACE 389 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:48 INFO - 1499993208875 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:48 INFO - 1499993208900 Marionette DEBUG Register listener.js for window 15
17:46:48 INFO - 1499993208911 Marionette TRACE 389 <- [1,1,null,{"sessionId":"c4a2083e-7357-4b51-874d-c14ae86dc8c1","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:49 INFO - 1499993209529 Marionette TRACE 389 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
17:46:49 INFO - 1499993209533 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"
17:46:49 INFO - 1499993209543 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"
17:46:49 INFO - 1499993209545 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"
17:46:49 INFO - ++DOMWINDOW == 26 (0000003551730000) [pid = 2096] [serial = 46] [outer = 00000035581E1800]
17:46:49 INFO - 1499993209602 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:46:49 INFO - 1499993209648 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:46:49 INFO - 1499993209666 Marionette TRACE 389 <- [1,2,null,{}]
17:46:49 INFO - 1499993209669 Marionette TRACE 389 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
17:46:49 INFO - 1499993209678 Marionette TRACE 389 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"032b8d8f-ac2f-4fd7-9f88-9755407ddb72","ELEMENT":"032b8d8f-ac2f-4fd7-9f88-9755407ddb72"}}]
17:46:49 INFO - 1499993209740 Marionette TRACE 389 -> [0,4,"clickElement",{"id":"032b8d8f-ac2f-4fd7-9f88-9755407ddb72"}]
17:46:50 INFO - 1499993210013 Marionette TRACE 389 <- [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]
17:46:50 INFO - 1499993210029 Marionette TRACE 389 -> [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}]
17:46:50 INFO - TEST-END: test_click.py TestClick.test_input_file1499993210046 Marionette TRACE 389 <- [1,5,null,{"value":null}]
17:46:50 INFO - 1499993210100 Marionette TRACE 389 -> [0,6,"deleteSession",{}]
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210110 Marionette TRACE 389 <- [1,6,null,{}]
17:46:50 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 1456ms
17:46:50 INFO - TEST-START | test_click.py TestClick.test_obscured_element
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210139 Marionette DEBUG Closed connection 389
17:46:50 INFO - 1499993210142 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49833
17:46:50 INFO - 1499993210145 Marionette DEBUG Closed connection 390
17:46:50 INFO - 1499993210148 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49834
17:46:50 INFO - 1499993210154 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:50 INFO - 1499993210168 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:50 INFO - 1499993210221 Marionette DEBUG Register listener.js for window 15
17:46:50 INFO - 1499993210258 Marionette TRACE 391 <- [1,1,null,{"sessionId":"64d4d24e-c86b-4346-885a-539164bc95f8","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:50 INFO - 1499993210282 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
17:46:50 INFO - 1499993210285 Marionette TRACE 391 <- [1,2,null,{}]
17:46:50 INFO - 1499993210289 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:50 INFO - 1499993210292 Marionette TRACE 391 <- [1,3,null,{}]
17:46:50 INFO - 1499993210295 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:50 INFO - 1499993210297 Marionette TRACE 391 <- [1,4,null,{}]
17:46:50 INFO - 1499993210301 Marionette TRACE 391 -> [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}]
17:46:50 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499993210313 Marionette TRACE 391 <- [1,5,null,{"value":null}]
17:46:50 INFO - 1499993210317 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210324 Marionette TRACE 391 <- [1,6,null,{}]
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210353 Marionette DEBUG Closed connection 391
17:46:50 INFO - 1499993210356 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49835
17:46:50 INFO - 1499993210358 Marionette DEBUG Closed connection 392
17:46:50 INFO - 1499993210360 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49836
17:46:50 INFO - 1499993210363 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:50 INFO - 1499993210367 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:50 INFO - 1499993210418 Marionette DEBUG Register listener.js for window 15
17:46:50 INFO - 1499993210446 Marionette TRACE 393 <- [1,1,null,{"sessionId":"c2a02642-34c3-4e17-893c-3d0095a1ef0e","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:50 INFO - 1499993210467 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210477 Marionette TRACE 393 <- [1,2,null,{}]
17:46:50 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:50 INFO - 1499993210501 Marionette DEBUG Closed connection 393
17:46:50 INFO - 1499993210503 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49837
17:46:50 INFO - 1499993210537 Marionette DEBUG Closed connection 394
17:46:50 INFO - 1499993210540 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49838
17:46:50 INFO - 1499993210568 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:50 INFO - 1499993210572 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:50 INFO - 1499993210622 Marionette DEBUG Register listener.js for window 15
17:46:50 INFO - 1499993210639 Marionette TRACE 395 <- [1,1,null,{"sessionId":"c5ebda7f-5ddc-4ef2-9274-9f5f5fcbdf85","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:50 INFO - 1499993210654 Marionette TRACE 395 -> [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"}]
17:46:50 INFO - 1499993210660 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:46:50 INFO - 1499993210672 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:46:50 INFO - 1499993210673 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
17:46:50 INFO - ++DOMWINDOW == 27 (000000355132B000) [pid = 2096] [serial = 47] [outer = 00000035581E1800]
17:46:50 INFO - 1499993210754 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"
17:46:50 INFO - 1499993210763 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"
17:46:50 INFO - 1499993210783 Marionette TRACE 395 <- [1,2,null,{}]
17:46:50 INFO - 1499993210786 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
17:46:50 INFO - 1499993210799 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"888b34a7-36a1-471f-ac57-e5b80a24f944","ELEMENT":"888b34a7-36a1-471f-ac57-e5b80a24f944"}}]
17:46:50 INFO - 1499993210802 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
17:46:50 INFO - 1499993210811 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"726105f3-0720-42e6-815b-daf3eda8e17e","ELEMENT":"726105f3-0720-42e6-815b-daf3eda8e17e"}}]
17:46:50 INFO - 1499993210813 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"888b34a7-36a1-471f-ac57-e5b80a24f944"}]
17:46:51 INFO - 1499993211432 Marionette DEBUG Canceled page load listener because no navigation has been detected
17:46:51 INFO - 1499993211434 Marionette TRACE 395 <- [1,5,null,{}]
17:46:51 INFO - 1499993211438 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"726105f3-0720-42e6-815b-daf3eda8e17e"}]
17:46:51 INFO - 1499993211769 Marionette TRACE 395 <- [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]
17:46:51 INFO - 1499993211789 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
17:46:51 INFO - 1499993211806 Marionette TRACE 395 <- [1,7,null,{"value":false}]
17:46:51 INFO - 1499993211844 Marionette TRACE 395 -> [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}]
17:46:51 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499993211869 Marionette TRACE 395 <- [1,8,null,{"value":null}]
17:46:51 INFO - 1499993211881 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
17:46:51 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:51 INFO - 1499993211886 Marionette TRACE 395 <- [1,9,null,{}]
17:46:51 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1776ms
17:46:51 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
17:46:51 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:51 INFO - 1499993211902 Marionette DEBUG Closed connection 395
17:46:51 INFO - 1499993211905 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49839
17:46:51 INFO - 1499993211942 Marionette DEBUG Closed connection 396
17:46:51 INFO - 1499993211945 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49840
17:46:51 INFO - 1499993211979 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:51 INFO - 1499993211982 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:52 INFO - 1499993212035 Marionette DEBUG Register listener.js for window 15
17:46:52 INFO - 1499993212051 Marionette TRACE 397 <- [1,1,null,{"sessionId":"b515cba6-da1d-43b3-97ff-cdb33c396c6f","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:52 INFO - 1499993212063 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
17:46:52 INFO - 1499993212065 Marionette TRACE 397 <- [1,2,null,{}]
17:46:52 INFO - 1499993212116 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
17:46:52 INFO - 1499993212118 Marionette TRACE 397 <- [1,3,null,{}]
17:46:52 INFO - 1499993212121 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
17:46:52 INFO - 1499993212124 Marionette TRACE 397 <- [1,4,null,{}]
17:46:52 INFO - 1499993212126 Marionette TRACE 397 -> [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}]
17:46:52 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499993212142 Marionette TRACE 397 <- [1,5,null,{"value":null}]
17:46:52 INFO - 1499993212155 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
17:46:52 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:52 INFO - 1499993212160 Marionette TRACE 397 <- [1,6,null,{}]
17:46:52 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:52 INFO - 1499993212186 Marionette DEBUG Closed connection 397
17:46:52 INFO - 1499993212188 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49841
17:46:52 INFO - 1499993212193 Marionette DEBUG Closed connection 398
17:46:52 INFO - 1499993212195 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49842
17:46:52 INFO - 1499993212362 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
17:46:52 INFO - 1499993212375 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:52 INFO - 1499993212405 Marionette DEBUG Register listener.js for window 15
17:46:52 INFO - 1499993212427 Marionette TRACE 399 <- [1,1,null,{"sessionId":"9716f666-d5c9-4ac5-8065-b29a3bce0c55","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:52 INFO - 1499993212444 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
17:46:52 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:52 INFO - 1499993212450 Marionette TRACE 399 <- [1,2,null,{}]
17:46:52 INFO - [Parent 2096] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
17:46:52 INFO - 1499993212509 Marionette DEBUG Closed connection 399
17:46:52 INFO - 1499993212511 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49843
17:46:52 INFO - 1499993212535 Marionette DEBUG Closed connection 400
17:46:52 INFO - 1499993212538 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49844
17:46:52 INFO - 1499993212544 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
17:46:52 INFO - 1499993212551 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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}
17:46:52 INFO - 1499993212581 Marionette DEBUG Register listener.js for window 15
17:46:52 INFO - 1499993212600 Marionette TRACE 401 <- [1,1,null,{"sessionId":"444cb9a2-ab28-4b86-a3d7-9ce3d89d652f","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":2096,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-179.001\\AppData\\Local\\Temp\\tmpwiv2og.mozrunner","moz:accessibilityChecks":false}}]
17:46:52 INFO - 1499993212642 Marionette TRACE 401 -> [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"}]
17:46:52 INFO - 1499993212650 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"
17:46:52 INFO - 1499993212661 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"
17:46:52 INFO - 1499993212662 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"
17:46:52 INFO - ++DOMWINDOW == 28 (000000354C907800) [pid = 2096] [serial = 48] [outer = 00000035581E1800]
17:46:52 INFO - 1499993212724 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"
17:46:52 INFO - 1499993212732 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"
17:46:52 INFO - 1499993212751 Marionette TRACE 401 <- [1,2,null,{}]
17:46:52 INFO - 1499993212756 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
17:46:52 INFO - 1499993212768 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0f14af1b-4f7d-43bd-af34-bd2cc6b22b6f","ELEMENT":"0f14af1b-4f7d-43bd-af34-bd2cc6b22b6f"}}]
17:46:52 INFO - 1499993212771 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0f14af1b-4f7d-43bd-af34-bd2cc6b22b6f"}]
17:46:52 INFO - 1499993212904 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
17:46:52 INFO - 1499993212923 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"0f14af1b-4f7d-43bd-af34-bd2cc6b22b6f"}]
17:46:53 INFO - 1499993213077 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element