could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:45:56 INFO - 1500918356918 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}]
10:45:56 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500918356927 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:45:56 INFO - 1500918356929 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:45:56 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:56 INFO - 1500918356934 Marionette TRACE 352 <- [1,6,null,{}]
10:45:56 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 677ms
10:45:56 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:45:56 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:56 INFO - 1500918356940 Marionette DEBUG Closed connection 352
10:45:56 INFO - 1500918356941 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49787
10:45:56 INFO - 1500918356943 Marionette DEBUG Closed connection 353
10:45:56 INFO - 1500918356944 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49788
10:45:56 INFO - 1500918356947 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:56 INFO - 1500918356949 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:56 INFO - 1500918356972 Marionette DEBUG Register listener.js for window 12
10:45:56 INFO - 1500918356984 Marionette TRACE 354 <- [1,1,null,{"sessionId":"a1433846-4e20-4e61-90ca-40728b62fec5","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:57 INFO - 1500918356991 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:45:57 INFO - 1500918356992 Marionette TRACE 354 <- [1,2,null,{}]
10:45:57 INFO - 1500918356994 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:45:57 INFO - 1500918356996 Marionette TRACE 354 <- [1,3,null,{}]
10:45:57 INFO - 1500918356998 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:45:57 INFO - 1500918356999 Marionette TRACE 354 <- [1,4,null,{}]
10:45:57 INFO - 1500918357002 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}]
10:45:57 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500918357010 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:45:57 INFO - 1500918357011 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357016 Marionette TRACE 354 <- [1,6,null,{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357022 Marionette DEBUG Closed connection 354
10:45:57 INFO - 1500918357023 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49789
10:45:57 INFO - 1500918357025 Marionette DEBUG Closed connection 355
10:45:57 INFO - 1500918357026 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49790
10:45:57 INFO - 1500918357029 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:57 INFO - 1500918357032 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:57 INFO - 1500918357059 Marionette DEBUG Register listener.js for window 12
10:45:57 INFO - 1500918357074 Marionette TRACE 356 <- [1,1,null,{"sessionId":"cfac712d-833c-4e39-ad44-5245208e810f","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:57 INFO - 1500918357080 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357084 Marionette TRACE 356 <- [1,2,null,{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357090 Marionette DEBUG Closed connection 356
10:45:57 INFO - 1500918357092 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49791
10:45:57 INFO - 1500918357093 Marionette DEBUG Closed connection 357
10:45:57 INFO - 1500918357095 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49792
10:45:57 INFO - 1500918357097 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:45:57 INFO - 1500918357099 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:57 INFO - 1500918357122 Marionette DEBUG Register listener.js for window 12
10:45:57 INFO - 1500918357133 Marionette TRACE 358 <- [1,1,null,{"sessionId":"825ff796-77b6-4b10-9bad-33288e4b92a1","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:57 INFO - 1500918357141 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49339/clicks.html"}]
10:45:57 INFO - 1500918357145 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49339/hidden.html"
10:45:57 INFO - 1500918357158 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49339/hidden.html"
10:45:57 INFO - 1500918357159 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49339/hidden.html"
10:45:57 INFO - ++DOMWINDOW == 25 (000000685614B800) [pid = 3984] [serial = 41] [outer = 000000684FFDB000]
10:45:57 INFO - 1500918357300 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49339/clicks.html"
10:45:57 INFO - 1500918357305 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49339/clicks.html"
10:45:57 INFO - 1500918357323 Marionette TRACE 358 <- [1,2,null,{}]
10:45:57 INFO - 1500918357329 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:45:57 INFO - 1500918357335 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"9e8ebc72-b0a0-421b-aef5-7ca25b51805d","ELEMENT":"9e8ebc72-b0a0-421b-aef5-7ca25b51805d"}}]
10:45:57 INFO - 1500918357337 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"9e8ebc72-b0a0-421b-aef5-7ca25b51805d"}]
10:45:57 INFO - 1500918357566 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49339/clicks.html"
10:45:57 INFO - [Parent 3984] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
10:45:57 INFO - 1500918357596 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49339/clicks.html"
10:45:57 INFO - 1500918357598 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49339/clicks.html"
10:45:57 INFO - ++DOMWINDOW == 26 (00000068581C0800) [pid = 3984] [serial = 42] [outer = 000000684FFDB000]
10:45:57 INFO - 1500918357701 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49339/test.html"
10:45:57 INFO - 1500918357708 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49339/test.html"
10:45:57 INFO - 1500918357724 Marionette TRACE 358 <- [1,4,null,{}]
10:45:57 INFO - 1500918357729 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:45:57 INFO - 1500918357736 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"d3fd8131-4941-46da-8ad2-0dd5497cfc96","ELEMENT":"d3fd8131-4941-46da-8ad2-0dd5497cfc96"}}]
10:45:57 INFO - 1500918357738 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:45:57 INFO - 1500918357739 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:45:57 INFO - 1500918357742 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}]
10:45:57 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500918357750 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:45:57 INFO - 1500918357751 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357756 Marionette TRACE 358 <- [1,8,null,{}]
10:45:57 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 821ms
10:45:57 INFO - TEST-START | test_click.py TestClick.test_container_element
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357762 Marionette DEBUG Closed connection 358
10:45:57 INFO - 1500918357763 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49795
10:45:57 INFO - 1500918357765 Marionette DEBUG Closed connection 359
10:45:57 INFO - 1500918357766 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49796
10:45:57 INFO - 1500918357768 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:57 INFO - 1500918357779 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:57 INFO - 1500918357802 Marionette DEBUG Register listener.js for window 12
10:45:57 INFO - 1500918357813 Marionette TRACE 360 <- [1,1,null,{"sessionId":"ca622fe5-5b09-4d6d-89ce-ee6de7dea498","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:57 INFO - 1500918357848 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:45:57 INFO - 1500918357849 Marionette TRACE 360 <- [1,2,null,{}]
10:45:57 INFO - 1500918357852 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:45:57 INFO - 1500918357854 Marionette TRACE 360 <- [1,3,null,{}]
10:45:57 INFO - 1500918357856 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:45:57 INFO - 1500918357857 Marionette TRACE 360 <- [1,4,null,{}]
10:45:57 INFO - 1500918357860 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}]
10:45:57 INFO - TEST-START: test_click.py TestClick.test_container_element1500918357867 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:45:57 INFO - 1500918357869 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357873 Marionette TRACE 360 <- [1,6,null,{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357880 Marionette DEBUG Closed connection 360
10:45:57 INFO - 1500918357881 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49797
10:45:57 INFO - 1500918357883 Marionette DEBUG Closed connection 361
10:45:57 INFO - 1500918357884 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49798
10:45:57 INFO - 1500918357886 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:57 INFO - 1500918357889 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:57 INFO - 1500918357911 Marionette DEBUG Register listener.js for window 12
10:45:57 INFO - 1500918357922 Marionette TRACE 362 <- [1,1,null,{"sessionId":"6dc6d80c-479c-4dc6-923d-e0e31865495e","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:57 INFO - 1500918357951 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357956 Marionette TRACE 362 <- [1,2,null,{}]
10:45:57 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:57 INFO - 1500918357977 Marionette DEBUG Closed connection 362
10:45:57 INFO - 1500918357979 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49799
10:45:57 INFO - 1500918357983 Marionette DEBUG Closed connection 363
10:45:57 INFO - 1500918357985 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49800
10:45:57 INFO - 1500918357987 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:45:57 INFO - 1500918357990 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:58 INFO - 1500918358012 Marionette DEBUG Register listener.js for window 12
10:45:58 INFO - 1500918358023 Marionette TRACE 364 <- [1,1,null,{"sessionId":"25c8165f-e7d3-4eb2-b0d7-3d1f158134b6","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:58 INFO - 1500918358033 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"}]
10:45:58 INFO - 1500918358037 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49339/test.html"
10:45:58 INFO - 1500918358043 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49339/test.html"
10:45:58 INFO - 1500918358044 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49339/test.html"
10:45:58 INFO - ++DOMWINDOW == 27 (00000068581BB800) [pid = 3984] [serial = 43] [outer = 000000684FFDB000]
10:45:58 INFO - 1500918358099 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"
10:45:58 INFO - 1500918358103 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"
10:45:58 INFO - 1500918358119 Marionette TRACE 364 <- [1,2,null,{}]
10:45:58 INFO - 1500918358127 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:45:58 INFO - 1500918358135 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"98013b1c-0a75-4501-8b24-ffd1205c7fc7","ELEMENT":"98013b1c-0a75-4501-8b24-ffd1205c7fc7"}}]
10:45:58 INFO - 1500918358142 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"98013b1c-0a75-4501-8b24-ffd1205c7fc7"}]
10:45:58 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:45:58 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:45:58 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:45:59 INFO - 1500918359140 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:45:59 INFO - 1500918359155 Marionette TRACE 364 <- [1,4,null,{}]
10:45:59 INFO - 1500918359197 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"98013b1c-0a75-4501-8b24-ffd1205c7fc7","name":"selected"}]
10:45:59 INFO - 1500918359226 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:45:59 INFO - 1500918359229 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}]
10:45:59 INFO - TEST-END: test_click.py TestClick.test_container_element1500918359236 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:45:59 INFO - 1500918359238 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359242 Marionette TRACE 364 <- [1,7,null,{}]
10:45:59 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1486ms
10:45:59 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359249 Marionette DEBUG Closed connection 364
10:45:59 INFO - 1500918359250 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49801
10:45:59 INFO - 1500918359252 Marionette DEBUG Closed connection 365
10:45:59 INFO - 1500918359253 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49802
10:45:59 INFO - 1500918359256 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:59 INFO - 1500918359258 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:59 INFO - 1500918359281 Marionette DEBUG Register listener.js for window 12
10:45:59 INFO - 1500918359337 Marionette TRACE 366 <- [1,1,null,{"sessionId":"549b3330-da6b-4953-92ec-9ddd2a1cf083","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:59 INFO - 1500918359499 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:45:59 INFO - 1500918359505 Marionette TRACE 366 <- [1,2,null,{}]
10:45:59 INFO - 1500918359509 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:45:59 INFO - 1500918359512 Marionette TRACE 366 <- [1,3,null,{}]
10:45:59 INFO - 1500918359567 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:45:59 INFO - 1500918359570 Marionette TRACE 366 <- [1,4,null,{}]
10:45:59 INFO - 1500918359575 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}]
10:45:59 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500918359589 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:45:59 INFO - 1500918359593 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359601 Marionette TRACE 366 <- [1,6,null,{}]
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359613 Marionette DEBUG Closed connection 366
10:45:59 INFO - 1500918359617 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49803
10:45:59 INFO - 1500918359670 Marionette DEBUG Closed connection 367
10:45:59 INFO - 1500918359673 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49804
10:45:59 INFO - 1500918359695 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:45:59 INFO - 1500918359704 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:59 INFO - 1500918359751 Marionette DEBUG Register listener.js for window 12
10:45:59 INFO - 1500918359772 Marionette TRACE 368 <- [1,1,null,{"sessionId":"eca59b09-1fec-4467-89cf-a6bffe871b4b","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:59 INFO - 1500918359787 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359795 Marionette TRACE 368 <- [1,2,null,{}]
10:45:59 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:45:59 INFO - 1500918359830 Marionette DEBUG Closed connection 368
10:45:59 INFO - 1500918359833 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49805
10:45:59 INFO - 1500918359838 Marionette DEBUG Closed connection 369
10:45:59 INFO - 1500918359840 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49806
10:45:59 INFO - 1500918359863 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:45:59 INFO - 1500918359867 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:45:59 INFO - 1500918359913 Marionette DEBUG Register listener.js for window 12
10:45:59 INFO - 1500918359931 Marionette TRACE 370 <- [1,1,null,{"sessionId":"e8ab30a8-2d20-4276-a998-e644c626056d","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:45:59 INFO - 1500918359950 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"}]
10:45:59 INFO - 1500918359957 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"
10:45:59 INFO - 1500918359967 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"
10:45:59 INFO - 1500918359968 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"
10:45:59 INFO - ++DOMWINDOW == 28 (000000684EA0D000) [pid = 3984] [serial = 44] [outer = 000000684FFDB000]
10:46:00 INFO - 1500918360038 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"
10:46:00 INFO - 1500918360045 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"
10:46:00 INFO - 1500918360070 Marionette TRACE 370 <- [1,2,null,{}]
10:46:00 INFO - 1500918360074 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:46:00 INFO - 1500918360084 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"71075d71-f616-4f83-80be-20dd27eb9fbc","ELEMENT":"71075d71-f616-4f83-80be-20dd27eb9fbc"}}]
10:46:00 INFO - 1500918360091 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"71075d71-f616-4f83-80be-20dd27eb9fbc"}]
10:46:00 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:46:00 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:46:00 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:46:00 INFO - 1500918360714 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:46:00 INFO - 1500918360718 Marionette TRACE 370 <- [1,4,null,{}]
10:46:00 INFO - 1500918360722 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"71075d71-f616-4f83-80be-20dd27eb9fbc","name":"selected"}]
10:46:00 INFO - 1500918360783 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:46:00 INFO - 1500918360791 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}]
10:46:00 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500918360803 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:46:00 INFO - 1500918360855 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:46:00 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:00 INFO - 1500918360861 Marionette TRACE 370 <- [1,7,null,{}]
10:46:00 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 1618ms
10:46:00 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:46:00 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:00 INFO - 1500918360886 Marionette DEBUG Closed connection 370
10:46:00 INFO - 1500918360889 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49807
10:46:00 INFO - 1500918360897 Marionette DEBUG Closed connection 371
10:46:00 INFO - 1500918360899 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49808
10:46:00 INFO - 1500918360902 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:00 INFO - 1500918360906 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:00 INFO - 1500918360954 Marionette DEBUG Register listener.js for window 12
10:46:00 INFO - 1500918360990 Marionette TRACE 372 <- [1,1,null,{"sessionId":"88bf70f2-7261-44f7-9408-ebcd41e713db","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:01 INFO - 1500918361011 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:46:01 INFO - 1500918361013 Marionette TRACE 372 <- [1,2,null,{}]
10:46:01 INFO - 1500918361020 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:46:01 INFO - 1500918361022 Marionette TRACE 372 <- [1,3,null,{}]
10:46:01 INFO - 1500918361024 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:46:01 INFO - 1500918361027 Marionette TRACE 372 <- [1,4,null,{}]
10:46:01 INFO - 1500918361036 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}]
10:46:01 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500918361046 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:46:01 INFO - 1500918361049 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:46:01 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:01 INFO - 1500918361055 Marionette TRACE 372 <- [1,6,null,{}]
10:46:01 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:01 INFO - 1500918361078 Marionette DEBUG Closed connection 372
10:46:01 INFO - 1500918361080 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49809
10:46:01 INFO - 1500918361249 Marionette DEBUG Closed connection 373
10:46:01 INFO - 1500918361252 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49810
10:46:01 INFO - 1500918361260 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:01 INFO - 1500918361271 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:01 INFO - 1500918361298 Marionette DEBUG Register listener.js for window 12
10:46:01 INFO - 1500918361320 Marionette TRACE 374 <- [1,1,null,{"sessionId":"ff47376f-6ac6-4897-bc2c-d7ab7c9e8876","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:01 INFO - 1500918361336 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:46:01 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:01 INFO - 1500918361343 Marionette TRACE 374 <- [1,2,null,{}]
10:46:01 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:01 INFO - 1500918361361 Marionette DEBUG Closed connection 374
10:46:01 INFO - 1500918361364 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49811
10:46:01 INFO - 1500918361389 Marionette DEBUG Closed connection 375
10:46:01 INFO - 1500918361394 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49812
10:46:01 INFO - 1500918361400 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:46:01 INFO - 1500918361407 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:01 INFO - 1500918361435 Marionette DEBUG Register listener.js for window 12
10:46:01 INFO - 1500918361452 Marionette TRACE 376 <- [1,1,null,{"sessionId":"c37711b9-0fab-454d-8e8b-972d3055deaf","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:01 INFO - 1500918361496 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"}]
10:46:01 INFO - 1500918361503 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"
10:46:01 INFO - 1500918361513 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"
10:46:01 INFO - 1500918361514 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"
10:46:01 INFO - ++DOMWINDOW == 29 (000000684EA0C800) [pid = 3984] [serial = 45] [outer = 000000684FFDB000]
10:46:01 INFO - 1500918361579 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"
10:46:01 INFO - 1500918361585 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"
10:46:01 INFO - 1500918361606 Marionette TRACE 376 <- [1,2,null,{}]
10:46:01 INFO - 1500918361621 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:46:01 INFO - 1500918361633 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a1b037e2-2aad-4c58-bf15-561d3038c0f3","ELEMENT":"a1b037e2-2aad-4c58-bf15-561d3038c0f3"}}]
10:46:01 INFO - 1500918361636 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"a1b037e2-2aad-4c58-bf15-561d3038c0f3"}]
10:46:02 INFO - 1500918362101 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:46:02 INFO - 1500918362104 Marionette TRACE 376 <- [1,4,null,{}]
10:46:02 INFO - 1500918362107 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}]
10:46:02 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500918362118 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:46:02 INFO - 1500918362122 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362130 Marionette TRACE 376 <- [1,6,null,{}]
10:46:02 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1271ms
10:46:02 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362140 Marionette DEBUG Closed connection 376
10:46:02 INFO - 1500918362143 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49813
10:46:02 INFO - 1500918362166 Marionette DEBUG Closed connection 377
10:46:02 INFO - 1500918362169 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49814
10:46:02 INFO - 1500918362173 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:02 INFO - 1500918362177 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:02 INFO - 1500918362202 Marionette DEBUG Register listener.js for window 12
10:46:02 INFO - 1500918362216 Marionette TRACE 378 <- [1,1,null,{"sessionId":"c39276ef-82ec-4257-b144-6981083eb111","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:02 INFO - 1500918362230 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:46:02 INFO - 1500918362232 Marionette TRACE 378 <- [1,2,null,{}]
10:46:02 INFO - 1500918362239 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:46:02 INFO - 1500918362244 Marionette TRACE 378 <- [1,3,null,{}]
10:46:02 INFO - 1500918362247 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:46:02 INFO - 1500918362249 Marionette TRACE 378 <- [1,4,null,{}]
10:46:02 INFO - 1500918362252 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}]
10:46:02 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500918362263 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:46:02 INFO - 1500918362265 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362270 Marionette TRACE 378 <- [1,6,null,{}]
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362277 Marionette DEBUG Closed connection 378
10:46:02 INFO - 1500918362279 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49815
10:46:02 INFO - 1500918362281 Marionette DEBUG Closed connection 379
10:46:02 INFO - 1500918362283 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49816
10:46:02 INFO - 1500918362285 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:02 INFO - 1500918362288 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:02 INFO - 1500918362313 Marionette DEBUG Register listener.js for window 12
10:46:02 INFO - 1500918362330 Marionette TRACE 380 <- [1,1,null,{"sessionId":"2686b828-a551-43cd-9c2f-a661ec3f245e","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:02 INFO - --DOMWINDOW == 28 (000000685021D800) [pid = 3984] [serial = 26] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 27 (0000006854868800) [pid = 3984] [serial = 28] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 26 (0000006844D2E800) [pid = 3984] [serial = 29] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 25 (000000684F74A000) [pid = 3984] [serial = 30] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 24 (00000068581C2000) [pid = 3984] [serial = 31] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 23 (00000068586C0000) [pid = 3984] [serial = 32] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 22 (0000006843F38000) [pid = 3984] [serial = 27] [outer = 0000000000000000] [url = http://127.0.0.1:49339/test_accessibility.html]
10:46:02 INFO - --DOMWINDOW == 21 (0000006859EC9800) [pid = 3984] [serial = 33] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20top%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
10:46:02 INFO - 1500918362371 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362376 Marionette TRACE 380 <- [1,2,null,{}]
10:46:02 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:02 INFO - 1500918362398 Marionette DEBUG Closed connection 380
10:46:02 INFO - 1500918362401 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49817
10:46:02 INFO - 1500918362403 Marionette DEBUG Closed connection 381
10:46:02 INFO - 1500918362404 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49818
10:46:02 INFO - 1500918362407 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:46:02 INFO - 1500918362412 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:02 INFO - 1500918362437 Marionette DEBUG Register listener.js for window 12
10:46:02 INFO - 1500918362452 Marionette TRACE 382 <- [1,1,null,{"sessionId":"a39d026f-8aad-4058-8778-3037e1d2bc8f","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:02 INFO - 1500918362459 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"}]
10:46:02 INFO - 1500918362465 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"
10:46:02 INFO - 1500918362473 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"
10:46:02 INFO - 1500918362473 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"
10:46:02 INFO - ++DOMWINDOW == 22 (0000006846095800) [pid = 3984] [serial = 46] [outer = 000000684FFDB000]
10:46:02 INFO - 1500918362554 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"
10:46:02 INFO - 1500918362567 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"
10:46:02 INFO - 1500918362578 Marionette TRACE 382 <- [1,2,null,{}]
10:46:02 INFO - 1500918362589 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:46:02 INFO - 1500918362598 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"613c9f53-c007-4f4b-ae6e-a1404d1beac5","ELEMENT":"613c9f53-c007-4f4b-ae6e-a1404d1beac5"}}]
10:46:02 INFO - 1500918362600 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"613c9f53-c007-4f4b-ae6e-a1404d1beac5"}]
10:46:03 INFO - 1500918363049 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:46:03 INFO - 1500918363051 Marionette TRACE 382 <- [1,4,null,{}]
10:46:03 INFO - 1500918363054 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}]
10:46:03 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500918363063 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:46:03 INFO - 1500918363065 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363069 Marionette TRACE 382 <- [1,6,null,{}]
10:46:03 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 935ms
10:46:03 INFO - TEST-START | test_click.py TestClick.test_input_file
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363075 Marionette DEBUG Closed connection 382
10:46:03 INFO - 1500918363077 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49819
10:46:03 INFO - 1500918363081 Marionette DEBUG Closed connection 383
10:46:03 INFO - 1500918363086 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49820
10:46:03 INFO - 1500918363089 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:03 INFO - 1500918363091 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363115 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363129 Marionette TRACE 384 <- [1,1,null,{"sessionId":"b8d34bab-c4d1-4a52-8bb6-148ceeee9606","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363136 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:46:03 INFO - 1500918363137 Marionette TRACE 384 <- [1,2,null,{}]
10:46:03 INFO - 1500918363139 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:46:03 INFO - 1500918363141 Marionette TRACE 384 <- [1,3,null,{}]
10:46:03 INFO - 1500918363143 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:46:03 INFO - 1500918363144 Marionette TRACE 384 <- [1,4,null,{}]
10:46:03 INFO - 1500918363147 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}]
10:46:03 INFO - TEST-START: test_click.py TestClick.test_input_file1500918363158 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:46:03 INFO - 1500918363160 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363165 Marionette TRACE 384 <- [1,6,null,{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363171 Marionette DEBUG Closed connection 384
10:46:03 INFO - 1500918363173 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49821
10:46:03 INFO - 1500918363175 Marionette DEBUG Closed connection 385
10:46:03 INFO - 1500918363176 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49822
10:46:03 INFO - 1500918363178 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:03 INFO - 1500918363181 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363205 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363217 Marionette TRACE 386 <- [1,1,null,{"sessionId":"62b0f36c-2935-4f99-bd79-6e7ecc0befab","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363223 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363227 Marionette TRACE 386 <- [1,2,null,{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363233 Marionette DEBUG Closed connection 386
10:46:03 INFO - 1500918363235 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49823
10:46:03 INFO - 1500918363237 Marionette DEBUG Closed connection 387
10:46:03 INFO - 1500918363238 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49824
10:46:03 INFO - 1500918363241 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:46:03 INFO - 1500918363243 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363267 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363279 Marionette TRACE 388 <- [1,1,null,{"sessionId":"46f43365-4983-4b5a-8855-803b038171f7","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363286 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:46:03 INFO - 1500918363293 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"
10:46:03 INFO - 1500918363299 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"
10:46:03 INFO - 1500918363301 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"
10:46:03 INFO - ++DOMWINDOW == 23 (000000684D085800) [pid = 3984] [serial = 47] [outer = 000000684FFDB000]
10:46:03 INFO - 1500918363363 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:46:03 INFO - 1500918363369 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:46:03 INFO - 1500918363389 Marionette TRACE 388 <- [1,2,null,{}]
10:46:03 INFO - 1500918363393 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:46:03 INFO - 1500918363402 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0038c2f-b43a-4a5c-b290-566c1846a263","ELEMENT":"e0038c2f-b43a-4a5c-b290-566c1846a263"}}]
10:46:03 INFO - 1500918363404 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"e0038c2f-b43a-4a5c-b290-566c1846a263"}]
10:46:03 INFO - 1500918363593 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:46:03 INFO - 1500918363599 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}]
10:46:03 INFO - TEST-END: test_click.py TestClick.test_input_file1500918363607 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:46:03 INFO - 1500918363609 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 544ms
10:46:03 INFO - 1500918363614 Marionette TRACE 388 <- [1,6,null,{}]
10:46:03 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363620 Marionette DEBUG Closed connection 388
10:46:03 INFO - 1500918363621 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49825
10:46:03 INFO - 1500918363623 Marionette DEBUG Closed connection 389
10:46:03 INFO - 1500918363624 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49826
10:46:03 INFO - 1500918363626 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:03 INFO - 1500918363628 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363652 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363664 Marionette TRACE 390 <- [1,1,null,{"sessionId":"96762db9-5eb1-4c0c-9bef-12f40522a201","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363671 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:46:03 INFO - 1500918363672 Marionette TRACE 390 <- [1,2,null,{}]
10:46:03 INFO - 1500918363674 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:46:03 INFO - 1500918363676 Marionette TRACE 390 <- [1,3,null,{}]
10:46:03 INFO - 1500918363678 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:46:03 INFO - 1500918363679 Marionette TRACE 390 <- [1,4,null,{}]
10:46:03 INFO - 1500918363682 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}]
10:46:03 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500918363691 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:46:03 INFO - 1500918363693 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363697 Marionette TRACE 390 <- [1,6,null,{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363703 Marionette DEBUG Closed connection 390
10:46:03 INFO - 1500918363704 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49827
10:46:03 INFO - 1500918363706 Marionette DEBUG Closed connection 391
10:46:03 INFO - 1500918363707 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49828
10:46:03 INFO - 1500918363709 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:03 INFO - 1500918363712 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363736 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363747 Marionette TRACE 392 <- [1,1,null,{"sessionId":"c0e480f5-f73d-4a4a-b5d1-6911bd880410","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363754 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363758 Marionette TRACE 392 <- [1,2,null,{}]
10:46:03 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:03 INFO - 1500918363764 Marionette DEBUG Closed connection 392
10:46:03 INFO - 1500918363765 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49829
10:46:03 INFO - 1500918363767 Marionette DEBUG Closed connection 393
10:46:03 INFO - 1500918363768 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49830
10:46:03 INFO - 1500918363770 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:46:03 INFO - 1500918363774 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:03 INFO - 1500918363803 Marionette DEBUG Register listener.js for window 12
10:46:03 INFO - 1500918363817 Marionette TRACE 394 <- [1,1,null,{"sessionId":"ba97eb56-fdb5-44eb-a7fc-2ed4ed812e76","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:03 INFO - 1500918363824 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"}]
10:46:03 INFO - 1500918363828 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:46:03 INFO - 1500918363837 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:46:03 INFO - 1500918363838 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:46:03 INFO - ++DOMWINDOW == 24 (000000684FFE5800) [pid = 3984] [serial = 48] [outer = 000000684FFDB000]
10:46:03 INFO - 1500918363900 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"
10:46:03 INFO - 1500918363906 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"
10:46:03 INFO - 1500918363923 Marionette TRACE 394 <- [1,2,null,{}]
10:46:03 INFO - 1500918363926 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:46:03 INFO - 1500918363934 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"65f94379-55a9-41b7-90ec-4605053bcb84","ELEMENT":"65f94379-55a9-41b7-90ec-4605053bcb84"}}]
10:46:03 INFO - 1500918363937 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:46:03 INFO - 1500918363944 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"a40b97b2-46de-4bdb-a20e-f265953e98ed","ELEMENT":"a40b97b2-46de-4bdb-a20e-f265953e98ed"}}]
10:46:03 INFO - 1500918363946 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"65f94379-55a9-41b7-90ec-4605053bcb84"}]
10:46:04 INFO - 1500918364385 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:46:04 INFO - 1500918364387 Marionette TRACE 394 <- [1,5,null,{}]
10:46:04 INFO - 1500918364390 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"a40b97b2-46de-4bdb-a20e-f265953e98ed"}]
10:46:04 INFO - 1500918364528 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:447:12\nclickElement@chrome://marionette/content/listener.js:1367:5\n"},null]
10:46:04 INFO - 1500918364538 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
10:46:04 INFO - 1500918364553 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:46:04 INFO - 1500918364563 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}]
10:46:04 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500918364575 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:46:04 INFO - 1500918364589 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364593 Marionette TRACE 394 <- [1,9,null,{}]
10:46:04 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 979ms
10:46:04 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364604 Marionette DEBUG Closed connection 394
10:46:04 INFO - 1500918364605 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49831
10:46:04 INFO - 1500918364619 Marionette DEBUG Closed connection 395
10:46:04 INFO - 1500918364621 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49832
10:46:04 INFO - 1500918364624 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:04 INFO - 1500918364627 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:04 INFO - 1500918364651 Marionette DEBUG Register listener.js for window 12
10:46:04 INFO - 1500918364662 Marionette TRACE 396 <- [1,1,null,{"sessionId":"8e647c0c-3b50-4d11-ab0b-1c0fe4f6ea0e","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:04 INFO - 1500918364669 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:46:04 INFO - 1500918364670 Marionette TRACE 396 <- [1,2,null,{}]
10:46:04 INFO - 1500918364673 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:46:04 INFO - 1500918364675 Marionette TRACE 396 <- [1,3,null,{}]
10:46:04 INFO - 1500918364676 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:46:04 INFO - 1500918364678 Marionette TRACE 396 <- [1,4,null,{}]
10:46:04 INFO - 1500918364681 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}]
10:46:04 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500918364689 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:46:04 INFO - 1500918364691 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364695 Marionette TRACE 396 <- [1,6,null,{}]
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364702 Marionette DEBUG Closed connection 396
10:46:04 INFO - 1500918364704 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49833
10:46:04 INFO - 1500918364705 Marionette DEBUG Closed connection 397
10:46:04 INFO - 1500918364706 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49834
10:46:04 INFO - 1500918364709 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:46:04 INFO - 1500918364711 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:04 INFO - 1500918364735 Marionette DEBUG Register listener.js for window 12
10:46:04 INFO - 1500918364746 Marionette TRACE 398 <- [1,1,null,{"sessionId":"0e3ab7e2-b1bf-40d1-b45c-581a6175eda5","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:04 INFO - 1500918364752 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364756 Marionette TRACE 398 <- [1,2,null,{}]
10:46:04 INFO - [Parent 3984] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:46:04 INFO - 1500918364762 Marionette DEBUG Closed connection 398
10:46:04 INFO - 1500918364763 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49835
10:46:04 INFO - 1500918364765 Marionette DEBUG Closed connection 399
10:46:04 INFO - 1500918364766 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49836
10:46:04 INFO - 1500918364769 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:46:04 INFO - 1500918364782 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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}
10:46:04 INFO - 1500918364806 Marionette DEBUG Register listener.js for window 12
10:46:04 INFO - 1500918364817 Marionette TRACE 400 <- [1,1,null,{"sessionId":"6c193920-1987-48e6-b100-1fb3ecbe5296","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":3984,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-149.001\\AppData\\Local\\Temp\\tmp_3snkl.mozrunner","moz:accessibilityChecks":false}}]
10:46:04 INFO - 1500918364824 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"}]
10:46:04 INFO - 1500918364828 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"
10:46:04 INFO - 1500918364847 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"
10:46:04 INFO - 1500918364847 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"
10:46:04 INFO - ++DOMWINDOW == 25 (0000006858622000) [pid = 3984] [serial = 49] [outer = 000000684FFDB000]
10:46:04 INFO - 1500918364908 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"
10:46:04 INFO - 1500918364913 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"
10:46:04 INFO - 1500918364921 Marionette TRACE 400 <- [1,2,null,{}]
10:46:04 INFO - 1500918364932 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:46:04 INFO - 1500918364941 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7924eb0f-d490-4f74-9eac-ef00107ffdb6","ELEMENT":"7924eb0f-d490-4f74-9eac-ef00107ffdb6"}}]
10:46:04 INFO - 1500918364943 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"7924eb0f-d490-4f74-9eac-ef00107ffdb6"}]
10:46:05 INFO - 1500918365074 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:46:05 INFO - 1500918365076 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"7924eb0f-d490-4f74-9eac-ef00107ffdb6"}]
10:46:05 INFO - 1500918365220 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element