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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
01:33:54 INFO - 1499675634788 Marionette TRACE 354 -> [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}]
01:33:54 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499675634796 Marionette TRACE 354 <- [1,5,null,{"value":null}]
01:33:54 INFO - 1499675634798 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
01:33:54 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:54 INFO - 1499675634803 Marionette TRACE 354 <- [1,6,null,{}]
01:33:54 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1535ms
01:33:54 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
01:33:54 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:54 INFO - 1499675634809 Marionette DEBUG Closed connection 354
01:33:54 INFO - 1499675634810 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49780
01:33:54 INFO - 1499675634814 Marionette DEBUG Closed connection 355
01:33:54 INFO - 1499675634819 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49781
01:33:54 INFO - 1499675634840 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:54 INFO - 1499675634846 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:54 INFO - 1499675634868 Marionette DEBUG Register listener.js for window 12
01:33:54 INFO - 1499675634882 Marionette TRACE 356 <- [1,1,null,{"sessionId":"9b356d2d-132c-442a-8bc2-ca94019e8e0a","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:54 INFO - 1499675634891 Marionette TRACE 356 -> [0,2,"setTimeouts",{"script":30000}]
01:33:54 INFO - 1499675634893 Marionette TRACE 356 <- [1,2,null,{}]
01:33:54 INFO - 1499675634895 Marionette TRACE 356 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:33:54 INFO - 1499675634897 Marionette TRACE 356 <- [1,3,null,{}]
01:33:54 INFO - 1499675634899 Marionette TRACE 356 -> [0,4,"setTimeouts",{"implicit":0}]
01:33:54 INFO - 1499675634901 Marionette TRACE 356 <- [1,4,null,{}]
01:33:54 INFO - 1499675634903 Marionette TRACE 356 -> [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}]
01:33:54 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499675634915 Marionette TRACE 356 <- [1,5,null,{"value":null}]
01:33:54 INFO - 1499675634917 Marionette TRACE 356 -> [0,6,"deleteSession",{}]
01:33:54 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:54 INFO - 1499675634922 Marionette TRACE 356 <- [1,6,null,{}]
01:33:54 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:54 INFO - 1499675634944 Marionette DEBUG Closed connection 356
01:33:54 INFO - 1499675634946 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49782
01:33:54 INFO - 1499675634950 Marionette DEBUG Closed connection 357
01:33:54 INFO - 1499675634951 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49783
01:33:54 INFO - 1499675634953 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:54 INFO - 1499675634956 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:54 INFO - 1499675634978 Marionette DEBUG Register listener.js for window 12
01:33:54 INFO - 1499675634991 Marionette TRACE 358 <- [1,1,null,{"sessionId":"f0e52c36-aba3-4633-b8ef-93fc5a0e7161","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:55 INFO - 1499675635003 Marionette TRACE 358 -> [0,2,"deleteSession",{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635008 Marionette TRACE 358 <- [1,2,null,{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635028 Marionette DEBUG Closed connection 358
01:33:55 INFO - 1499675635029 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49784
01:33:55 INFO - 1499675635031 Marionette DEBUG Closed connection 359
01:33:55 INFO - 1499675635032 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49785
01:33:55 INFO - 1499675635034 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:33:55 INFO - 1499675635037 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:55 INFO - 1499675635059 Marionette DEBUG Register listener.js for window 12
01:33:55 INFO - 1499675635070 Marionette TRACE 360 <- [1,1,null,{"sessionId":"78c13fe1-0386-45ea-aaf0-62d484b81a16","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:55 INFO - 1499675635082 Marionette TRACE 360 -> [0,2,"get",{"url":"http://127.0.0.1:49335/clicks.html"}]
01:33:55 INFO - 1499675635086 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/hidden.html"
01:33:55 INFO - 1499675635098 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/hidden.html"
01:33:55 INFO - 1499675635099 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/hidden.html"
01:33:55 INFO - ++DOMWINDOW == 21 (000000F4618FA000) [pid = 3712] [serial = 44] [outer = 000000F463041000]
01:33:55 INFO - 1499675635169 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/clicks.html"
01:33:55 INFO - 1499675635174 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/clicks.html"
01:33:55 INFO - 1499675635197 Marionette TRACE 360 <- [1,2,null,{}]
01:33:55 INFO - 1499675635200 Marionette TRACE 360 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
01:33:55 INFO - 1499675635211 Marionette TRACE 360 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"903c850f-ac0c-4312-a3c5-ab674dc6a564","ELEMENT":"903c850f-ac0c-4312-a3c5-ab674dc6a564"}}]
01:33:55 INFO - 1499675635213 Marionette TRACE 360 -> [0,4,"clickElement",{"id":"903c850f-ac0c-4312-a3c5-ab674dc6a564"}]
01:33:55 INFO - 1499675635466 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/clicks.html"
01:33:55 INFO - [3712] WARNING: Cannot switch to prerendered document in the parent process: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/xpfe/appshell/nsContentTreeOwner.cpp, line 446
01:33:55 INFO - 1499675635501 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/clicks.html"
01:33:55 INFO - 1499675635502 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/clicks.html"
01:33:55 INFO - ++DOMWINDOW == 22 (000000F462864000) [pid = 3712] [serial = 45] [outer = 000000F463041000]
01:33:55 INFO - 1499675635571 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49335/test.html"
01:33:55 INFO - 1499675635575 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49335/test.html"
01:33:55 INFO - 1499675635592 Marionette TRACE 360 <- [1,4,null,{}]
01:33:55 INFO - 1499675635599 Marionette TRACE 360 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
01:33:55 INFO - 1499675635609 Marionette TRACE 360 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"54cef4f4-67d4-47e8-bde7-714c939968b8","ELEMENT":"54cef4f4-67d4-47e8-bde7-714c939968b8"}}]
01:33:55 INFO - 1499675635613 Marionette TRACE 360 -> [0,6,"getTitle",{}]
01:33:55 INFO - 1499675635615 Marionette TRACE 360 <- [1,6,null,{"value":"Marionette Test"}]
01:33:55 INFO - 1499675635618 Marionette TRACE 360 -> [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}]
01:33:55 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499675635625 Marionette TRACE 360 <- [1,7,null,{"value":null}]
01:33:55 INFO - 1499675635627 Marionette TRACE 360 -> [0,8,"deleteSession",{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635632 Marionette TRACE 360 <- [1,8,null,{}]
01:33:55 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 829ms
01:33:55 INFO - TEST-START | test_click.py TestClick.test_container_element
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635638 Marionette DEBUG Closed connection 360
01:33:55 INFO - 1499675635640 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49788
01:33:55 INFO - 1499675635642 Marionette DEBUG Closed connection 361
01:33:55 INFO - 1499675635644 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49789
01:33:55 INFO - 1499675635646 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:55 INFO - 1499675635649 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:55 INFO - 1499675635671 Marionette DEBUG Register listener.js for window 12
01:33:55 INFO - 1499675635682 Marionette TRACE 362 <- [1,1,null,{"sessionId":"e82af4e0-2516-42ba-93c3-f24a318ac9b8","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:55 INFO - 1499675635689 Marionette TRACE 362 -> [0,2,"setTimeouts",{"script":30000}]
01:33:55 INFO - 1499675635690 Marionette TRACE 362 <- [1,2,null,{}]
01:33:55 INFO - 1499675635715 Marionette TRACE 362 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:33:55 INFO - 1499675635717 Marionette TRACE 362 <- [1,3,null,{}]
01:33:55 INFO - 1499675635719 Marionette TRACE 362 -> [0,4,"setTimeouts",{"implicit":0}]
01:33:55 INFO - 1499675635721 Marionette TRACE 362 <- [1,4,null,{}]
01:33:55 INFO - 1499675635723 Marionette TRACE 362 -> [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}]
01:33:55 INFO - TEST-START: test_click.py TestClick.test_container_element1499675635733 Marionette TRACE 362 <- [1,5,null,{"value":null}]
01:33:55 INFO - 1499675635735 Marionette TRACE 362 -> [0,6,"deleteSession",{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635739 Marionette TRACE 362 <- [1,6,null,{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635745 Marionette DEBUG Closed connection 362
01:33:55 INFO - 1499675635746 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49790
01:33:55 INFO - 1499675635748 Marionette DEBUG Closed connection 363
01:33:55 INFO - 1499675635749 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49791
01:33:55 INFO - 1499675635751 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:55 INFO - 1499675635754 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:55 INFO - 1499675635776 Marionette DEBUG Register listener.js for window 12
01:33:55 INFO - 1499675635787 Marionette TRACE 364 <- [1,1,null,{"sessionId":"15e497ae-a860-4679-8beb-18743a189036","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:55 INFO - 1499675635816 Marionette TRACE 364 -> [0,2,"deleteSession",{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635820 Marionette TRACE 364 <- [1,2,null,{}]
01:33:55 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:55 INFO - 1499675635840 Marionette DEBUG Closed connection 364
01:33:55 INFO - 1499675635842 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49792
01:33:55 INFO - 1499675635847 Marionette DEBUG Closed connection 365
01:33:55 INFO - 1499675635848 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49793
01:33:55 INFO - 1499675635851 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:33:55 INFO - 1499675635854 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:55 INFO - 1499675635876 Marionette DEBUG Register listener.js for window 12
01:33:55 INFO - 1499675635887 Marionette TRACE 366 <- [1,1,null,{"sessionId":"5b18c6c5-ab06-462e-ba11-d41b185c7915","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:55 INFO - 1499675635897 Marionette TRACE 366 -> [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"}]
01:33:55 INFO - 1499675635901 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49335/test.html"
01:33:55 INFO - 1499675635910 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49335/test.html"
01:33:55 INFO - 1499675635911 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49335/test.html"
01:33:55 INFO - ++DOMWINDOW == 23 (000000F467145000) [pid = 3712] [serial = 46] [outer = 000000F463041000]
01:33:55 INFO - 1499675635969 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"
01:33:55 INFO - 1499675635989 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"
01:33:56 INFO - 1499675636003 Marionette TRACE 366 <- [1,2,null,{}]
01:33:56 INFO - 1499675636011 Marionette TRACE 366 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
01:33:56 INFO - 1499675636019 Marionette TRACE 366 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"535811a4-7e96-41c7-bbd6-b9d3c47c773e","ELEMENT":"535811a4-7e96-41c7-bbd6-b9d3c47c773e"}}]
01:33:56 INFO - 1499675636024 Marionette TRACE 366 -> [0,4,"clickElement",{"id":"535811a4-7e96-41c7-bbd6-b9d3c47c773e"}]
01:33:56 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
01:33:56 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
01:33:56 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
01:33:57 INFO - 1499675637053 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:33:57 INFO - 1499675637071 Marionette TRACE 366 <- [1,4,null,{}]
01:33:57 INFO - 1499675637087 Marionette TRACE 366 -> [0,5,"getElementProperty",{"id":"535811a4-7e96-41c7-bbd6-b9d3c47c773e","name":"selected"}]
01:33:57 INFO - 1499675637110 Marionette TRACE 366 <- [1,5,null,{"value":true}]
01:33:57 INFO - 1499675637113 Marionette TRACE 366 -> [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}]
01:33:57 INFO - TEST-END: test_click.py TestClick.test_container_element1499675637120 Marionette TRACE 366 <- [1,6,null,{"value":null}]
01:33:57 INFO - 1499675637122 Marionette TRACE 366 -> [0,7,"deleteSession",{}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637127 Marionette TRACE 366 <- [1,7,null,{}]
01:33:57 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1495ms
01:33:57 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637133 Marionette DEBUG Closed connection 366
01:33:57 INFO - 1499675637134 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49794
01:33:57 INFO - 1499675637160 Marionette DEBUG Closed connection 367
01:33:57 INFO - 1499675637161 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49795
01:33:57 INFO - 1499675637164 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:57 INFO - 1499675637167 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:57 INFO - 1499675637204 Marionette DEBUG Register listener.js for window 12
01:33:57 INFO - 1499675637218 Marionette TRACE 368 <- [1,1,null,{"sessionId":"6f7d61db-9ee2-4a65-b752-2e20b6156132","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:57 INFO - 1499675637225 Marionette TRACE 368 -> [0,2,"setTimeouts",{"script":30000}]
01:33:57 INFO - 1499675637226 Marionette TRACE 368 <- [1,2,null,{}]
01:33:57 INFO - 1499675637228 Marionette TRACE 368 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:33:57 INFO - 1499675637230 Marionette TRACE 368 <- [1,3,null,{}]
01:33:57 INFO - 1499675637232 Marionette TRACE 368 -> [0,4,"setTimeouts",{"implicit":0}]
01:33:57 INFO - 1499675637234 Marionette TRACE 368 <- [1,4,null,{}]
01:33:57 INFO - 1499675637237 Marionette TRACE 368 -> [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}]
01:33:57 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499675637246 Marionette TRACE 368 <- [1,5,null,{"value":null}]
01:33:57 INFO - 1499675637248 Marionette TRACE 368 -> [0,6,"deleteSession",{}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637253 Marionette TRACE 368 <- [1,6,null,{}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637259 Marionette DEBUG Closed connection 368
01:33:57 INFO - 1499675637260 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49796
01:33:57 INFO - 1499675637262 Marionette DEBUG Closed connection 369
01:33:57 INFO - 1499675637263 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49797
01:33:57 INFO - 1499675637265 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:57 INFO - 1499675637267 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:57 INFO - 1499675637290 Marionette DEBUG Register listener.js for window 12
01:33:57 INFO - 1499675637300 Marionette TRACE 370 <- [1,1,null,{"sessionId":"cbfd3782-c97a-4f48-8c51-8215c6f5ec1d","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:57 INFO - 1499675637306 Marionette TRACE 370 -> [0,2,"deleteSession",{}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637310 Marionette TRACE 370 <- [1,2,null,{}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:57 INFO - 1499675637316 Marionette DEBUG Closed connection 370
01:33:57 INFO - 1499675637317 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49798
01:33:57 INFO - 1499675637319 Marionette DEBUG Closed connection 371
01:33:57 INFO - 1499675637320 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49799
01:33:57 INFO - 1499675637322 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:33:57 INFO - 1499675637325 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:57 INFO - 1499675637347 Marionette DEBUG Register listener.js for window 12
01:33:57 INFO - 1499675637404 Marionette TRACE 372 <- [1,1,null,{"sessionId":"7a50dd05-c021-4aed-a73d-07aa94c660fc","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:57 INFO - 1499675637410 Marionette TRACE 372 -> [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"}]
01:33:57 INFO - 1499675637414 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"
01:33:57 INFO - 1499675637420 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"
01:33:57 INFO - 1499675637421 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"
01:33:57 INFO - ++DOMWINDOW == 24 (000000F4673DD800) [pid = 3712] [serial = 47] [outer = 000000F463041000]
01:33:57 INFO - 1499675637466 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"
01:33:57 INFO - 1499675637481 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"
01:33:57 INFO - 1499675637497 Marionette TRACE 372 <- [1,2,null,{}]
01:33:57 INFO - 1499675637500 Marionette TRACE 372 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
01:33:57 INFO - 1499675637508 Marionette TRACE 372 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bd841ef3-c44e-4e1e-9877-8416d2845393","ELEMENT":"bd841ef3-c44e-4e1e-9877-8416d2845393"}}]
01:33:57 INFO - 1499675637516 Marionette TRACE 372 -> [0,4,"clickElement",{"id":"bd841ef3-c44e-4e1e-9877-8416d2845393"}]
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
01:33:57 INFO - [3712] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
01:33:57 INFO - 1499675637932 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:33:57 INFO - 1499675637935 Marionette TRACE 372 <- [1,4,null,{}]
01:33:57 INFO - 1499675637941 Marionette TRACE 372 -> [0,5,"getElementProperty",{"id":"bd841ef3-c44e-4e1e-9877-8416d2845393","name":"selected"}]
01:33:57 INFO - 1499675637990 Marionette TRACE 372 <- [1,5,null,{"value":true}]
01:33:58 INFO - 1499675638000 Marionette TRACE 372 -> [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}]
01:33:58 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499675638014 Marionette TRACE 372 <- [1,6,null,{"value":null}]
01:33:58 INFO - 1499675638068 Marionette TRACE 372 -> [0,7,"deleteSession",{}]
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638077 Marionette TRACE 372 <- [1,7,null,{}]
01:33:58 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 954ms
01:33:58 INFO - TEST-START | test_click.py TestClick.test_css_transforms
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638106 Marionette DEBUG Closed connection 372
01:33:58 INFO - 1499675638109 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49800
01:33:58 INFO - 1499675638112 Marionette DEBUG Closed connection 373
01:33:58 INFO - 1499675638117 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49801
01:33:58 INFO - 1499675638122 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:58 INFO - 1499675638131 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:58 INFO - 1499675638175 Marionette DEBUG Register listener.js for window 12
01:33:58 INFO - 1499675638209 Marionette TRACE 374 <- [1,1,null,{"sessionId":"57b436d8-4ce3-4db7-9cba-2475e829bc96","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:58 INFO - 1499675638229 Marionette TRACE 374 -> [0,2,"setTimeouts",{"script":30000}]
01:33:58 INFO - 1499675638234 Marionette TRACE 374 <- [1,2,null,{}]
01:33:58 INFO - 1499675638286 Marionette TRACE 374 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:33:58 INFO - 1499675638289 Marionette TRACE 374 <- [1,3,null,{}]
01:33:58 INFO - 1499675638292 Marionette TRACE 374 -> [0,4,"setTimeouts",{"implicit":0}]
01:33:58 INFO - 1499675638295 Marionette TRACE 374 <- [1,4,null,{}]
01:33:58 INFO - 1499675638299 Marionette TRACE 374 -> [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}]
01:33:58 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499675638311 Marionette TRACE 374 <- [1,5,null,{"value":null}]
01:33:58 INFO - 1499675638315 Marionette TRACE 374 -> [0,6,"deleteSession",{}]
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638322 Marionette TRACE 374 <- [1,6,null,{}]
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638380 Marionette DEBUG Closed connection 374
01:33:58 INFO - 1499675638384 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49802
01:33:58 INFO - 1499675638405 Marionette DEBUG Closed connection 375
01:33:58 INFO - 1499675638407 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49803
01:33:58 INFO - 1499675638410 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:58 INFO - 1499675638414 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:58 INFO - 1499675638458 Marionette DEBUG Register listener.js for window 12
01:33:58 INFO - 1499675638495 Marionette TRACE 376 <- [1,1,null,{"sessionId":"c205303f-5307-4297-984b-14085b38b7c9","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:58 INFO - 1499675638523 Marionette TRACE 376 -> [0,2,"deleteSession",{}]
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638532 Marionette TRACE 376 <- [1,2,null,{}]
01:33:58 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:58 INFO - 1499675638558 Marionette DEBUG Closed connection 376
01:33:58 INFO - 1499675638560 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49804
01:33:58 INFO - 1499675638565 Marionette DEBUG Closed connection 377
01:33:58 INFO - 1499675638567 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49805
01:33:58 INFO - 1499675638600 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:33:58 INFO - 1499675638604 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:58 INFO - 1499675638648 Marionette DEBUG Register listener.js for window 12
01:33:58 INFO - 1499675638664 Marionette TRACE 378 <- [1,1,null,{"sessionId":"9d0227f5-cc14-4f16-b9a4-55586ce0ef3b","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:58 INFO - 1499675638676 Marionette TRACE 378 -> [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"}]
01:33:58 INFO - 1499675638681 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"
01:33:58 INFO - 1499675638692 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"
01:33:58 INFO - 1499675638693 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"
01:33:58 INFO - ++DOMWINDOW == 25 (000000F461433800) [pid = 3712] [serial = 48] [outer = 000000F463041000]
01:33:58 INFO - 1499675638763 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"
01:33:58 INFO - 1499675638772 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"
01:33:58 INFO - 1499675638968 Marionette TRACE 378 <- [1,2,null,{}]
01:33:58 INFO - 1499675638978 Marionette TRACE 378 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
01:33:59 INFO - 1499675638990 Marionette TRACE 378 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"836f62ab-44ff-4699-aa98-84fa47ebbc98","ELEMENT":"836f62ab-44ff-4699-aa98-84fa47ebbc98"}}]
01:33:59 INFO - 1499675638994 Marionette TRACE 378 -> [0,4,"clickElement",{"id":"836f62ab-44ff-4699-aa98-84fa47ebbc98"}]
01:33:59 INFO - 1499675639432 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:33:59 INFO - 1499675639438 Marionette TRACE 378 <- [1,4,null,{}]
01:33:59 INFO - 1499675639443 Marionette TRACE 378 -> [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}]
01:33:59 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499675639456 Marionette TRACE 378 <- [1,5,null,{"value":null}]
01:33:59 INFO - 1499675639461 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639468 Marionette TRACE 378 <- [1,6,null,{}]
01:33:59 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1387ms
01:33:59 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639477 Marionette DEBUG Closed connection 378
01:33:59 INFO - 1499675639481 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49806
01:33:59 INFO - 1499675639484 Marionette DEBUG Closed connection 379
01:33:59 INFO - 1499675639487 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49807
01:33:59 INFO - 1499675639490 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:59 INFO - 1499675639499 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:59 INFO - 1499675639522 Marionette DEBUG Register listener.js for window 12
01:33:59 INFO - 1499675639541 Marionette TRACE 380 <- [1,1,null,{"sessionId":"e3b434e4-0345-4ff1-ace2-69f1fd014495","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:59 INFO - 1499675639555 Marionette TRACE 380 -> [0,2,"setTimeouts",{"script":30000}]
01:33:59 INFO - 1499675639558 Marionette TRACE 380 <- [1,2,null,{}]
01:33:59 INFO - 1499675639584 Marionette TRACE 380 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:33:59 INFO - 1499675639587 Marionette TRACE 380 <- [1,3,null,{}]
01:33:59 INFO - 1499675639590 Marionette TRACE 380 -> [0,4,"setTimeouts",{"implicit":0}]
01:33:59 INFO - 1499675639592 Marionette TRACE 380 <- [1,4,null,{}]
01:33:59 INFO - 1499675639602 Marionette TRACE 380 -> [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}]
01:33:59 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499675639612 Marionette TRACE 380 <- [1,5,null,{"value":null}]
01:33:59 INFO - --DOMWINDOW == 24 (000000F4617CA800) [pid = 3712] [serial = 38] [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%20vertically%20%2A/%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]
01:33:59 INFO - --DOMWINDOW == 23 (000000F461425800) [pid = 3712] [serial = 37] [outer = 0000000000000000] [url = data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20position%3A%20absolute%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20/%2A%20move%20centre%20point%20off%20viewport%20horizontally%20%2A/%0A%20%20%20%20%20%20%20%20%20%20%20%20%20left%3A%20-105px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E]
01:33:59 INFO - --DOMWINDOW == 22 (000000F46C319000) [pid = 3712] [serial = 35] [outer = 0000000000000000] [url = http://127.0.0.1:49335/test_accessibility.html]
01:33:59 INFO - --DOMWINDOW == 21 (000000F456DD2800) [pid = 3712] [serial = 36] [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]
01:33:59 INFO - 1499675639620 Marionette TRACE 380 -> [0,6,"deleteSession",{}]
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639627 Marionette TRACE 380 <- [1,6,null,{}]
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639651 Marionette DEBUG Closed connection 380
01:33:59 INFO - 1499675639654 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49808
01:33:59 INFO - 1499675639656 Marionette DEBUG Closed connection 381
01:33:59 INFO - 1499675639658 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49809
01:33:59 INFO - 1499675639665 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:33:59 INFO - 1499675639670 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:59 INFO - 1499675639694 Marionette DEBUG Register listener.js for window 12
01:33:59 INFO - 1499675639732 Marionette TRACE 382 <- [1,1,null,{"sessionId":"3bdfc68f-8d23-4809-a739-915c9e17e178","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:59 INFO - 1499675639743 Marionette TRACE 382 -> [0,2,"deleteSession",{}]
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639749 Marionette TRACE 382 <- [1,2,null,{}]
01:33:59 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:33:59 INFO - 1499675639776 Marionette DEBUG Closed connection 382
01:33:59 INFO - 1499675639778 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49810
01:33:59 INFO - 1499675639891 Marionette DEBUG Closed connection 383
01:33:59 INFO - 1499675639893 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49811
01:33:59 INFO - 1499675639898 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:33:59 INFO - 1499675639901 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:33:59 INFO - 1499675639924 Marionette DEBUG Register listener.js for window 12
01:33:59 INFO - 1499675639938 Marionette TRACE 384 <- [1,1,null,{"sessionId":"955be3db-4843-4ba0-9da5-5160ce258864","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:33:59 INFO - 1499675639946 Marionette TRACE 384 -> [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"}]
01:33:59 INFO - 1499675639952 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"
01:33:59 INFO - 1499675639961 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"
01:33:59 INFO - 1499675639962 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"
01:33:59 INFO - ++DOMWINDOW == 22 (000000F461427000) [pid = 3712] [serial = 49] [outer = 000000F463041000]
01:34:00 INFO - 1499675640017 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"
01:34:00 INFO - 1499675640035 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"
01:34:00 INFO - 1499675640053 Marionette TRACE 384 <- [1,2,null,{}]
01:34:00 INFO - 1499675640064 Marionette TRACE 384 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
01:34:00 INFO - 1499675640072 Marionette TRACE 384 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7d9740c1-b6d8-4119-a88c-9203d5df32db","ELEMENT":"7d9740c1-b6d8-4119-a88c-9203d5df32db"}}]
01:34:00 INFO - 1499675640074 Marionette TRACE 384 -> [0,4,"clickElement",{"id":"7d9740c1-b6d8-4119-a88c-9203d5df32db"}]
01:34:01 INFO - 1499675641079 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:34:01 INFO - 1499675641102 Marionette TRACE 384 <- [1,4,null,{}]
01:34:01 INFO - 1499675641144 Marionette TRACE 384 -> [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}]
01:34:01 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499675641155 Marionette TRACE 384 <- [1,5,null,{"value":null}]
01:34:01 INFO - 1499675641206 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641211 Marionette TRACE 384 <- [1,6,null,{}]
01:34:01 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1745ms
01:34:01 INFO - TEST-START | test_click.py TestClick.test_input_file
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641262 Marionette DEBUG Closed connection 384
01:34:01 INFO - 1499675641264 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49812
01:34:01 INFO - 1499675641266 Marionette DEBUG Closed connection 385
01:34:01 INFO - 1499675641269 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49813
01:34:01 INFO - 1499675641271 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:01 INFO - 1499675641273 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:01 INFO - 1499675641298 Marionette DEBUG Register listener.js for window 12
01:34:01 INFO - 1499675641311 Marionette TRACE 386 <- [1,1,null,{"sessionId":"3fb1f906-ef95-4c98-873e-bbb7f8fe4f30","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:01 INFO - 1499675641318 Marionette TRACE 386 -> [0,2,"setTimeouts",{"script":30000}]
01:34:01 INFO - 1499675641320 Marionette TRACE 386 <- [1,2,null,{}]
01:34:01 INFO - 1499675641322 Marionette TRACE 386 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:34:01 INFO - 1499675641324 Marionette TRACE 386 <- [1,3,null,{}]
01:34:01 INFO - 1499675641403 Marionette TRACE 386 -> [0,4,"setTimeouts",{"implicit":0}]
01:34:01 INFO - 1499675641405 Marionette TRACE 386 <- [1,4,null,{}]
01:34:01 INFO - 1499675641420 Marionette TRACE 386 -> [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}]
01:34:01 INFO - TEST-START: test_click.py TestClick.test_input_file1499675641429 Marionette TRACE 386 <- [1,5,null,{"value":null}]
01:34:01 INFO - 1499675641433 Marionette TRACE 386 -> [0,6,"deleteSession",{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641437 Marionette TRACE 386 <- [1,6,null,{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641459 Marionette DEBUG Closed connection 386
01:34:01 INFO - 1499675641461 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49814
01:34:01 INFO - 1499675641465 Marionette DEBUG Closed connection 387
01:34:01 INFO - 1499675641467 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49815
01:34:01 INFO - 1499675641470 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:01 INFO - 1499675641475 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:01 INFO - 1499675641499 Marionette DEBUG Register listener.js for window 12
01:34:01 INFO - 1499675641514 Marionette TRACE 388 <- [1,1,null,{"sessionId":"7f892ea1-2f97-4010-b3b6-15028166c4e9","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:01 INFO - 1499675641524 Marionette TRACE 388 -> [0,2,"deleteSession",{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641528 Marionette TRACE 388 <- [1,2,null,{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641553 Marionette DEBUG Closed connection 388
01:34:01 INFO - 1499675641558 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49816
01:34:01 INFO - 1499675641563 Marionette DEBUG Closed connection 389
01:34:01 INFO - 1499675641564 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49817
01:34:01 INFO - 1499675641567 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:34:01 INFO - 1499675641570 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:01 INFO - 1499675641593 Marionette DEBUG Register listener.js for window 12
01:34:01 INFO - 1499675641607 Marionette TRACE 390 <- [1,1,null,{"sessionId":"713d71e4-d31b-415d-b88f-a6bb5ce8964c","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:01 INFO - 1499675641617 Marionette TRACE 390 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
01:34:01 INFO - 1499675641621 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"
01:34:01 INFO - 1499675641630 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"
01:34:01 INFO - 1499675641631 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"
01:34:01 INFO - ++DOMWINDOW == 23 (000000F4623C2800) [pid = 3712] [serial = 50] [outer = 000000F463041000]
01:34:01 INFO - 1499675641697 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:34:01 INFO - 1499675641703 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:34:01 INFO - 1499675641721 Marionette TRACE 390 <- [1,2,null,{}]
01:34:01 INFO - 1499675641728 Marionette TRACE 390 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
01:34:01 INFO - 1499675641740 Marionette TRACE 390 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"16127a73-2cf1-4ae9-80df-fee77edd3dfa","ELEMENT":"16127a73-2cf1-4ae9-80df-fee77edd3dfa"}}]
01:34:01 INFO - 1499675641742 Marionette TRACE 390 -> [0,4,"clickElement",{"id":"16127a73-2cf1-4ae9-80df-fee77edd3dfa"}]
01:34:01 INFO - 1499675641909 Marionette TRACE 390 <- [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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
01:34:01 INFO - 1499675641912 Marionette TRACE 390 -> [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}]
01:34:01 INFO - TEST-END: test_click.py TestClick.test_input_file1499675641920 Marionette TRACE 390 <- [1,5,null,{"value":null}]
01:34:01 INFO - 1499675641922 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641927 Marionette TRACE 390 <- [1,6,null,{}]
01:34:01 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 713ms
01:34:01 INFO - TEST-START | test_click.py TestClick.test_obscured_element
01:34:01 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:01 INFO - 1499675641933 Marionette DEBUG Closed connection 390
01:34:01 INFO - 1499675641934 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49818
01:34:01 INFO - 1499675641936 Marionette DEBUG Closed connection 391
01:34:01 INFO - 1499675641937 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49819
01:34:01 INFO - 1499675641959 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:01 INFO - 1499675641962 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:01 INFO - 1499675641985 Marionette DEBUG Register listener.js for window 12
01:34:01 INFO - 1499675641996 Marionette TRACE 392 <- [1,1,null,{"sessionId":"9909772c-43be-4b5d-aae4-e5f1805cab68","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:02 INFO - 1499675642006 Marionette TRACE 392 -> [0,2,"setTimeouts",{"script":30000}]
01:34:02 INFO - 1499675642007 Marionette TRACE 392 <- [1,2,null,{}]
01:34:02 INFO - 1499675642010 Marionette TRACE 392 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:34:02 INFO - 1499675642011 Marionette TRACE 392 <- [1,3,null,{}]
01:34:02 INFO - 1499675642013 Marionette TRACE 392 -> [0,4,"setTimeouts",{"implicit":0}]
01:34:02 INFO - 1499675642015 Marionette TRACE 392 <- [1,4,null,{}]
01:34:02 INFO - 1499675642018 Marionette TRACE 392 -> [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}]
01:34:02 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499675642027 Marionette TRACE 392 <- [1,5,null,{"value":null}]
01:34:02 INFO - 1499675642028 Marionette TRACE 392 -> [0,6,"deleteSession",{}]
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642033 Marionette TRACE 392 <- [1,6,null,{}]
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642056 Marionette DEBUG Closed connection 392
01:34:02 INFO - 1499675642057 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49820
01:34:02 INFO - 1499675642061 Marionette DEBUG Closed connection 393
01:34:02 INFO - 1499675642064 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49821
01:34:02 INFO - 1499675642066 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:02 INFO - 1499675642069 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:02 INFO - 1499675642093 Marionette DEBUG Register listener.js for window 12
01:34:02 INFO - 1499675642104 Marionette TRACE 394 <- [1,1,null,{"sessionId":"d28f86ac-2026-41eb-9697-5c0829e65443","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:02 INFO - 1499675642115 Marionette TRACE 394 -> [0,2,"deleteSession",{}]
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642119 Marionette TRACE 394 <- [1,2,null,{}]
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642140 Marionette DEBUG Closed connection 394
01:34:02 INFO - 1499675642141 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49822
01:34:02 INFO - 1499675642146 Marionette DEBUG Closed connection 395
01:34:02 INFO - 1499675642147 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49823
01:34:02 INFO - 1499675642150 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:34:02 INFO - 1499675642152 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:02 INFO - 1499675642176 Marionette DEBUG Register listener.js for window 12
01:34:02 INFO - 1499675642187 Marionette TRACE 396 <- [1,1,null,{"sessionId":"bad36e3d-906e-4955-a3d6-dc36c76eb9cb","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:02 INFO - 1499675642197 Marionette TRACE 396 -> [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"}]
01:34:02 INFO - 1499675642201 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:34:02 INFO - 1499675642208 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:34:02 INFO - 1499675642209 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
01:34:02 INFO - ++DOMWINDOW == 24 (000000F46352F000) [pid = 3712] [serial = 51] [outer = 000000F463041000]
01:34:02 INFO - 1499675642269 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"
01:34:02 INFO - 1499675642275 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"
01:34:02 INFO - 1499675642292 Marionette TRACE 396 <- [1,2,null,{}]
01:34:02 INFO - 1499675642298 Marionette TRACE 396 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
01:34:02 INFO - 1499675642306 Marionette TRACE 396 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0e1c08b6-c55f-41ba-a5a1-6bcb9520fae3","ELEMENT":"0e1c08b6-c55f-41ba-a5a1-6bcb9520fae3"}}]
01:34:02 INFO - 1499675642308 Marionette TRACE 396 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
01:34:02 INFO - 1499675642315 Marionette TRACE 396 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"54684d87-2e88-44da-866d-b768c63086eb","ELEMENT":"54684d87-2e88-44da-866d-b768c63086eb"}}]
01:34:02 INFO - 1499675642318 Marionette TRACE 396 -> [0,5,"clickElement",{"id":"0e1c08b6-c55f-41ba-a5a1-6bcb9520fae3"}]
01:34:02 INFO - 1499675642754 Marionette DEBUG Canceled page load listener because no navigation has been detected
01:34:02 INFO - 1499675642756 Marionette TRACE 396 <- [1,5,null,{}]
01:34:02 INFO - 1499675642758 Marionette TRACE 396 -> [0,6,"clickElement",{"id":"54684d87-2e88-44da-866d-b768c63086eb"}]
01:34:02 INFO - 1499675642899 Marionette TRACE 396 <- [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:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
01:34:02 INFO - 1499675642916 Marionette TRACE 396 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
01:34:02 INFO - 1499675642929 Marionette TRACE 396 <- [1,7,null,{"value":false}]
01:34:02 INFO - 1499675642935 Marionette TRACE 396 -> [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}]
01:34:02 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499675642947 Marionette TRACE 396 <- [1,8,null,{"value":null}]
01:34:02 INFO - 1499675642957 Marionette TRACE 396 -> [0,9,"deleteSession",{}]
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642961 Marionette TRACE 396 <- [1,9,null,{}]
01:34:02 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1034ms
01:34:02 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
01:34:02 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:02 INFO - 1499675642969 Marionette DEBUG Closed connection 396
01:34:02 INFO - 1499675642970 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49824
01:34:03 INFO - 1499675643000 Marionette DEBUG Closed connection 397
01:34:03 INFO - 1499675643011 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49825
01:34:03 INFO - 1499675643016 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:03 INFO - 1499675643018 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:03 INFO - 1499675643043 Marionette DEBUG Register listener.js for window 12
01:34:03 INFO - 1499675643054 Marionette TRACE 398 <- [1,1,null,{"sessionId":"1cf80683-283c-46a2-adf0-35b9ca5604ee","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:03 INFO - 1499675643064 Marionette TRACE 398 -> [0,2,"setTimeouts",{"script":30000}]
01:34:03 INFO - 1499675643066 Marionette TRACE 398 <- [1,2,null,{}]
01:34:03 INFO - 1499675643070 Marionette TRACE 398 -> [0,3,"setTimeouts",{"pageLoad":300000}]
01:34:03 INFO - 1499675643072 Marionette TRACE 398 <- [1,3,null,{}]
01:34:03 INFO - 1499675643074 Marionette TRACE 398 -> [0,4,"setTimeouts",{"implicit":0}]
01:34:03 INFO - 1499675643075 Marionette TRACE 398 <- [1,4,null,{}]
01:34:03 INFO - 1499675643703 Marionette TRACE 398 -> [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}]
01:34:03 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499675643710 Marionette TRACE 398 <- [1,5,null,{"value":null}]
01:34:03 INFO - 1499675643754 Marionette TRACE 398 -> [0,6,"deleteSession",{}]
01:34:03 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:03 INFO - 1499675643759 Marionette TRACE 398 <- [1,6,null,{}]
01:34:03 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:03 INFO - 1499675643781 Marionette DEBUG Closed connection 398
01:34:03 INFO - 1499675643782 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49826
01:34:03 INFO - 1499675643786 Marionette DEBUG Closed connection 399
01:34:03 INFO - 1499675643787 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49827
01:34:03 INFO - 1499675643790 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
01:34:03 INFO - 1499675643794 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:03 INFO - 1499675643822 Marionette DEBUG Register listener.js for window 12
01:34:03 INFO - 1499675643848 Marionette TRACE 400 <- [1,1,null,{"sessionId":"997158cc-5aa1-47e2-bf1e-946bb4dd0793","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:03 INFO - 1499675643857 Marionette TRACE 400 -> [0,2,"deleteSession",{}]
01:34:03 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:03 INFO - 1499675643861 Marionette TRACE 400 <- [1,2,null,{}]
01:34:03 INFO - [3712] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
01:34:03 INFO - 1499675643883 Marionette DEBUG Closed connection 400
01:34:03 INFO - 1499675643885 Marionette DEBUG Accepted connection 401 from 127.0.0.1:49828
01:34:03 INFO - 1499675643888 Marionette DEBUG Closed connection 401
01:34:03 INFO - 1499675643890 Marionette DEBUG Accepted connection 402 from 127.0.0.1:49829
01:34:03 INFO - 1499675643892 Marionette TRACE 402 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
01:34:03 INFO - 1499675643895 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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}
01:34:03 INFO - 1499675643919 Marionette DEBUG Register listener.js for window 12
01:34:03 INFO - 1499675643930 Marionette TRACE 402 <- [1,1,null,{"sessionId":"2681eeea-bf3d-4749-816e-2fcd924ce126","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":3712,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-355.001\\AppData\\Local\\Temp\\tmppazxrs.mozrunner","moz:accessibilityChecks":false}}]
01:34:03 INFO - 1499675643940 Marionette TRACE 402 -> [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"}]
01:34:03 INFO - 1499675643944 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"
01:34:03 INFO - 1499675643954 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"
01:34:03 INFO - 1499675643955 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"
01:34:03 INFO - ++DOMWINDOW == 25 (000000F46A055800) [pid = 3712] [serial = 52] [outer = 000000F463041000]
01:34:04 INFO - 1499675644013 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"
01:34:04 INFO - 1499675644019 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"
01:34:04 INFO - 1499675644035 Marionette TRACE 402 <- [1,2,null,{}]
01:34:04 INFO - 1499675644043 Marionette TRACE 402 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
01:34:04 INFO - 1499675644050 Marionette TRACE 402 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"e0c42b89-d7e4-4014-8572-12fd563815bd","ELEMENT":"e0c42b89-d7e4-4014-8572-12fd563815bd"}}]
01:34:04 INFO - 1499675644052 Marionette TRACE 402 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"e0c42b89-d7e4-4014-8572-12fd563815bd"}]
01:34:04 INFO - 1499675644172 Marionette TRACE 402 <- [1,4,null,{"value":"none"}]
01:34:04 INFO - 1499675644182 Marionette TRACE 402 -> [0,5,"clickElement",{"id":"e0c42b89-d7e4-4014-8572-12fd563815bd"}]
01:34:04 INFO - 1499675644302 Marionette TRACE 402 <- [1,5,{"error":"element click intercepted","message":"Element