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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
05:07:16 INFO - 1499256436900 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:07:16 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499256436907 Marionette TRACE 352 <- [1,5,null,{"value":null}]
05:07:16 INFO - 1499256436909 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
05:07:16 INFO - [2736] 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:07:16 INFO - 1499256436913 Marionette TRACE 352 <- [1,6,null,{}]
05:07:16 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 661ms
05:07:16 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
05:07:16 INFO - [2736] 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:07:16 INFO - 1499256436919 Marionette DEBUG Closed connection 352
05:07:16 INFO - 1499256436921 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49792
05:07:16 INFO - 1499256436922 Marionette DEBUG Closed connection 353
05:07:16 INFO - 1499256436924 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49793
05:07:16 INFO - 1499256436947 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:16 INFO - 1499256436950 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:16 INFO - 1499256436972 Marionette DEBUG Register listener.js for window 12
05:07:16 INFO - 1499256436983 Marionette TRACE 354 <- [1,1,null,{"sessionId":"957ef1c1-a95e-43ea-b656-275b50b0bff6","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:16 INFO - 1499256436990 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
05:07:16 INFO - 1499256436992 Marionette TRACE 354 <- [1,2,null,{}]
05:07:16 INFO - 1499256436994 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:16 INFO - 1499256436995 Marionette TRACE 354 <- [1,3,null,{}]
05:07:16 INFO - 1499256436997 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:17 INFO - 1499256436998 Marionette TRACE 354 <- [1,4,null,{}]
05:07:17 INFO - 1499256437001 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:07:17 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499256437008 Marionette TRACE 354 <- [1,5,null,{"value":null}]
05:07:17 INFO - 1499256437010 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437014 Marionette TRACE 354 <- [1,6,null,{}]
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437039 Marionette DEBUG Closed connection 354
05:07:17 INFO - 1499256437041 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49794
05:07:17 INFO - 1499256437045 Marionette DEBUG Closed connection 355
05:07:17 INFO - 1499256437046 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49795
05:07:17 INFO - 1499256437048 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:17 INFO - 1499256437051 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:17 INFO - 1499256437073 Marionette DEBUG Register listener.js for window 12
05:07:17 INFO - 1499256437084 Marionette TRACE 356 <- [1,1,null,{"sessionId":"2eeec22b-e274-40e0-a49d-53c00ca351be","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:17 INFO - 1499256437091 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437095 Marionette TRACE 356 <- [1,2,null,{}]
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437117 Marionette DEBUG Closed connection 356
05:07:17 INFO - 1499256437119 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49796
05:07:17 INFO - 1499256437124 Marionette DEBUG Closed connection 357
05:07:17 INFO - 1499256437125 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49797
05:07:17 INFO - 1499256437128 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:17 INFO - 1499256437130 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:17 INFO - 1499256437153 Marionette DEBUG Register listener.js for window 12
05:07:17 INFO - 1499256437164 Marionette TRACE 358 <- [1,1,null,{"sessionId":"ae74858a-8cd0-43ce-8884-53787a614a6d","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:17 INFO - 1499256437171 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49334/clicks.html"}]
05:07:17 INFO - 1499256437175 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/hidden.html"
05:07:17 INFO - 1499256437193 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/hidden.html"
05:07:17 INFO - 1499256437194 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/hidden.html"
05:07:17 INFO - ++DOMWINDOW == 28 (0000002D4A307000) [pid = 2736] [serial = 44] [outer = 0000002D40890800]
05:07:17 INFO - 1499256437255 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/clicks.html"
05:07:17 INFO - 1499256437259 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/clicks.html"
05:07:17 INFO - 1499256437277 Marionette TRACE 358 <- [1,2,null,{}]
05:07:17 INFO - 1499256437284 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
05:07:17 INFO - 1499256437296 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8c7695d6-b0d4-4a16-a18b-f873742aac89","ELEMENT":"8c7695d6-b0d4-4a16-a18b-f873742aac89"}}]
05:07:17 INFO - 1499256437299 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"8c7695d6-b0d4-4a16-a18b-f873742aac89"}]
05:07:17 INFO - 1499256437562 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/clicks.html"
05:07:17 INFO - [2736] 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 445
05:07:17 INFO - 1499256437579 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/clicks.html"
05:07:17 INFO - 1499256437581 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/clicks.html"
05:07:17 INFO - ++DOMWINDOW == 29 (0000002D40EC3800) [pid = 2736] [serial = 45] [outer = 0000002D40890800]
05:07:17 INFO - 1499256437637 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49334/test.html"
05:07:17 INFO - 1499256437642 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49334/test.html"
05:07:17 INFO - 1499256437658 Marionette TRACE 358 <- [1,4,null,{}]
05:07:17 INFO - 1499256437668 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
05:07:17 INFO - 1499256437675 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"dc31e572-a93c-4ecd-bf6b-fbdadebbcd3f","ELEMENT":"dc31e572-a93c-4ecd-bf6b-fbdadebbcd3f"}}]
05:07:17 INFO - 1499256437677 Marionette TRACE 358 -> [0,6,"getTitle",{}]
05:07:17 INFO - 1499256437678 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
05:07:17 INFO - 1499256437682 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:07:17 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499256437689 Marionette TRACE 358 <- [1,7,null,{"value":null}]
05:07:17 INFO - 1499256437691 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437695 Marionette TRACE 358 <- [1,8,null,{}]
05:07:17 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 781ms
05:07:17 INFO - TEST-START | test_click.py TestClick.test_container_element
05:07:17 INFO - [2736] 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:07:17 INFO - 1499256437701 Marionette DEBUG Closed connection 358
05:07:17 INFO - 1499256437702 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49800
05:07:17 INFO - 1499256437704 Marionette DEBUG Closed connection 359
05:07:17 INFO - 1499256437705 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49801
05:07:17 INFO - 1499256437707 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:17 INFO - 1499256437709 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:17 INFO - 1499256437732 Marionette DEBUG Register listener.js for window 12
05:07:17 INFO - 1499256437743 Marionette TRACE 360 <- [1,1,null,{"sessionId":"f93532e1-98e2-4dbc-93ef-b27648c6e6c8","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:17 INFO - 1499256437771 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
05:07:17 INFO - 1499256437772 Marionette TRACE 360 <- [1,2,null,{}]
05:07:17 INFO - 1499256437774 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:17 INFO - 1499256437776 Marionette TRACE 360 <- [1,3,null,{}]
05:07:17 INFO - 1499256437783 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:17 INFO - 1499256437784 Marionette TRACE 360 <- [1,4,null,{}]
05:07:18 INFO - 1499256438649 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:07:18 INFO - TEST-START: test_click.py TestClick.test_container_element1499256438658 Marionette TRACE 360 <- [1,5,null,{"value":null}]
05:07:18 INFO - 1499256438704 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
05:07:18 INFO - [2736] 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:07:18 INFO - 1499256438708 Marionette TRACE 360 <- [1,6,null,{}]
05:07:18 INFO - [2736] 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:07:18 INFO - 1499256438714 Marionette DEBUG Closed connection 360
05:07:18 INFO - 1499256438715 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49802
05:07:18 INFO - 1499256438717 Marionette DEBUG Closed connection 361
05:07:18 INFO - 1499256438718 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49803
05:07:18 INFO - 1499256438720 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:18 INFO - 1499256438722 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:18 INFO - 1499256438746 Marionette DEBUG Register listener.js for window 12
05:07:18 INFO - 1499256438757 Marionette TRACE 362 <- [1,1,null,{"sessionId":"48207438-7fc6-4fe7-9c1f-a27dea930d6c","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:18 INFO - 1499256438760 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
05:07:18 INFO - [2736] 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:07:18 INFO - 1499256438764 Marionette TRACE 362 <- [1,2,null,{}]
05:07:18 INFO - [2736] 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:07:18 INFO - 1499256438826 Marionette DEBUG Closed connection 362
05:07:18 INFO - 1499256438827 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49804
05:07:18 INFO - 1499256438880 Marionette DEBUG Closed connection 363
05:07:18 INFO - 1499256438881 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49805
05:07:18 INFO - 1499256438885 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:18 INFO - 1499256438888 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:18 INFO - 1499256438911 Marionette DEBUG Register listener.js for window 12
05:07:18 INFO - 1499256438923 Marionette TRACE 364 <- [1,1,null,{"sessionId":"d16211b8-0b47-418a-93a4-0adf05464ca2","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:18 INFO - 1499256438929 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:07:18 INFO - 1499256438932 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49334/test.html"
05:07:18 INFO - 1499256438938 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49334/test.html"
05:07:18 INFO - 1499256438940 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49334/test.html"
05:07:18 INFO - ++DOMWINDOW == 30 (0000002D40EDA000) [pid = 2736] [serial = 46] [outer = 0000002D40890800]
05:07:19 INFO - 1499256439039 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:07:19 INFO - 1499256439055 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:07:19 INFO - 1499256439070 Marionette TRACE 364 <- [1,2,null,{}]
05:07:19 INFO - 1499256439072 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
05:07:19 INFO - 1499256439081 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"4d5b9878-1840-48cd-a90d-1d5970310c10","ELEMENT":"4d5b9878-1840-48cd-a90d-1d5970310c10"}}]
05:07:19 INFO - 1499256439133 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"4d5b9878-1840-48cd-a90d-1d5970310c10"}]
05:07:19 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
05:07:19 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
05:07:19 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
05:07:19 INFO - 1499256439623 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:07:19 INFO - 1499256439625 Marionette TRACE 364 <- [1,4,null,{}]
05:07:19 INFO - 1499256439627 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"4d5b9878-1840-48cd-a90d-1d5970310c10","name":"selected"}]
05:07:19 INFO - 1499256439656 Marionette TRACE 364 <- [1,5,null,{"value":true}]
05:07:19 INFO - 1499256439659 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:07:19 INFO - TEST-END: test_click.py TestClick.test_container_element1499256439666 Marionette TRACE 364 <- [1,6,null,{"value":null}]
05:07:19 INFO - 1499256439668 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439672 Marionette TRACE 364 <- [1,7,null,{}]
05:07:19 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1977ms
05:07:19 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439678 Marionette DEBUG Closed connection 364
05:07:19 INFO - 1499256439679 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49806
05:07:19 INFO - 1499256439681 Marionette DEBUG Closed connection 365
05:07:19 INFO - 1499256439682 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49807
05:07:19 INFO - 1499256439684 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:19 INFO - 1499256439688 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:19 INFO - 1499256439711 Marionette DEBUG Register listener.js for window 12
05:07:19 INFO - 1499256439724 Marionette TRACE 366 <- [1,1,null,{"sessionId":"9466ec05-9782-42cc-9109-704542d01a36","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:19 INFO - 1499256439726 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
05:07:19 INFO - 1499256439728 Marionette TRACE 366 <- [1,2,null,{}]
05:07:19 INFO - 1499256439730 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:19 INFO - 1499256439731 Marionette TRACE 366 <- [1,3,null,{}]
05:07:19 INFO - 1499256439733 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:19 INFO - 1499256439734 Marionette TRACE 366 <- [1,4,null,{}]
05:07:19 INFO - 1499256439737 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:07:19 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499256439744 Marionette TRACE 366 <- [1,5,null,{"value":null}]
05:07:19 INFO - 1499256439746 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439750 Marionette TRACE 366 <- [1,6,null,{}]
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439756 Marionette DEBUG Closed connection 366
05:07:19 INFO - 1499256439757 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49808
05:07:19 INFO - 1499256439759 Marionette DEBUG Closed connection 367
05:07:19 INFO - 1499256439760 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49809
05:07:19 INFO - 1499256439762 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:19 INFO - 1499256439764 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:19 INFO - 1499256439787 Marionette DEBUG Register listener.js for window 12
05:07:19 INFO - 1499256439798 Marionette TRACE 368 <- [1,1,null,{"sessionId":"c77dd883-b920-4a1d-8e11-d6dc188a17c5","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:19 INFO - 1499256439801 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439804 Marionette TRACE 368 <- [1,2,null,{}]
05:07:19 INFO - [2736] 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:07:19 INFO - 1499256439810 Marionette DEBUG Closed connection 368
05:07:19 INFO - 1499256439811 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49810
05:07:19 INFO - 1499256439813 Marionette DEBUG Closed connection 369
05:07:19 INFO - 1499256439814 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49811
05:07:19 INFO - 1499256439816 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:19 INFO - 1499256439819 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:19 INFO - 1499256439841 Marionette DEBUG Register listener.js for window 12
05:07:19 INFO - 1499256439852 Marionette TRACE 370 <- [1,1,null,{"sessionId":"05e7300b-ef3f-4f91-a449-ae5efbe2ce2b","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:19 INFO - 1499256439855 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:07:19 INFO - 1499256439938 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:07:19 INFO - 1499256439952 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:07:19 INFO - 1499256439953 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:07:19 INFO - ++DOMWINDOW == 31 (0000002D4A6CC000) [pid = 2736] [serial = 47] [outer = 0000002D40890800]
05:07:20 INFO - 1499256440001 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:07:20 INFO - 1499256440009 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:07:20 INFO - 1499256440025 Marionette TRACE 370 <- [1,2,null,{}]
05:07:20 INFO - 1499256440031 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
05:07:20 INFO - 1499256440045 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a4c1397f-953e-4887-b92f-41db3bf15897","ELEMENT":"a4c1397f-953e-4887-b92f-41db3bf15897"}}]
05:07:20 INFO - 1499256440050 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"a4c1397f-953e-4887-b92f-41db3bf15897"}]
05:07:20 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
05:07:20 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
05:07:20 INFO - [2736] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
05:07:20 INFO - 1499256440496 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:07:20 INFO - 1499256440498 Marionette TRACE 370 <- [1,4,null,{}]
05:07:20 INFO - 1499256440500 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"a4c1397f-953e-4887-b92f-41db3bf15897","name":"selected"}]
05:07:20 INFO - 1499256440529 Marionette TRACE 370 <- [1,5,null,{"value":true}]
05:07:20 INFO - 1499256440534 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:07:20 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499256440541 Marionette TRACE 370 <- [1,6,null,{"value":null}]
05:07:20 INFO - 1499256440543 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440547 Marionette TRACE 370 <- [1,7,null,{}]
05:07:20 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 874ms
05:07:20 INFO - TEST-START | test_click.py TestClick.test_css_transforms
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440553 Marionette DEBUG Closed connection 370
05:07:20 INFO - 1499256440554 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49812
05:07:20 INFO - 1499256440556 Marionette DEBUG Closed connection 371
05:07:20 INFO - 1499256440557 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49813
05:07:20 INFO - 1499256440559 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:20 INFO - 1499256440561 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:20 INFO - 1499256440584 Marionette DEBUG Register listener.js for window 12
05:07:20 INFO - 1499256440595 Marionette TRACE 372 <- [1,1,null,{"sessionId":"c63a7e35-40ec-4686-842b-9ae044149e8e","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:20 INFO - 1499256440600 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
05:07:20 INFO - 1499256440602 Marionette TRACE 372 <- [1,2,null,{}]
05:07:20 INFO - 1499256440635 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:20 INFO - 1499256440637 Marionette TRACE 372 <- [1,3,null,{}]
05:07:20 INFO - 1499256440638 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:20 INFO - 1499256440640 Marionette TRACE 372 <- [1,4,null,{}]
05:07:20 INFO - 1499256440642 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:07:20 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499256440649 Marionette TRACE 372 <- [1,5,null,{"value":null}]
05:07:20 INFO - 1499256440651 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440658 Marionette TRACE 372 <- [1,6,null,{}]
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440664 Marionette DEBUG Closed connection 372
05:07:20 INFO - 1499256440666 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49814
05:07:20 INFO - 1499256440690 Marionette DEBUG Closed connection 373
05:07:20 INFO - 1499256440691 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49815
05:07:20 INFO - 1499256440694 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:20 INFO - 1499256440696 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:20 INFO - 1499256440719 Marionette DEBUG Register listener.js for window 12
05:07:20 INFO - 1499256440730 Marionette TRACE 374 <- [1,1,null,{"sessionId":"b91196e0-46d0-4a1e-a881-86f1352f5493","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:20 INFO - 1499256440733 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440737 Marionette TRACE 374 <- [1,2,null,{}]
05:07:20 INFO - [2736] 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:07:20 INFO - 1499256440743 Marionette DEBUG Closed connection 374
05:07:20 INFO - 1499256440744 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49816
05:07:20 INFO - 1499256440746 Marionette DEBUG Closed connection 375
05:07:20 INFO - 1499256440747 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49817
05:07:20 INFO - 1499256440749 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:20 INFO - 1499256440752 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:20 INFO - 1499256440775 Marionette DEBUG Register listener.js for window 12
05:07:20 INFO - 1499256440786 Marionette TRACE 376 <- [1,1,null,{"sessionId":"bb6f7378-2e63-42dc-a3c0-add8714a05ec","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:20 INFO - 1499256440789 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:07:20 INFO - 1499256440792 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:07:20 INFO - 1499256440802 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:07:20 INFO - 1499256440803 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:07:20 INFO - ++DOMWINDOW == 32 (0000002D48DAD000) [pid = 2736] [serial = 48] [outer = 0000002D40890800]
05:07:20 INFO - 1499256440893 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:07:20 INFO - 1499256440905 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:07:20 INFO - 1499256440954 Marionette TRACE 376 <- [1,2,null,{}]
05:07:20 INFO - 1499256440971 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
05:07:20 INFO - 1499256440978 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a6346156-693b-4fda-b866-4dc6342b72f9","ELEMENT":"a6346156-693b-4fda-b866-4dc6342b72f9"}}]
05:07:20 INFO - 1499256440979 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"a6346156-693b-4fda-b866-4dc6342b72f9"}]
05:07:21 INFO - 1499256441407 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:07:21 INFO - 1499256441409 Marionette TRACE 376 <- [1,4,null,{}]
05:07:21 INFO - 1499256441411 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:07:21 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499256441418 Marionette TRACE 376 <- [1,5,null,{"value":null}]
05:07:21 INFO - 1499256441420 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441424 Marionette TRACE 376 <- [1,6,null,{}]
05:07:21 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 877ms
05:07:21 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441450 Marionette DEBUG Closed connection 376
05:07:21 INFO - 1499256441451 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49818
05:07:21 INFO - 1499256441453 Marionette DEBUG Closed connection 377
05:07:21 INFO - 1499256441454 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49819
05:07:21 INFO - 1499256441457 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:21 INFO - 1499256441467 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:21 INFO - 1499256441491 Marionette DEBUG Register listener.js for window 12
05:07:21 INFO - 1499256441502 Marionette TRACE 378 <- [1,1,null,{"sessionId":"8457013b-fe8a-488b-b961-c073a2505c0b","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:21 INFO - 1499256441511 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
05:07:21 INFO - 1499256441512 Marionette TRACE 378 <- [1,2,null,{}]
05:07:21 INFO - 1499256441514 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:21 INFO - 1499256441516 Marionette TRACE 378 <- [1,3,null,{}]
05:07:21 INFO - 1499256441517 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:21 INFO - 1499256441519 Marionette TRACE 378 <- [1,4,null,{}]
05:07:21 INFO - 1499256441521 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:07:21 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499256441528 Marionette TRACE 378 <- [1,5,null,{"value":null}]
05:07:21 INFO - 1499256441530 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441534 Marionette TRACE 378 <- [1,6,null,{}]
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441540 Marionette DEBUG Closed connection 378
05:07:21 INFO - 1499256441541 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49820
05:07:21 INFO - 1499256441543 Marionette DEBUG Closed connection 379
05:07:21 INFO - 1499256441544 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49821
05:07:21 INFO - 1499256441546 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:21 INFO - 1499256441548 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:21 INFO - 1499256441573 Marionette DEBUG Register listener.js for window 12
05:07:21 INFO - 1499256441584 Marionette TRACE 380 <- [1,1,null,{"sessionId":"96e60001-0ef3-4ff4-a814-8ba8d7ed5e47","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:21 INFO - 1499256441587 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441591 Marionette TRACE 380 <- [1,2,null,{}]
05:07:21 INFO - [2736] 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:07:21 INFO - 1499256441597 Marionette DEBUG Closed connection 380
05:07:21 INFO - 1499256441599 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49822
05:07:21 INFO - 1499256441600 Marionette DEBUG Closed connection 381
05:07:21 INFO - 1499256441601 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49823
05:07:21 INFO - 1499256441603 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:21 INFO - 1499256441606 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:21 INFO - 1499256441629 Marionette DEBUG Register listener.js for window 12
05:07:21 INFO - 1499256441640 Marionette TRACE 382 <- [1,1,null,{"sessionId":"b53b79ba-0083-4fea-b8af-71159a17a84f","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:21 INFO - 1499256441643 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:07:21 INFO - 1499256441647 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:07:21 INFO - 1499256441652 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:07:21 INFO - 1499256441653 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:07:21 INFO - ++DOMWINDOW == 33 (0000002D4A6DB000) [pid = 2736] [serial = 49] [outer = 0000002D40890800]
05:07:21 INFO - 1499256441702 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:07:21 INFO - 1499256441707 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:07:21 INFO - 1499256441775 Marionette TRACE 382 <- [1,2,null,{}]
05:07:21 INFO - 1499256441781 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
05:07:21 INFO - 1499256441787 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b8df40b7-263d-4638-ad7a-c3941b105f14","ELEMENT":"b8df40b7-263d-4638-ad7a-c3941b105f14"}}]
05:07:21 INFO - 1499256441789 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"b8df40b7-263d-4638-ad7a-c3941b105f14"}]
05:07:22 INFO - 1499256442866 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:07:22 INFO - 1499256442884 Marionette TRACE 382 <- [1,4,null,{}]
05:07:22 INFO - 1499256442889 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:07:22 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499256442896 Marionette TRACE 382 <- [1,5,null,{"value":null}]
05:07:23 INFO - 1499256443104 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443113 Marionette TRACE 382 <- [1,6,null,{}]
05:07:23 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1691ms
05:07:23 INFO - TEST-START | test_click.py TestClick.test_input_file
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443125 Marionette DEBUG Closed connection 382
05:07:23 INFO - 1499256443129 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49824
05:07:23 INFO - 1499256443151 Marionette DEBUG Closed connection 383
05:07:23 INFO - 1499256443155 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49825
05:07:23 INFO - 1499256443159 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:23 INFO - 1499256443169 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:23 INFO - 1499256443219 Marionette DEBUG Register listener.js for window 12
05:07:23 INFO - 1499256443254 Marionette TRACE 384 <- [1,1,null,{"sessionId":"07def9df-8503-4194-aa19-10fd09b30b28","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:23 INFO - 1499256443264 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
05:07:23 INFO - 1499256443270 Marionette TRACE 384 <- [1,2,null,{}]
05:07:23 INFO - 1499256443275 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:23 INFO - 1499256443280 Marionette TRACE 384 <- [1,3,null,{}]
05:07:23 INFO - 1499256443333 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:23 INFO - 1499256443336 Marionette TRACE 384 <- [1,4,null,{}]
05:07:23 INFO - 1499256443340 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:07:23 INFO - TEST-START: test_click.py TestClick.test_input_file1499256443354 Marionette TRACE 384 <- [1,5,null,{"value":null}]
05:07:23 INFO - 1499256443358 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443365 Marionette TRACE 384 <- [1,6,null,{}]
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443423 Marionette DEBUG Closed connection 384
05:07:23 INFO - 1499256443427 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49826
05:07:23 INFO - 1499256443448 Marionette DEBUG Closed connection 385
05:07:23 INFO - 1499256443451 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49827
05:07:23 INFO - 1499256443455 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:23 INFO - 1499256443460 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:23 INFO - 1499256443508 Marionette DEBUG Register listener.js for window 12
05:07:23 INFO - 1499256443528 Marionette TRACE 386 <- [1,1,null,{"sessionId":"9ccf3a38-de7d-4b13-aff5-240ddec8913a","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:23 INFO - 1499256443536 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443542 Marionette TRACE 386 <- [1,2,null,{}]
05:07:23 INFO - [2736] 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:07:23 INFO - 1499256443557 Marionette DEBUG Closed connection 386
05:07:23 INFO - 1499256443559 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49828
05:07:23 INFO - 1499256443581 Marionette DEBUG Closed connection 387
05:07:23 INFO - 1499256443583 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49829
05:07:23 INFO - 1499256443586 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:23 INFO - 1499256443591 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:23 INFO - 1499256443640 Marionette DEBUG Register listener.js for window 12
05:07:23 INFO - 1499256443658 Marionette TRACE 388 <- [1,1,null,{"sessionId":"4e6f2c67-21e1-47e5-bfbf-8c1b0cce0ac3","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:23 INFO - 1499256443691 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
05:07:23 INFO - 1499256443699 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:07:23 INFO - 1499256443710 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:07:23 INFO - 1499256443712 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:07:23 INFO - ++DOMWINDOW == 34 (0000002D3CB3D800) [pid = 2736] [serial = 50] [outer = 0000002D40890800]
05:07:23 INFO - 1499256443774 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:07:23 INFO - 1499256443792 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:07:23 INFO - 1499256443813 Marionette TRACE 388 <- [1,2,null,{}]
05:07:23 INFO - 1499256443829 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
05:07:23 INFO - 1499256443839 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fdbd673e-bc70-45ab-9ad2-856d1d6c4fd4","ELEMENT":"fdbd673e-bc70-45ab-9ad2-856d1d6c4fd4"}}]
05:07:23 INFO - 1499256443842 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"fdbd673e-bc70-45ab-9ad2-856d1d6c4fd4"}]
05:07:24 INFO - 1499256444105 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:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
05:07:24 INFO - 1499256444129 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:07:24 INFO - TEST-END: test_click.py TestClick.test_input_file1499256444141 Marionette TRACE 388 <- [1,5,null,{"value":null}]
05:07:24 INFO - 1499256444143 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444148 Marionette TRACE 388 <- [1,6,null,{}]
05:07:24 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 1031ms
05:07:24 INFO - TEST-START | test_click.py TestClick.test_obscured_element
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444174 Marionette DEBUG Closed connection 388
05:07:24 INFO - 1499256444176 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49830
05:07:24 INFO - 1499256444220 Marionette DEBUG Closed connection 389
05:07:24 INFO - 1499256444223 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49831
05:07:24 INFO - 1499256444246 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:24 INFO - 1499256444250 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:24 INFO - 1499256444299 Marionette DEBUG Register listener.js for window 12
05:07:24 INFO - 1499256444317 Marionette TRACE 390 <- [1,1,null,{"sessionId":"9645eb7c-939b-415d-bda5-9222171540d5","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:24 INFO - 1499256444342 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
05:07:24 INFO - 1499256444344 Marionette TRACE 390 <- [1,2,null,{}]
05:07:24 INFO - 1499256444352 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:24 INFO - 1499256444354 Marionette TRACE 390 <- [1,3,null,{}]
05:07:24 INFO - 1499256444357 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:24 INFO - 1499256444359 Marionette TRACE 390 <- [1,4,null,{}]
05:07:24 INFO - 1499256444372 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
05:07:24 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499256444382 Marionette TRACE 390 <- [1,5,null,{"value":null}]
05:07:24 INFO - 1499256444385 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444390 Marionette TRACE 390 <- [1,6,null,{}]
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444397 Marionette DEBUG Closed connection 390
05:07:24 INFO - 1499256444399 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49832
05:07:24 INFO - 1499256444401 Marionette DEBUG Closed connection 391
05:07:24 INFO - 1499256444404 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49833
05:07:24 INFO - 1499256444406 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:24 INFO - 1499256444409 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:24 INFO - 1499256444459 Marionette DEBUG Register listener.js for window 12
05:07:24 INFO - 1499256444480 Marionette TRACE 392 <- [1,1,null,{"sessionId":"7bfecd7a-cef6-4933-a2e0-8036d31d44f6","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:24 INFO - 1499256444519 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444525 Marionette TRACE 392 <- [1,2,null,{}]
05:07:24 INFO - [2736] 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:07:24 INFO - 1499256444535 Marionette DEBUG Closed connection 392
05:07:24 INFO - 1499256444540 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49834
05:07:24 INFO - 1499256444542 Marionette DEBUG Closed connection 393
05:07:24 INFO - 1499256444544 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49835
05:07:24 INFO - 1499256444547 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:24 INFO - 1499256444552 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:24 INFO - 1499256444604 Marionette DEBUG Register listener.js for window 12
05:07:24 INFO - 1499256444620 Marionette TRACE 394 <- [1,1,null,{"sessionId":"4b2b94df-fd9c-4f2e-af71-09db5b924517","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:24 INFO - 1499256444658 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
05:07:24 INFO - 1499256444663 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:07:24 INFO - 1499256444673 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:07:24 INFO - 1499256444674 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
05:07:24 INFO - ++DOMWINDOW == 35 (0000002D47CAF800) [pid = 2736] [serial = 51] [outer = 0000002D40890800]
05:07:24 INFO - 1499256444773 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:07:24 INFO - 1499256444780 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:07:24 INFO - 1499256444798 Marionette TRACE 394 <- [1,2,null,{}]
05:07:24 INFO - 1499256444806 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
05:07:24 INFO - 1499256444816 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8b67b30a-380e-473e-917f-0abb29390aa8","ELEMENT":"8b67b30a-380e-473e-917f-0abb29390aa8"}}]
05:07:24 INFO - 1499256444818 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
05:07:24 INFO - 1499256444837 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"8fd6e379-4f17-44c1-8f1f-33ba28feb423","ELEMENT":"8fd6e379-4f17-44c1-8f1f-33ba28feb423"}}]
05:07:24 INFO - 1499256444840 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"8b67b30a-380e-473e-917f-0abb29390aa8"}]
05:07:25 INFO - 1499256445666 Marionette DEBUG Canceled page load listener because no navigation has been detected
05:07:25 INFO - 1499256445671 Marionette TRACE 394 <- [1,5,null,{}]
05:07:25 INFO - 1499256445679 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"8fd6e379-4f17-44c1-8f1f-33ba28feb423"}]
05:07:25 INFO - 1499256445874 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:393:12\nclickElement@chrome://marionette/content/listener.js:1318:5\n"},null]
05:07:25 INFO - 1499256445917 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
05:07:25 INFO - 1499256445930 Marionette TRACE 394 <- [1,7,null,{"value":false}]
05:07:25 INFO - 1499256445935 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
05:07:25 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499256445948 Marionette TRACE 394 <- [1,8,null,{"value":null}]
05:07:25 INFO - 1499256445951 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
05:07:25 INFO - [2736] 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:07:25 INFO - 1499256445960 Marionette TRACE 394 <- [1,9,null,{}]
05:07:25 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1811ms
05:07:25 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
05:07:25 INFO - [2736] 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:07:25 INFO - 1499256445970 Marionette DEBUG Closed connection 394
05:07:25 INFO - 1499256445974 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49836
05:07:26 INFO - 1499256446010 Marionette DEBUG Closed connection 395
05:07:26 INFO - 1499256446013 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49837
05:07:26 INFO - 1499256446017 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:26 INFO - 1499256446028 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:26 INFO - 1499256446056 Marionette DEBUG Register listener.js for window 12
05:07:26 INFO - 1499256446076 Marionette TRACE 396 <- [1,1,null,{"sessionId":"a3ee61e2-9aba-4d29-9aa3-807ee836fbf6","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:26 INFO - 1499256446117 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
05:07:26 INFO - 1499256446121 Marionette TRACE 396 <- [1,2,null,{}]
05:07:26 INFO - 1499256446127 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
05:07:26 INFO - 1499256446129 Marionette TRACE 396 <- [1,3,null,{}]
05:07:26 INFO - 1499256446132 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
05:07:26 INFO - 1499256446134 Marionette TRACE 396 <- [1,4,null,{}]
05:07:26 INFO - 1499256446174 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
05:07:26 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499256446185 Marionette TRACE 396 <- [1,5,null,{"value":null}]
05:07:26 INFO - 1499256446190 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
05:07:26 INFO - [2736] 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:07:26 INFO - 1499256446196 Marionette TRACE 396 <- [1,6,null,{}]
05:07:26 INFO - [2736] 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:07:26 INFO - 1499256446221 Marionette DEBUG Closed connection 396
05:07:26 INFO - 1499256446225 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49838
05:07:26 INFO - 1499256446233 Marionette DEBUG Closed connection 397
05:07:26 INFO - 1499256446236 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49839
05:07:26 INFO - 1499256446247 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
05:07:26 INFO - 1499256446253 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:26 INFO - 1499256446278 Marionette DEBUG Register listener.js for window 12
05:07:26 INFO - 1499256446295 Marionette TRACE 398 <- [1,1,null,{"sessionId":"bde5bf87-3fc0-43cd-be1b-22120d69d4a7","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:26 INFO - 1499256446302 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
05:07:26 INFO - [2736] 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:07:26 INFO - 1499256446307 Marionette TRACE 398 <- [1,2,null,{}]
05:07:26 INFO - [2736] 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:07:26 INFO - 1499256446315 Marionette DEBUG Closed connection 398
05:07:26 INFO - 1499256446317 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49840
05:07:26 INFO - 1499256446325 Marionette DEBUG Closed connection 399
05:07:26 INFO - 1499256446327 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49841
05:07:26 INFO - --DOMWINDOW == 34 (0000002D4A311800) [pid = 2736] [serial = 34] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 33 (0000002D49B40800) [pid = 2736] [serial = 33] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 32 (0000002D47E2D000) [pid = 2736] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 31 (0000002D3FC5F000) [pid = 2736] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 30 (0000002D35291000) [pid = 2736] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 29 (0000002D47058000) [pid = 2736] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - --DOMWINDOW == 28 (0000002D335ED000) [pid = 2736] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49334/test_accessibility.html]
05:07:26 INFO - 1499256446357 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
05:07:26 INFO - 1499256446360 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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}
05:07:26 INFO - 1499256446385 Marionette DEBUG Register listener.js for window 12
05:07:26 INFO - 1499256446400 Marionette TRACE 400 <- [1,1,null,{"sessionId":"3a8220c2-dc87-401e-8fdb-347cfd3a1812","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":2736,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmpwgqpzi.mozrunner","moz:accessibilityChecks":false}}]
05:07:26 INFO - 1499256446407 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
05:07:26 INFO - 1499256446412 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:07:26 INFO - 1499256446421 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:07:26 INFO - 1499256446422 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:07:26 INFO - ++DOMWINDOW == 29 (0000002D35418000) [pid = 2736] [serial = 52] [outer = 0000002D40890800]
05:07:26 INFO - 1499256446483 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:07:26 INFO - 1499256446490 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:07:26 INFO - 1499256446509 Marionette TRACE 400 <- [1,2,null,{}]
05:07:26 INFO - 1499256446513 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
05:07:26 INFO - 1499256446520 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"98ea6aa5-28fc-482c-b458-0e6cce7c9386","ELEMENT":"98ea6aa5-28fc-482c-b458-0e6cce7c9386"}}]
05:07:26 INFO - 1499256446522 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"98ea6aa5-28fc-482c-b458-0e6cce7c9386"}]
05:07:26 INFO - 1499256446649 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
05:07:26 INFO - 1499256446651 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"98ea6aa5-28fc-482c-b458-0e6cce7c9386"}]
05:07:26 INFO - 1499256446801 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element