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]
05:45:52 INFO - 1500554752374 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
05:45:52 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500554752382 Marionette TRACE 352 <- [1,5,null,{"value":null}]
05:45:52 INFO - 1500554752384 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752389 Marionette TRACE 352 <- [1,6,null,{}]
05:45:52 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 615ms
05:45:52 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752395 Marionette DEBUG Closed connection 352
05:45:52 INFO - 1500554752396 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49780
05:45:52 INFO - 1500554752415 Marionette DEBUG Closed connection 353
05:45:52 INFO - 1500554752417 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49781
05:45:52 INFO - 1500554752419 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:52 INFO - 1500554752422 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:52 INFO - 1500554752443 Marionette DEBUG Register listener.js for window 15
05:45:52 INFO - 1500554752455 Marionette TRACE 354 <- [1,1,null,{"sessionId":"8398685e-5ff9-4ed9-8244-a63323813848","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:52 INFO - 1500554752465 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
05:45:52 INFO - 1500554752466 Marionette TRACE 354 <- [1,2,null,{}]
05:45:52 INFO - 1500554752468 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:52 INFO - 1500554752470 Marionette TRACE 354 <- [1,3,null,{}]
05:45:52 INFO - 1500554752472 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:52 INFO - 1500554752474 Marionette TRACE 354 <- [1,4,null,{}]
05:45:52 INFO - 1500554752477 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
05:45:52 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500554752484 Marionette TRACE 354 <- [1,5,null,{"value":null}]
05:45:52 INFO - 1500554752486 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752491 Marionette TRACE 354 <- [1,6,null,{}]
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752513 Marionette DEBUG Closed connection 354
05:45:52 INFO - 1500554752514 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49782
05:45:52 INFO - 1500554752518 Marionette DEBUG Closed connection 355
05:45:52 INFO - 1500554752519 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49783
05:45:52 INFO - 1500554752521 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:52 INFO - 1500554752525 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:52 INFO - 1500554752549 Marionette DEBUG Register listener.js for window 15
05:45:52 INFO - 1500554752565 Marionette TRACE 356 <- [1,1,null,{"sessionId":"55a28ae6-35c9-4bf1-bf9b-23d8c22aa476","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:52 INFO - 1500554752576 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752580 Marionette TRACE 356 <- [1,2,null,{}]
05:45:52 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:52 INFO - 1500554752586 Marionette DEBUG Closed connection 356
05:45:52 INFO - 1500554752588 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49784
05:45:52 INFO - 1500554752589 Marionette DEBUG Closed connection 357
05:45:52 INFO - 1500554752591 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49785
05:45:52 INFO - 1500554752593 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:52 INFO - 1500554752595 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:52 INFO - 1500554752616 Marionette DEBUG Register listener.js for window 15
05:45:52 INFO - 1500554752627 Marionette TRACE 358 <- [1,1,null,{"sessionId":"cc12f222-4bd7-46cb-aa83-eaebbcf71843","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:52 INFO - 1500554752652 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49330/clicks.html"}]
05:45:52 INFO - 1500554752656 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/hidden.html"
05:45:52 INFO - 1500554752678 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/hidden.html"
05:45:52 INFO - 1500554752679 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/hidden.html"
05:45:52 INFO - ++DOMWINDOW == 20 (000000E599863800) [pid = 648] [serial = 40] [outer = 000000E599DC2000]
05:45:52 INFO - 1500554752747 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/clicks.html"
05:45:52 INFO - 1500554752754 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/clicks.html"
05:45:52 INFO - 1500554752774 Marionette TRACE 358 <- [1,2,null,{}]
05:45:52 INFO - 1500554752777 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
05:45:52 INFO - 1500554752787 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4faed615-7a10-4b52-913a-69dc95654c72","ELEMENT":"4faed615-7a10-4b52-913a-69dc95654c72"}}]
05:45:52 INFO - 1500554752789 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"4faed615-7a10-4b52-913a-69dc95654c72"}]
05:45:53 INFO - 1500554753014 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/clicks.html"
05:45:53 INFO - [Parent 648] 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
05:45:53 INFO - 1500554753031 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/clicks.html"
05:45:53 INFO - 1500554753032 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/clicks.html"
05:45:53 INFO - ++DOMWINDOW == 21 (000000E599866000) [pid = 648] [serial = 41] [outer = 000000E599DC2000]
05:45:53 INFO - 1500554753094 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49330/test.html"
05:45:53 INFO - 1500554753098 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49330/test.html"
05:45:53 INFO - 1500554753114 Marionette TRACE 358 <- [1,4,null,{}]
05:45:53 INFO - 1500554753124 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
05:45:53 INFO - 1500554753131 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2202e034-128d-4923-9c39-1c7db31ad0fb","ELEMENT":"2202e034-128d-4923-9c39-1c7db31ad0fb"}}]
05:45:53 INFO - 1500554753133 Marionette TRACE 358 -> [0,6,"getTitle",{}]
05:45:53 INFO - 1500554753134 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
05:45:53 INFO - 1500554753138 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
05:45:53 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500554753145 Marionette TRACE 358 <- [1,7,null,{"value":null}]
05:45:53 INFO - 1500554753147 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
05:45:53 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:53 INFO - 1500554753152 Marionette TRACE 358 <- [1,8,null,{}]
05:45:53 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 763ms
05:45:53 INFO - TEST-START | test_click.py TestClick.test_container_element
05:45:53 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:53 INFO - 1500554753158 Marionette DEBUG Closed connection 358
05:45:53 INFO - 1500554753159 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49788
05:45:53 INFO - 1500554753161 Marionette DEBUG Closed connection 359
05:45:53 INFO - 1500554753162 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49789
05:45:53 INFO - 1500554753165 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:53 INFO - 1500554753167 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:53 INFO - 1500554753187 Marionette DEBUG Register listener.js for window 15
05:45:53 INFO - 1500554753198 Marionette TRACE 360 <- [1,1,null,{"sessionId":"488538e7-abdb-4af7-b890-18141d6f22b1","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:53 INFO - 1500554753227 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
05:45:53 INFO - 1500554753228 Marionette TRACE 360 <- [1,2,null,{}]
05:45:53 INFO - 1500554753231 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:53 INFO - 1500554753232 Marionette TRACE 360 <- [1,3,null,{}]
05:45:53 INFO - 1500554753826 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:53 INFO - 1500554753828 Marionette TRACE 360 <- [1,4,null,{}]
05:45:53 INFO - 1500554753878 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
05:45:53 INFO - TEST-START: test_click.py TestClick.test_container_element1500554753889 Marionette TRACE 360 <- [1,5,null,{"value":null}]
05:45:53 INFO - 1500554753904 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
05:45:53 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:53 INFO - 1500554753908 Marionette TRACE 360 <- [1,6,null,{}]
05:45:53 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:53 INFO - 1500554753933 Marionette DEBUG Closed connection 360
05:45:53 INFO - 1500554753934 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49790
05:45:53 INFO - 1500554753936 Marionette DEBUG Closed connection 361
05:45:53 INFO - 1500554753937 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49791
05:45:53 INFO - 1500554753940 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:53 INFO - 1500554753942 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:53 INFO - 1500554753962 Marionette DEBUG Register listener.js for window 15
05:45:53 INFO - 1500554753976 Marionette TRACE 362 <- [1,1,null,{"sessionId":"708db95e-e90e-4a54-b592-82372c6546cf","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:53 INFO - 1500554753987 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
05:45:53 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:53 INFO - 1500554753992 Marionette TRACE 362 <- [1,2,null,{}]
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:54 INFO - 1500554753998 Marionette DEBUG Closed connection 362
05:45:54 INFO - 1500554753999 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49792
05:45:54 INFO - 1500554754001 Marionette DEBUG Closed connection 363
05:45:54 INFO - 1500554754002 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49793
05:45:54 INFO - 1500554754004 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:54 INFO - 1500554754007 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:54 INFO - 1500554754028 Marionette DEBUG Register listener.js for window 15
05:45:54 INFO - 1500554754039 Marionette TRACE 364 <- [1,1,null,{"sessionId":"0b954c30-be6f-430e-b1e0-05045c8b69df","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:54 INFO - 1500554754064 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
05:45:54 INFO - 1500554754068 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49330/test.html"
05:45:54 INFO - 1500554754073 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49330/test.html"
05:45:54 INFO - 1500554754074 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49330/test.html"
05:45:54 INFO - ++DOMWINDOW == 22 (000000E599DB7800) [pid = 648] [serial = 42] [outer = 000000E599DC2000]
05:45:54 INFO - 1500554754125 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"
05:45:54 INFO - 1500554754133 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"
05:45:54 INFO - 1500554754148 Marionette TRACE 364 <- [1,2,null,{}]
05:45:54 INFO - 1500554754155 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
05:45:54 INFO - 1500554754162 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"97c694a5-06bc-447b-9918-926d00fe6b87","ELEMENT":"97c694a5-06bc-447b-9918-926d00fe6b87"}}]
05:45:54 INFO - 1500554754166 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"97c694a5-06bc-447b-9918-926d00fe6b87"}]
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
05:45:54 INFO - 1500554754572 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:45:54 INFO - 1500554754575 Marionette TRACE 364 <- [1,4,null,{}]
05:45:54 INFO - 1500554754579 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"97c694a5-06bc-447b-9918-926d00fe6b87","name":"selected"}]
05:45:54 INFO - 1500554754620 Marionette TRACE 364 <- [1,5,null,{"value":true}]
05:45:54 INFO - 1500554754631 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
05:45:54 INFO - TEST-END: test_click.py TestClick.test_container_element1500554754645 Marionette TRACE 364 <- [1,6,null,{"value":null}]
05:45:54 INFO - 1500554754699 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:54 INFO - 1500554754708 Marionette TRACE 364 <- [1,7,null,{}]
05:45:54 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1557ms
05:45:54 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:54 INFO - 1500554754719 Marionette DEBUG Closed connection 364
05:45:54 INFO - 1500554754722 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49794
05:45:54 INFO - 1500554754726 Marionette DEBUG Closed connection 365
05:45:54 INFO - 1500554754730 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49795
05:45:54 INFO - 1500554754753 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:54 INFO - 1500554754763 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:54 INFO - 1500554754804 Marionette DEBUG Register listener.js for window 15
05:45:54 INFO - 1500554754828 Marionette TRACE 366 <- [1,1,null,{"sessionId":"9a794c39-ae5c-49e1-a0aa-6046f822f223","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:54 INFO - 1500554754857 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
05:45:54 INFO - 1500554754862 Marionette TRACE 366 <- [1,2,null,{}]
05:45:54 INFO - 1500554754865 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:54 INFO - 1500554754868 Marionette TRACE 366 <- [1,3,null,{}]
05:45:54 INFO - 1500554754915 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:54 INFO - 1500554754917 Marionette TRACE 366 <- [1,4,null,{}]
05:45:54 INFO - 1500554754922 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
05:45:54 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500554754934 Marionette TRACE 366 <- [1,5,null,{"value":null}]
05:45:54 INFO - 1500554754939 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
05:45:54 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:54 INFO - 1500554754945 Marionette TRACE 366 <- [1,6,null,{}]
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:55 INFO - 1500554755109 Marionette DEBUG Closed connection 366
05:45:55 INFO - 1500554755112 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49796
05:45:55 INFO - 1500554755144 Marionette DEBUG Closed connection 367
05:45:55 INFO - 1500554755147 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49797
05:45:55 INFO - 1500554755169 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:55 INFO - 1500554755180 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:55 INFO - 1500554755204 Marionette DEBUG Register listener.js for window 15
05:45:55 INFO - 1500554755226 Marionette TRACE 368 <- [1,1,null,{"sessionId":"1a646343-5311-4a49-9f19-f942cfac7a1a","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:55 INFO - 1500554755239 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:55 INFO - 1500554755246 Marionette TRACE 368 <- [1,2,null,{}]
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:55 INFO - 1500554755285 Marionette DEBUG Closed connection 368
05:45:55 INFO - 1500554755290 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49798
05:45:55 INFO - 1500554755296 Marionette DEBUG Closed connection 369
05:45:55 INFO - 1500554755300 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49799
05:45:55 INFO - 1500554755363 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:55 INFO - 1500554755368 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:55 INFO - 1500554755392 Marionette DEBUG Register listener.js for window 15
05:45:55 INFO - 1500554755412 Marionette TRACE 370 <- [1,1,null,{"sessionId":"016dfa10-9562-440f-b4fc-ed03447fe89e","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:55 INFO - 1500554755425 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
05:45:55 INFO - 1500554755432 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"
05:45:55 INFO - 1500554755440 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"
05:45:55 INFO - 1500554755441 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"
05:45:55 INFO - ++DOMWINDOW == 23 (000000E58D613800) [pid = 648] [serial = 43] [outer = 000000E599DC2000]
05:45:55 INFO - 1500554755509 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"
05:45:55 INFO - 1500554755516 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"
05:45:55 INFO - 1500554755542 Marionette TRACE 370 <- [1,2,null,{}]
05:45:55 INFO - 1500554755546 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
05:45:55 INFO - 1500554755559 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"1213f826-f02c-4c86-a121-846461493afd","ELEMENT":"1213f826-f02c-4c86-a121-846461493afd"}}]
05:45:55 INFO - 1500554755561 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"1213f826-f02c-4c86-a121-846461493afd"}]
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
05:45:55 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
05:45:55 INFO - --DOMWINDOW == 22 (000000E58E044000) [pid = 648] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
05:45:55 INFO - --DOMWINDOW == 21 (000000E5A46E1800) [pid = 648] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49330/test_accessibility.html]
05:45:55 INFO - --DOMWINDOW == 20 (000000E59383C000) [pid = 648] [serial = 32] [outer = 0000000000000000] [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%20position%3A%20absolute%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%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%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]
05:45:55 INFO - --DOMWINDOW == 19 (000000E5943DC800) [pid = 648] [serial = 33] [outer = 0000000000000000] [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%20position%3A%20absolute%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%20/%2A%20move%20centre%20point%20off%20viewport%20horizontally%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%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]
05:45:56 INFO - 1500554756554 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:45:56 INFO - 1500554756592 Marionette TRACE 370 <- [1,4,null,{}]
05:45:56 INFO - 1500554756637 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"1213f826-f02c-4c86-a121-846461493afd","name":"selected"}]
05:45:56 INFO - 1500554756661 Marionette TRACE 370 <- [1,5,null,{"value":true}]
05:45:56 INFO - 1500554756705 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
05:45:56 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500554756716 Marionette TRACE 370 <- [1,6,null,{"value":null}]
05:45:56 INFO - 1500554756718 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
05:45:56 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:56 INFO - 1500554756724 Marionette TRACE 370 <- [1,7,null,{}]
05:45:56 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 2015ms
05:45:56 INFO - TEST-START | test_click.py TestClick.test_css_transforms
05:45:56 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:56 INFO - 1500554756732 Marionette DEBUG Closed connection 370
05:45:56 INFO - 1500554756734 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49800
05:45:56 INFO - 1500554756736 Marionette DEBUG Closed connection 371
05:45:56 INFO - 1500554756738 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49801
05:45:56 INFO - 1500554756741 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:56 INFO - 1500554756745 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:56 INFO - 1500554756768 Marionette DEBUG Register listener.js for window 15
05:45:56 INFO - 1500554756827 Marionette TRACE 372 <- [1,1,null,{"sessionId":"525a0113-7af1-41e8-b8a3-104345eb8917","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:56 INFO - 1500554756889 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
05:45:56 INFO - 1500554756895 Marionette TRACE 372 <- [1,2,null,{}]
05:45:56 INFO - 1500554756931 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:56 INFO - 1500554756933 Marionette TRACE 372 <- [1,3,null,{}]
05:45:56 INFO - 1500554756948 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:56 INFO - 1500554756951 Marionette TRACE 372 <- [1,4,null,{}]
05:45:56 INFO - 1500554756954 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
05:45:56 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500554756965 Marionette TRACE 372 <- [1,5,null,{"value":null}]
05:45:56 INFO - 1500554756968 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
05:45:56 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:56 INFO - 1500554756973 Marionette TRACE 372 <- [1,6,null,{}]
05:45:56 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:56 INFO - 1500554756994 Marionette DEBUG Closed connection 372
05:45:56 INFO - 1500554756996 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49802
05:45:57 INFO - 1500554757000 Marionette DEBUG Closed connection 373
05:45:57 INFO - 1500554757003 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49803
05:45:57 INFO - 1500554757005 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:57 INFO - 1500554757008 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:57 INFO - 1500554757030 Marionette DEBUG Register listener.js for window 15
05:45:57 INFO - 1500554757043 Marionette TRACE 374 <- [1,1,null,{"sessionId":"618a357e-d909-4331-a0d1-2f46e76f914e","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:57 INFO - 1500554757055 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757060 Marionette TRACE 374 <- [1,2,null,{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757080 Marionette DEBUG Closed connection 374
05:45:57 INFO - 1500554757082 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49804
05:45:57 INFO - 1500554757086 Marionette DEBUG Closed connection 375
05:45:57 INFO - 1500554757087 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49805
05:45:57 INFO - 1500554757090 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:57 INFO - 1500554757096 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:57 INFO - 1500554757117 Marionette DEBUG Register listener.js for window 15
05:45:57 INFO - 1500554757133 Marionette TRACE 376 <- [1,1,null,{"sessionId":"efa69059-8f07-456a-81c3-0a7abffa638d","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:57 INFO - 1500554757143 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
05:45:57 INFO - 1500554757147 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"
05:45:57 INFO - 1500554757154 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"
05:45:57 INFO - 1500554757155 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"
05:45:57 INFO - ++DOMWINDOW == 20 (000000E5923D1000) [pid = 648] [serial = 44] [outer = 000000E599DC2000]
05:45:57 INFO - 1500554757219 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"
05:45:57 INFO - 1500554757224 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"
05:45:57 INFO - 1500554757236 Marionette TRACE 376 <- [1,2,null,{}]
05:45:57 INFO - 1500554757248 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
05:45:57 INFO - 1500554757256 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b78820e7-8262-42e9-89fa-320f21794945","ELEMENT":"b78820e7-8262-42e9-89fa-320f21794945"}}]
05:45:57 INFO - 1500554757258 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"b78820e7-8262-42e9-89fa-320f21794945"}]
05:45:57 INFO - 1500554757679 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:45:57 INFO - 1500554757681 Marionette TRACE 376 <- [1,4,null,{}]
05:45:57 INFO - 1500554757683 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
05:45:57 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500554757691 Marionette TRACE 376 <- [1,5,null,{"value":null}]
05:45:57 INFO - 1500554757694 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757698 Marionette TRACE 376 <- [1,6,null,{}]
05:45:57 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 973ms
05:45:57 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757706 Marionette DEBUG Closed connection 376
05:45:57 INFO - 1500554757712 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49806
05:45:57 INFO - 1500554757714 Marionette DEBUG Closed connection 377
05:45:57 INFO - 1500554757715 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49807
05:45:57 INFO - 1500554757718 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:57 INFO - 1500554757720 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:57 INFO - 1500554757742 Marionette DEBUG Register listener.js for window 15
05:45:57 INFO - 1500554757778 Marionette TRACE 378 <- [1,1,null,{"sessionId":"15325385-8393-4701-a3ce-dcc44714ceae","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:57 INFO - 1500554757786 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
05:45:57 INFO - 1500554757788 Marionette TRACE 378 <- [1,2,null,{}]
05:45:57 INFO - 1500554757790 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:57 INFO - 1500554757792 Marionette TRACE 378 <- [1,3,null,{}]
05:45:57 INFO - 1500554757794 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:57 INFO - 1500554757795 Marionette TRACE 378 <- [1,4,null,{}]
05:45:57 INFO - 1500554757798 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
05:45:57 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500554757810 Marionette TRACE 378 <- [1,5,null,{"value":null}]
05:45:57 INFO - 1500554757812 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757817 Marionette TRACE 378 <- [1,6,null,{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757823 Marionette DEBUG Closed connection 378
05:45:57 INFO - 1500554757824 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49808
05:45:57 INFO - 1500554757826 Marionette DEBUG Closed connection 379
05:45:57 INFO - 1500554757827 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49809
05:45:57 INFO - 1500554757829 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:57 INFO - 1500554757832 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:57 INFO - 1500554757853 Marionette DEBUG Register listener.js for window 15
05:45:57 INFO - 1500554757865 Marionette TRACE 380 <- [1,1,null,{"sessionId":"263ea556-e6e3-436e-a070-7dd3def4b1e1","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:57 INFO - 1500554757871 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757876 Marionette TRACE 380 <- [1,2,null,{}]
05:45:57 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:57 INFO - 1500554757882 Marionette DEBUG Closed connection 380
05:45:57 INFO - 1500554757883 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49810
05:45:57 INFO - 1500554757885 Marionette DEBUG Closed connection 381
05:45:57 INFO - 1500554757886 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49811
05:45:57 INFO - 1500554757888 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:57 INFO - 1500554757892 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:57 INFO - 1500554757913 Marionette DEBUG Register listener.js for window 15
05:45:57 INFO - 1500554757925 Marionette TRACE 382 <- [1,1,null,{"sessionId":"04499e82-3271-4871-8b49-a0a3f2e11346","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:57 INFO - 1500554757932 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
05:45:57 INFO - 1500554757936 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"
05:45:57 INFO - 1500554757941 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"
05:45:57 INFO - 1500554757942 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"
05:45:57 INFO - ++DOMWINDOW == 21 (000000E598069800) [pid = 648] [serial = 45] [outer = 000000E599DC2000]
05:45:58 INFO - 1500554757996 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"
05:45:58 INFO - 1500554758007 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"
05:45:58 INFO - 1500554758016 Marionette TRACE 382 <- [1,2,null,{}]
05:45:58 INFO - 1500554758026 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
05:45:58 INFO - 1500554758037 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"79bd7008-7c36-4e07-9323-4200e78c7105","ELEMENT":"79bd7008-7c36-4e07-9323-4200e78c7105"}}]
05:45:58 INFO - 1500554758086 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"79bd7008-7c36-4e07-9323-4200e78c7105"}]
05:45:58 INFO - 1500554758516 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:45:58 INFO - 1500554758518 Marionette TRACE 382 <- [1,4,null,{}]
05:45:58 INFO - 1500554758521 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
05:45:58 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500554758529 Marionette TRACE 382 <- [1,5,null,{"value":null}]
05:45:58 INFO - 1500554758531 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758535 Marionette TRACE 382 <- [1,6,null,{}]
05:45:58 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 837ms
05:45:58 INFO - TEST-START | test_click.py TestClick.test_input_file
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758541 Marionette DEBUG Closed connection 382
05:45:58 INFO - 1500554758543 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49812
05:45:58 INFO - 1500554758545 Marionette DEBUG Closed connection 383
05:45:58 INFO - 1500554758546 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49813
05:45:58 INFO - 1500554758548 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:58 INFO - 1500554758551 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:58 INFO - 1500554758572 Marionette DEBUG Register listener.js for window 15
05:45:58 INFO - 1500554758584 Marionette TRACE 384 <- [1,1,null,{"sessionId":"53ba055c-1155-4472-9459-ae057c0d763a","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:58 INFO - 1500554758590 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
05:45:58 INFO - 1500554758592 Marionette TRACE 384 <- [1,2,null,{}]
05:45:58 INFO - 1500554758594 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:58 INFO - 1500554758595 Marionette TRACE 384 <- [1,3,null,{}]
05:45:58 INFO - 1500554758597 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:58 INFO - 1500554758599 Marionette TRACE 384 <- [1,4,null,{}]
05:45:58 INFO - 1500554758601 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
05:45:58 INFO - TEST-START: test_click.py TestClick.test_input_file1500554758610 Marionette TRACE 384 <- [1,5,null,{"value":null}]
05:45:58 INFO - 1500554758612 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758616 Marionette TRACE 384 <- [1,6,null,{}]
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758622 Marionette DEBUG Closed connection 384
05:45:58 INFO - 1500554758624 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49814
05:45:58 INFO - 1500554758625 Marionette DEBUG Closed connection 385
05:45:58 INFO - 1500554758627 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49815
05:45:58 INFO - 1500554758629 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:58 INFO - 1500554758631 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:58 INFO - 1500554758653 Marionette DEBUG Register listener.js for window 15
05:45:58 INFO - 1500554758664 Marionette TRACE 386 <- [1,1,null,{"sessionId":"dcb5a4de-1694-4de9-95ab-6d31f67d84c3","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:58 INFO - 1500554758671 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758675 Marionette TRACE 386 <- [1,2,null,{}]
05:45:58 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:58 INFO - 1500554758680 Marionette DEBUG Closed connection 386
05:45:58 INFO - 1500554758682 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49816
05:45:58 INFO - 1500554758683 Marionette DEBUG Closed connection 387
05:45:58 INFO - 1500554758685 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49817
05:45:58 INFO - 1500554758687 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:58 INFO - 1500554758691 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:58 INFO - 1500554758717 Marionette DEBUG Register listener.js for window 15
05:45:58 INFO - 1500554758731 Marionette TRACE 388 <- [1,1,null,{"sessionId":"a75e010b-afc7-4090-b670-65498997b067","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:58 INFO - 1500554758737 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
05:45:58 INFO - 1500554758741 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"
05:45:58 INFO - 1500554758747 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"
05:45:58 INFO - 1500554758749 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"
05:45:58 INFO - ++DOMWINDOW == 22 (000000E5983A0800) [pid = 648] [serial = 46] [outer = 000000E599DC2000]
05:45:58 INFO - 1500554758873 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:45:58 INFO - 1500554758878 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:45:58 INFO - 1500554758895 Marionette TRACE 388 <- [1,2,null,{}]
05:45:58 INFO - 1500554758899 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
05:45:58 INFO - 1500554758907 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"89eed1f3-702f-4b4a-b0f9-9b1919c168e6","ELEMENT":"89eed1f3-702f-4b4a-b0f9-9b1919c168e6"}}]
05:45:58 INFO - 1500554758909 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"89eed1f3-702f-4b4a-b0f9-9b1919c168e6"}]
05:45:59 INFO - 1500554759047 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
05:45:59 INFO - 1500554759064 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
05:45:59 INFO - TEST-END: test_click.py TestClick.test_input_file1500554759073 Marionette TRACE 388 <- [1,5,null,{"value":null}]
05:45:59 INFO - 1500554759076 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759080 Marionette TRACE 388 <- [1,6,null,{}]
05:45:59 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 545ms
05:45:59 INFO - TEST-START | test_click.py TestClick.test_obscured_element
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759671 Marionette DEBUG Closed connection 388
05:45:59 INFO - 1500554759672 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49818
05:45:59 INFO - 1500554759675 Marionette DEBUG Closed connection 389
05:45:59 INFO - 1500554759690 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49819
05:45:59 INFO - 1500554759692 Marionette DEBUG Closed connection 390
05:45:59 INFO - 1500554759693 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49820
05:45:59 INFO - 1500554759696 Marionette TRACE 391 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:59 INFO - 1500554759698 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:59 INFO - 1500554759720 Marionette DEBUG Register listener.js for window 15
05:45:59 INFO - 1500554759739 Marionette TRACE 391 <- [1,1,null,{"sessionId":"50e7e7d5-375b-4c43-a2a2-c9626a546d01","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:59 INFO - 1500554759758 Marionette TRACE 391 -> [0,2,"setTimeouts",{"script":30000}]
05:45:59 INFO - 1500554759760 Marionette TRACE 391 <- [1,2,null,{}]
05:45:59 INFO - 1500554759762 Marionette TRACE 391 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:45:59 INFO - 1500554759764 Marionette TRACE 391 <- [1,3,null,{}]
05:45:59 INFO - 1500554759766 Marionette TRACE 391 -> [0,4,"setTimeouts",{"implicit":0}]
05:45:59 INFO - 1500554759768 Marionette TRACE 391 <- [1,4,null,{}]
05:45:59 INFO - 1500554759770 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}]
05:45:59 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500554759778 Marionette TRACE 391 <- [1,5,null,{"value":null}]
05:45:59 INFO - 1500554759780 Marionette TRACE 391 -> [0,6,"deleteSession",{}]
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759784 Marionette TRACE 391 <- [1,6,null,{}]
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759790 Marionette DEBUG Closed connection 391
05:45:59 INFO - 1500554759791 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49821
05:45:59 INFO - 1500554759792 Marionette DEBUG Closed connection 392
05:45:59 INFO - 1500554759794 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49822
05:45:59 INFO - 1500554759796 Marionette TRACE 393 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:45:59 INFO - 1500554759798 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:59 INFO - 1500554759820 Marionette DEBUG Register listener.js for window 15
05:45:59 INFO - 1500554759831 Marionette TRACE 393 <- [1,1,null,{"sessionId":"f0386bee-9c87-4256-a1eb-64cd74619f2e","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:59 INFO - 1500554759837 Marionette TRACE 393 -> [0,2,"deleteSession",{}]
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759841 Marionette TRACE 393 <- [1,2,null,{}]
05:45:59 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:45:59 INFO - 1500554759847 Marionette DEBUG Closed connection 393
05:45:59 INFO - 1500554759848 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49823
05:45:59 INFO - 1500554759850 Marionette DEBUG Closed connection 394
05:45:59 INFO - 1500554759851 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49824
05:45:59 INFO - 1500554759853 Marionette TRACE 395 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:45:59 INFO - 1500554759856 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:45:59 INFO - 1500554759877 Marionette DEBUG Register listener.js for window 15
05:45:59 INFO - 1500554759889 Marionette TRACE 395 <- [1,1,null,{"sessionId":"87e0b887-1c17-4bb9-91cc-8f4f6fd6714c","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:45:59 INFO - 1500554759896 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"}]
05:45:59 INFO - 1500554759900 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:45:59 INFO - 1500554759906 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:45:59 INFO - 1500554759907 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:45:59 INFO - ++DOMWINDOW == 23 (000000E599658800) [pid = 648] [serial = 47] [outer = 000000E599DC2000]
05:45:59 INFO - 1500554759963 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"
05:45:59 INFO - 1500554759969 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"
05:45:59 INFO - 1500554759983 Marionette TRACE 395 <- [1,2,null,{}]
05:45:59 INFO - 1500554759986 Marionette TRACE 395 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
05:45:59 INFO - 1500554759992 Marionette TRACE 395 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f8ac034d-c231-4490-a798-f3a4fea17118","ELEMENT":"f8ac034d-c231-4490-a798-f3a4fea17118"}}]
05:45:59 INFO - 1500554759995 Marionette TRACE 395 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
05:46:00 INFO - 1500554760003 Marionette TRACE 395 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"af7c3d55-0fed-47f4-9734-dc591b57c450","ELEMENT":"af7c3d55-0fed-47f4-9734-dc591b57c450"}}]
05:46:00 INFO - 1500554760005 Marionette TRACE 395 -> [0,5,"clickElement",{"id":"f8ac034d-c231-4490-a798-f3a4fea17118"}]
05:46:00 INFO - 1500554760417 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:46:00 INFO - 1500554760420 Marionette TRACE 395 <- [1,5,null,{}]
05:46:00 INFO - 1500554760474 Marionette TRACE 395 -> [0,6,"clickElement",{"id":"af7c3d55-0fed-47f4-9734-dc591b57c450"}]
05:46:00 INFO - 1500554760663 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]
05:46:00 INFO - 1500554760691 Marionette TRACE 395 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
05:46:00 INFO - 1500554760705 Marionette TRACE 395 <- [1,7,null,{"value":false}]
05:46:00 INFO - 1500554760710 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}]
05:46:00 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500554760724 Marionette TRACE 395 <- [1,8,null,{"value":null}]
05:46:00 INFO - 1500554760759 Marionette TRACE 395 -> [0,9,"deleteSession",{}]
05:46:00 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:00 INFO - 1500554760767 Marionette TRACE 395 <- [1,9,null,{}]
05:46:00 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1687ms
05:46:00 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
05:46:00 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:00 INFO - 1500554760795 Marionette DEBUG Closed connection 395
05:46:00 INFO - 1500554760799 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49825
05:46:00 INFO - 1500554760805 Marionette DEBUG Closed connection 396
05:46:00 INFO - 1500554760808 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49826
05:46:00 INFO - 1500554760861 Marionette TRACE 397 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:46:00 INFO - 1500554760871 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:46:00 INFO - 1500554760915 Marionette DEBUG Register listener.js for window 15
05:46:00 INFO - 1500554760967 Marionette TRACE 397 <- [1,1,null,{"sessionId":"27f035b2-4a19-4a47-b257-b95579cd2052","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:46:00 INFO - 1500554760998 Marionette TRACE 397 -> [0,2,"setTimeouts",{"script":30000}]
05:46:01 INFO - 1500554761001 Marionette TRACE 397 <- [1,2,null,{}]
05:46:01 INFO - 1500554761013 Marionette TRACE 397 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:46:01 INFO - 1500554761016 Marionette TRACE 397 <- [1,3,null,{}]
05:46:01 INFO - 1500554761023 Marionette TRACE 397 -> [0,4,"setTimeouts",{"implicit":0}]
05:46:01 INFO - 1500554761026 Marionette TRACE 397 <- [1,4,null,{}]
05:46:01 INFO - 1500554761051 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}]
05:46:01 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500554761066 Marionette TRACE 397 <- [1,5,null,{"value":null}]
05:46:01 INFO - 1500554761095 Marionette TRACE 397 -> [0,6,"deleteSession",{}]
05:46:01 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:01 INFO - 1500554761102 Marionette TRACE 397 <- [1,6,null,{}]
05:46:01 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:01 INFO - 1500554761113 Marionette DEBUG Closed connection 397
05:46:01 INFO - 1500554761116 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49827
05:46:01 INFO - 1500554761164 Marionette DEBUG Closed connection 398
05:46:01 INFO - 1500554761166 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49828
05:46:01 INFO - 1500554761192 Marionette TRACE 399 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:46:01 INFO - 1500554761198 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:46:01 INFO - 1500554761242 Marionette DEBUG Register listener.js for window 15
05:46:01 INFO - 1500554761260 Marionette TRACE 399 <- [1,1,null,{"sessionId":"0be782c9-6192-4ec9-ac67-59d08c750fd3","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:46:01 INFO - 1500554761273 Marionette TRACE 399 -> [0,2,"deleteSession",{}]
05:46:01 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:01 INFO - 1500554761280 Marionette TRACE 399 <- [1,2,null,{}]
05:46:01 INFO - [Parent 648] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
05:46:01 INFO - 1500554761293 Marionette DEBUG Closed connection 399
05:46:01 INFO - 1500554761295 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49829
05:46:01 INFO - 1500554761315 Marionette DEBUG Closed connection 400
05:46:01 INFO - 1500554761317 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49830
05:46:01 INFO - 1500554761321 Marionette TRACE 401 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:46:01 INFO - 1500554761325 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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}
05:46:01 INFO - 1500554761368 Marionette DEBUG Register listener.js for window 15
05:46:01 INFO - 1500554761386 Marionette TRACE 401 <- [1,1,null,{"sessionId":"ba3fdc1b-a82b-49a7-a193-3783808ea3ec","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":648,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-040.001\\AppData\\Local\\Temp\\tmpeqmlwt.mozrunner","moz:accessibilityChecks":false}}]
05:46:01 INFO - 1500554761419 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"}]
05:46:01 INFO - 1500554761426 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"
05:46:01 INFO - 1500554761434 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"
05:46:01 INFO - 1500554761435 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"
05:46:01 INFO - ++DOMWINDOW == 24 (000000E599860800) [pid = 648] [serial = 48] [outer = 000000E599DC2000]
05:46:01 INFO - 1500554761508 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"
05:46:01 INFO - 1500554761516 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"
05:46:01 INFO - 1500554761535 Marionette TRACE 401 <- [1,2,null,{}]
05:46:01 INFO - 1500554761545 Marionette TRACE 401 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
05:46:01 INFO - 1500554761554 Marionette TRACE 401 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"768b27d8-388b-432f-9d75-c973b9cf867f","ELEMENT":"768b27d8-388b-432f-9d75-c973b9cf867f"}}]
05:46:01 INFO - 1500554761557 Marionette TRACE 401 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"768b27d8-388b-432f-9d75-c973b9cf867f"}]
05:46:01 INFO - 1500554761738 Marionette TRACE 401 <- [1,4,null,{"value":"none"}]
05:46:01 INFO - 1500554761741 Marionette TRACE 401 -> [0,5,"clickElement",{"id":"768b27d8-388b-432f-9d75-c973b9cf867f"}]
05:46:01 INFO - 1500554761932 Marionette TRACE 401 <- [1,5,{"error":"element click intercepted","message":"Element