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]
23:26:58 INFO - 1499668018535 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
23:26:58 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1499668018545 Marionette TRACE 352 <- [1,5,null,{"value":null}]
23:26:58 INFO - 1499668018547 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018551 Marionette TRACE 352 <- [1,6,null,{}]
23:26:58 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 1480ms
23:26:58 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018557 Marionette DEBUG Closed connection 352
23:26:58 INFO - 1499668018559 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49796
23:26:58 INFO - 1499668018561 Marionette DEBUG Closed connection 353
23:26:58 INFO - 1499668018562 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49797
23:26:58 INFO - 1499668018584 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:26:58 INFO - 1499668018586 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:58 INFO - 1499668018609 Marionette DEBUG Register listener.js for window 12
23:26:58 INFO - 1499668018621 Marionette TRACE 354 <- [1,1,null,{"sessionId":"f71fc244-47fe-4a31-92a6-8ca42b933814","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:58 INFO - 1499668018630 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
23:26:58 INFO - 1499668018632 Marionette TRACE 354 <- [1,2,null,{}]
23:26:58 INFO - 1499668018634 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:26:58 INFO - 1499668018636 Marionette TRACE 354 <- [1,3,null,{}]
23:26:58 INFO - 1499668018638 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
23:26:58 INFO - 1499668018639 Marionette TRACE 354 <- [1,4,null,{}]
23:26:58 INFO - 1499668018642 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
23:26:58 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1499668018651 Marionette TRACE 354 <- [1,5,null,{"value":null}]
23:26:58 INFO - 1499668018653 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018657 Marionette TRACE 354 <- [1,6,null,{}]
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018680 Marionette DEBUG Closed connection 354
23:26:58 INFO - 1499668018682 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49798
23:26:58 INFO - 1499668018685 Marionette DEBUG Closed connection 355
23:26:58 INFO - 1499668018688 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49799
23:26:58 INFO - 1499668018690 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:26:58 INFO - 1499668018693 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:58 INFO - 1499668018716 Marionette DEBUG Register listener.js for window 12
23:26:58 INFO - 1499668018727 Marionette TRACE 356 <- [1,1,null,{"sessionId":"2a452256-961e-45df-abaa-23a06420fb03","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:58 INFO - 1499668018737 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018741 Marionette TRACE 356 <- [1,2,null,{}]
23:26:58 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:58 INFO - 1499668018763 Marionette DEBUG Closed connection 356
23:26:58 INFO - 1499668018764 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49800
23:26:58 INFO - 1499668018768 Marionette DEBUG Closed connection 357
23:26:58 INFO - 1499668018770 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49801
23:26:58 INFO - 1499668018772 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:26:58 INFO - 1499668018775 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:58 INFO - 1499668018797 Marionette DEBUG Register listener.js for window 12
23:26:58 INFO - 1499668018808 Marionette TRACE 358 <- [1,1,null,{"sessionId":"15a2bb39-403f-44e3-a367-50b8e06f0104","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:58 INFO - 1499668018818 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49351/clicks.html"}]
23:26:58 INFO - 1499668018822 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49351/hidden.html"
23:26:58 INFO - 1499668018842 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49351/hidden.html"
23:26:58 INFO - 1499668018843 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49351/hidden.html"
23:26:58 INFO - ++DOMWINDOW == 21 (00000057742CD000) [pid = 424] [serial = 44] [outer = 0000005774BE0000]
23:26:58 INFO - 1499668018913 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49351/clicks.html"
23:26:58 INFO - 1499668018918 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49351/clicks.html"
23:26:58 INFO - 1499668018941 Marionette TRACE 358 <- [1,2,null,{}]
23:26:58 INFO - 1499668018944 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
23:26:58 INFO - 1499668018955 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"3d283974-c0a4-49a9-bb6e-394dfddefc84","ELEMENT":"3d283974-c0a4-49a9-bb6e-394dfddefc84"}}]
23:26:58 INFO - 1499668018963 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"3d283974-c0a4-49a9-bb6e-394dfddefc84"}]
23:26:59 INFO - 1499668019236 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49351/clicks.html"
23:26:59 INFO - [424] 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
23:26:59 INFO - 1499668019257 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49351/clicks.html"
23:26:59 INFO - 1499668019258 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49351/clicks.html"
23:26:59 INFO - ++DOMWINDOW == 22 (000000577C2C8800) [pid = 424] [serial = 45] [outer = 0000005774BE0000]
23:26:59 INFO - 1499668019322 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49351/test.html"
23:26:59 INFO - 1499668019327 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49351/test.html"
23:26:59 INFO - 1499668019344 Marionette TRACE 358 <- [1,4,null,{}]
23:26:59 INFO - 1499668019353 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
23:26:59 INFO - 1499668019361 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"bf166337-7ae7-411e-aaa9-f12829b45db7","ELEMENT":"bf166337-7ae7-411e-aaa9-f12829b45db7"}}]
23:26:59 INFO - 1499668019363 Marionette TRACE 358 -> [0,6,"getTitle",{}]
23:26:59 INFO - 1499668019365 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
23:26:59 INFO - 1499668019368 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
23:26:59 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1499668019376 Marionette TRACE 358 <- [1,7,null,{"value":null}]
23:26:59 INFO - 1499668019378 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019382 Marionette TRACE 358 <- [1,8,null,{}]
23:26:59 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 832ms
23:26:59 INFO - TEST-START | test_click.py TestClick.test_container_element
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019388 Marionette DEBUG Closed connection 358
23:26:59 INFO - 1499668019390 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49804
23:26:59 INFO - 1499668019391 Marionette DEBUG Closed connection 359
23:26:59 INFO - 1499668019393 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49805
23:26:59 INFO - 1499668019395 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:26:59 INFO - 1499668019397 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:59 INFO - 1499668019420 Marionette DEBUG Register listener.js for window 12
23:26:59 INFO - 1499668019431 Marionette TRACE 360 <- [1,1,null,{"sessionId":"a47e9344-c592-4104-9982-70e63fc95acd","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:59 INFO - 1499668019461 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
23:26:59 INFO - 1499668019463 Marionette TRACE 360 <- [1,2,null,{}]
23:26:59 INFO - 1499668019465 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:26:59 INFO - 1499668019467 Marionette TRACE 360 <- [1,3,null,{}]
23:26:59 INFO - 1499668019470 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
23:26:59 INFO - 1499668019471 Marionette TRACE 360 <- [1,4,null,{}]
23:26:59 INFO - 1499668019475 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
23:26:59 INFO - TEST-START: test_click.py TestClick.test_container_element1499668019483 Marionette TRACE 360 <- [1,5,null,{"value":null}]
23:26:59 INFO - 1499668019485 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019489 Marionette TRACE 360 <- [1,6,null,{}]
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019513 Marionette DEBUG Closed connection 360
23:26:59 INFO - 1499668019515 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49806
23:26:59 INFO - 1499668019519 Marionette DEBUG Closed connection 361
23:26:59 INFO - 1499668019520 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49807
23:26:59 INFO - 1499668019522 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:26:59 INFO - 1499668019525 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:59 INFO - 1499668019552 Marionette DEBUG Register listener.js for window 12
23:26:59 INFO - 1499668019566 Marionette TRACE 362 <- [1,1,null,{"sessionId":"859e552a-cd6c-4346-9680-21916b0627c0","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:59 INFO - 1499668019587 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019592 Marionette TRACE 362 <- [1,2,null,{}]
23:26:59 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:26:59 INFO - 1499668019615 Marionette DEBUG Closed connection 362
23:26:59 INFO - 1499668019617 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49808
23:26:59 INFO - 1499668019621 Marionette DEBUG Closed connection 363
23:26:59 INFO - 1499668019623 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49809
23:26:59 INFO - 1499668019626 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:26:59 INFO - 1499668019628 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:26:59 INFO - 1499668019652 Marionette DEBUG Register listener.js for window 12
23:26:59 INFO - 1499668019664 Marionette TRACE 364 <- [1,1,null,{"sessionId":"69cdc553-b441-443b-9162-048fd8140e11","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:26:59 INFO - 1499668019673 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
23:26:59 INFO - 1499668019677 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49351/test.html"
23:26:59 INFO - 1499668019686 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49351/test.html"
23:26:59 INFO - 1499668019687 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49351/test.html"
23:26:59 INFO - ++DOMWINDOW == 23 (000000577C2CF000) [pid = 424] [serial = 46] [outer = 0000005774BE0000]
23:26:59 INFO - 1499668019746 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"
23:26:59 INFO - 1499668019764 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"
23:26:59 INFO - 1499668019779 Marionette TRACE 364 <- [1,2,null,{}]
23:26:59 INFO - 1499668019789 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
23:26:59 INFO - 1499668019796 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2a748e4c-1963-420f-90ce-a3b3e45ef70c","ELEMENT":"2a748e4c-1963-420f-90ce-a3b3e45ef70c"}}]
23:26:59 INFO - 1499668019800 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"2a748e4c-1963-420f-90ce-a3b3e45ef70c"}]
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
23:27:00 INFO - 1499668020705 Marionette DEBUG Canceled page load listener because no navigation has been detected
23:27:00 INFO - 1499668020720 Marionette TRACE 364 <- [1,4,null,{}]
23:27:00 INFO - 1499668020763 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"2a748e4c-1963-420f-90ce-a3b3e45ef70c","name":"selected"}]
23:27:00 INFO - 1499668020792 Marionette TRACE 364 <- [1,5,null,{"value":true}]
23:27:00 INFO - 1499668020800 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
23:27:00 INFO - TEST-END: test_click.py TestClick.test_container_element1499668020807 Marionette TRACE 364 <- [1,6,null,{"value":null}]
23:27:00 INFO - 1499668020811 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:00 INFO - 1499668020816 Marionette TRACE 364 <- [1,7,null,{}]
23:27:00 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 1433ms
23:27:00 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:00 INFO - 1499668020822 Marionette DEBUG Closed connection 364
23:27:00 INFO - 1499668020823 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49810
23:27:00 INFO - 1499668020825 Marionette DEBUG Closed connection 365
23:27:00 INFO - 1499668020826 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49811
23:27:00 INFO - 1499668020828 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:00 INFO - 1499668020830 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:00 INFO - 1499668020853 Marionette DEBUG Register listener.js for window 12
23:27:00 INFO - 1499668020864 Marionette TRACE 366 <- [1,1,null,{"sessionId":"5c31afe1-2262-444b-8516-a05edc6ef517","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:00 INFO - 1499668020893 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
23:27:00 INFO - 1499668020895 Marionette TRACE 366 <- [1,2,null,{}]
23:27:00 INFO - 1499668020897 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:00 INFO - 1499668020898 Marionette TRACE 366 <- [1,3,null,{}]
23:27:00 INFO - 1499668020901 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:00 INFO - 1499668020902 Marionette TRACE 366 <- [1,4,null,{}]
23:27:00 INFO - 1499668020905 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
23:27:00 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1499668020912 Marionette TRACE 366 <- [1,5,null,{"value":null}]
23:27:00 INFO - 1499668020914 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:00 INFO - 1499668020918 Marionette TRACE 366 <- [1,6,null,{}]
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:00 INFO - 1499668020942 Marionette DEBUG Closed connection 366
23:27:00 INFO - 1499668020943 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49812
23:27:00 INFO - 1499668020947 Marionette DEBUG Closed connection 367
23:27:00 INFO - 1499668020948 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49813
23:27:00 INFO - 1499668020951 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:00 INFO - 1499668020953 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:00 INFO - 1499668020975 Marionette DEBUG Register listener.js for window 12
23:27:00 INFO - 1499668020986 Marionette TRACE 368 <- [1,1,null,{"sessionId":"4f1d56a6-288f-4cfc-96b0-a0f3b8936250","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:00 INFO - 1499668020996 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
23:27:00 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:01 INFO - 1499668021000 Marionette TRACE 368 <- [1,2,null,{}]
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:01 INFO - 1499668021022 Marionette DEBUG Closed connection 368
23:27:01 INFO - 1499668021023 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49814
23:27:01 INFO - 1499668021027 Marionette DEBUG Closed connection 369
23:27:01 INFO - 1499668021029 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49815
23:27:01 INFO - 1499668021031 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:01 INFO - 1499668021033 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:01 INFO - 1499668021056 Marionette DEBUG Register listener.js for window 12
23:27:01 INFO - 1499668021067 Marionette TRACE 370 <- [1,1,null,{"sessionId":"b8133257-d52c-425d-8d63-f958ebb908e1","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:01 INFO - 1499668021076 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
23:27:01 INFO - 1499668021080 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"
23:27:01 INFO - 1499668021086 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"
23:27:01 INFO - 1499668021087 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"
23:27:01 INFO - ++DOMWINDOW == 24 (000000576E615800) [pid = 424] [serial = 47] [outer = 0000005774BE0000]
23:27:01 INFO - 1499668021140 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"
23:27:01 INFO - 1499668021145 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"
23:27:01 INFO - 1499668021164 Marionette TRACE 370 <- [1,2,null,{}]
23:27:01 INFO - 1499668021170 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
23:27:01 INFO - 1499668021177 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"60175937-6d6c-477d-afad-bddb7119d523","ELEMENT":"60175937-6d6c-477d-afad-bddb7119d523"}}]
23:27:01 INFO - 1499668021179 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"60175937-6d6c-477d-afad-bddb7119d523"}]
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1908
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1816
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1622
23:27:01 INFO - 1499668021652 Marionette DEBUG Canceled page load listener because no navigation has been detected
23:27:01 INFO - 1499668021656 Marionette TRACE 370 <- [1,4,null,{}]
23:27:01 INFO - 1499668021660 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"60175937-6d6c-477d-afad-bddb7119d523","name":"selected"}]
23:27:01 INFO - 1499668021721 Marionette TRACE 370 <- [1,5,null,{"value":true}]
23:27:01 INFO - 1499668021767 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
23:27:01 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1499668021785 Marionette TRACE 370 <- [1,6,null,{"value":null}]
23:27:01 INFO - 1499668021797 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:01 INFO - 1499668021806 Marionette TRACE 370 <- [1,7,null,{}]
23:27:01 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 991ms
23:27:01 INFO - TEST-START | test_click.py TestClick.test_css_transforms
23:27:01 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:01 INFO - 1499668021815 Marionette DEBUG Closed connection 370
23:27:01 INFO - 1499668021818 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49816
23:27:01 INFO - 1499668021822 Marionette DEBUG Closed connection 371
23:27:01 INFO - 1499668021826 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49817
23:27:01 INFO - 1499668021881 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:01 INFO - 1499668021890 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:01 INFO - 1499668021938 Marionette DEBUG Register listener.js for window 12
23:27:01 INFO - 1499668021960 Marionette TRACE 372 <- [1,1,null,{"sessionId":"68325847-0db3-4405-8254-c1b9d45d357c","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:02 INFO - 1499668021997 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
23:27:02 INFO - 1499668022002 Marionette TRACE 372 <- [1,2,null,{}]
23:27:02 INFO - 1499668022054 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:02 INFO - 1499668022057 Marionette TRACE 372 <- [1,3,null,{}]
23:27:02 INFO - 1499668022060 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:02 INFO - 1499668022063 Marionette TRACE 372 <- [1,4,null,{}]
23:27:02 INFO - 1499668022067 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
23:27:02 INFO - TEST-START: test_click.py TestClick.test_css_transforms1499668022079 Marionette TRACE 372 <- [1,5,null,{"value":null}]
23:27:02 INFO - 1499668022104 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
23:27:02 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:02 INFO - 1499668022110 Marionette TRACE 372 <- [1,6,null,{}]
23:27:02 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:02 INFO - 1499668022170 Marionette DEBUG Closed connection 372
23:27:02 INFO - 1499668022173 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49818
23:27:02 INFO - 1499668022195 Marionette DEBUG Closed connection 373
23:27:02 INFO - 1499668022197 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49819
23:27:02 INFO - 1499668022201 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:02 INFO - 1499668022204 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:02 INFO - 1499668022250 Marionette DEBUG Register listener.js for window 12
23:27:02 INFO - 1499668022267 Marionette TRACE 374 <- [1,1,null,{"sessionId":"00722e98-7d62-4810-b6f1-d7d8df5f33f0","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:02 INFO - 1499668022456 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
23:27:02 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:02 INFO - 1499668022465 Marionette TRACE 374 <- [1,2,null,{}]
23:27:02 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:02 INFO - 1499668022493 Marionette DEBUG Closed connection 374
23:27:02 INFO - 1499668022496 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49820
23:27:02 INFO - 1499668022568 Marionette DEBUG Closed connection 375
23:27:02 INFO - 1499668022571 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49821
23:27:02 INFO - 1499668022583 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:02 INFO - 1499668022593 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:02 INFO - 1499668022618 Marionette DEBUG Register listener.js for window 12
23:27:02 INFO - 1499668022637 Marionette TRACE 376 <- [1,1,null,{"sessionId":"b0a877e0-3f52-4728-8f8b-ed07cbfd1760","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:02 INFO - 1499668022654 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
23:27:02 INFO - 1499668022661 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"
23:27:02 INFO - 1499668022674 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"
23:27:02 INFO - 1499668022675 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"
23:27:02 INFO - ++DOMWINDOW == 25 (0000005770E05000) [pid = 424] [serial = 48] [outer = 0000005774BE0000]
23:27:02 INFO - 1499668022740 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"
23:27:02 INFO - 1499668022749 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"
23:27:02 INFO - 1499668022787 Marionette TRACE 376 <- [1,2,null,{}]
23:27:02 INFO - 1499668022793 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
23:27:02 INFO - 1499668022808 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"2aba7bf6-04b9-4b4b-8f07-3340f5d89ae6","ELEMENT":"2aba7bf6-04b9-4b4b-8f07-3340f5d89ae6"}}]
23:27:02 INFO - 1499668022811 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"2aba7bf6-04b9-4b4b-8f07-3340f5d89ae6"}]
23:27:03 INFO - --DOMWINDOW == 24 (000000577DF5D000) [pid = 424] [serial = 35] [outer = 0000000000000000] [url = http://127.0.0.1:49351/test_accessibility.html]
23:27:03 INFO - --DOMWINDOW == 23 (0000005769029800) [pid = 424] [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]
23:27:03 INFO - --DOMWINDOW == 22 (000000577153D800) [pid = 424] [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]
23:27:03 INFO - --DOMWINDOW == 21 (00000057742E0800) [pid = 424] [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]
23:27:03 INFO - 1499668023263 Marionette DEBUG Canceled page load listener because no navigation has been detected
23:27:03 INFO - 1499668023266 Marionette TRACE 376 <- [1,4,null,{}]
23:27:03 INFO - 1499668023276 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
23:27:03 INFO - TEST-END: test_click.py TestClick.test_css_transforms1499668023286 Marionette TRACE 376 <- [1,5,null,{"value":null}]
23:27:03 INFO - 1499668023291 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023296 Marionette TRACE 376 <- [1,6,null,{}]
23:27:03 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 1490ms
23:27:03 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023305 Marionette DEBUG Closed connection 376
23:27:03 INFO - 1499668023307 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49822
23:27:03 INFO - 1499668023310 Marionette DEBUG Closed connection 377
23:27:03 INFO - 1499668023312 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49823
23:27:03 INFO - 1499668023317 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:03 INFO - 1499668023320 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:03 INFO - 1499668023344 Marionette DEBUG Register listener.js for window 12
23:27:03 INFO - 1499668023359 Marionette TRACE 378 <- [1,1,null,{"sessionId":"57eef219-edff-4bf7-8cb0-fb447ca8fbc3","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:03 INFO - 1499668023368 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
23:27:03 INFO - 1499668023370 Marionette TRACE 378 <- [1,2,null,{}]
23:27:03 INFO - 1499668023395 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:03 INFO - 1499668023397 Marionette TRACE 378 <- [1,3,null,{}]
23:27:03 INFO - 1499668023513 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:03 INFO - 1499668023518 Marionette TRACE 378 <- [1,4,null,{}]
23:27:03 INFO - 1499668023522 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
23:27:03 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1499668023532 Marionette TRACE 378 <- [1,5,null,{"value":null}]
23:27:03 INFO - 1499668023535 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023541 Marionette TRACE 378 <- [1,6,null,{}]
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023564 Marionette DEBUG Closed connection 378
23:27:03 INFO - 1499668023566 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49824
23:27:03 INFO - 1499668023570 Marionette DEBUG Closed connection 379
23:27:03 INFO - 1499668023572 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49825
23:27:03 INFO - 1499668023577 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:03 INFO - 1499668023580 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:03 INFO - 1499668023604 Marionette DEBUG Register listener.js for window 12
23:27:03 INFO - 1499668023618 Marionette TRACE 380 <- [1,1,null,{"sessionId":"45fec668-bb27-4818-821c-138854c43051","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:03 INFO - 1499668023629 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023634 Marionette TRACE 380 <- [1,2,null,{}]
23:27:03 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:03 INFO - 1499668023656 Marionette DEBUG Closed connection 380
23:27:03 INFO - 1499668023658 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49826
23:27:03 INFO - 1499668023663 Marionette DEBUG Closed connection 381
23:27:03 INFO - 1499668023666 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49827
23:27:03 INFO - 1499668023687 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:03 INFO - 1499668023691 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:03 INFO - 1499668023715 Marionette DEBUG Register listener.js for window 12
23:27:03 INFO - 1499668023728 Marionette TRACE 382 <- [1,1,null,{"sessionId":"3e97568b-9f17-4a5c-9fc3-13fa28e121b2","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:03 INFO - 1499668023740 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
23:27:03 INFO - 1499668023744 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"
23:27:03 INFO - 1499668023753 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"
23:27:03 INFO - 1499668023754 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"
23:27:03 INFO - ++DOMWINDOW == 22 (00000057738D4000) [pid = 424] [serial = 49] [outer = 0000005774BE0000]
23:27:03 INFO - 1499668023812 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"
23:27:03 INFO - 1499668023826 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"
23:27:03 INFO - 1499668023838 Marionette TRACE 382 <- [1,2,null,{}]
23:27:03 INFO - 1499668023848 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
23:27:03 INFO - 1499668023857 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"36fc4724-9088-4043-b2e6-f07d62d3a610","ELEMENT":"36fc4724-9088-4043-b2e6-f07d62d3a610"}}]
23:27:03 INFO - 1499668023859 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"36fc4724-9088-4043-b2e6-f07d62d3a610"}]
23:27:05 INFO - 1499668025040 Marionette DEBUG Canceled page load listener because no navigation has been detected
23:27:05 INFO - 1499668025042 Marionette TRACE 382 <- [1,4,null,{}]
23:27:05 INFO - 1499668025093 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
23:27:05 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1499668025104 Marionette TRACE 382 <- [1,5,null,{"value":null}]
23:27:05 INFO - 1499668025121 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025125 Marionette TRACE 382 <- [1,6,null,{}]
23:27:05 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 1828ms
23:27:05 INFO - TEST-START | test_click.py TestClick.test_input_file
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025132 Marionette DEBUG Closed connection 382
23:27:05 INFO - 1499668025133 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49828
23:27:05 INFO - 1499668025135 Marionette DEBUG Closed connection 383
23:27:05 INFO - 1499668025137 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49829
23:27:05 INFO - 1499668025139 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:05 INFO - 1499668025144 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025168 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025183 Marionette TRACE 384 <- [1,1,null,{"sessionId":"5298d298-a5ae-4514-b362-d18727918dab","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:05 INFO - 1499668025212 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
23:27:05 INFO - 1499668025214 Marionette TRACE 384 <- [1,2,null,{}]
23:27:05 INFO - 1499668025216 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:05 INFO - 1499668025218 Marionette TRACE 384 <- [1,3,null,{}]
23:27:05 INFO - 1499668025220 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:05 INFO - 1499668025221 Marionette TRACE 384 <- [1,4,null,{}]
23:27:05 INFO - 1499668025224 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
23:27:05 INFO - TEST-START: test_click.py TestClick.test_input_file1499668025232 Marionette TRACE 384 <- [1,5,null,{"value":null}]
23:27:05 INFO - 1499668025234 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025239 Marionette TRACE 384 <- [1,6,null,{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025247 Marionette DEBUG Closed connection 384
23:27:05 INFO - 1499668025252 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49830
23:27:05 INFO - 1499668025254 Marionette DEBUG Closed connection 385
23:27:05 INFO - 1499668025256 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49831
23:27:05 INFO - 1499668025258 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:05 INFO - 1499668025260 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025285 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025299 Marionette TRACE 386 <- [1,1,null,{"sessionId":"f433bb67-9560-40da-89b5-b355f954b328","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:05 INFO - 1499668025305 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025309 Marionette TRACE 386 <- [1,2,null,{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025315 Marionette DEBUG Closed connection 386
23:27:05 INFO - 1499668025317 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49832
23:27:05 INFO - 1499668025319 Marionette DEBUG Closed connection 387
23:27:05 INFO - 1499668025320 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49833
23:27:05 INFO - 1499668025322 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:05 INFO - 1499668025325 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025349 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025360 Marionette TRACE 388 <- [1,1,null,{"sessionId":"40a7fbf4-f89f-4cf3-b10c-af0b494dc4f5","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:05 INFO - 1499668025366 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
23:27:05 INFO - 1499668025420 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"
23:27:05 INFO - 1499668025427 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"
23:27:05 INFO - 1499668025429 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"
23:27:05 INFO - ++DOMWINDOW == 23 (000000577438C000) [pid = 424] [serial = 50] [outer = 0000005774BE0000]
23:27:05 INFO - 1499668025490 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
23:27:05 INFO - 1499668025497 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
23:27:05 INFO - 1499668025516 Marionette TRACE 388 <- [1,2,null,{}]
23:27:05 INFO - 1499668025523 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
23:27:05 INFO - 1499668025531 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"7d6fa256-8a5c-4f34-889e-ac2349e36964","ELEMENT":"7d6fa256-8a5c-4f34-889e-ac2349e36964"}}]
23:27:05 INFO - 1499668025533 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"7d6fa256-8a5c-4f34-889e-ac2349e36964"}]
23:27:05 INFO - 1499668025712 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
23:27:05 INFO - 1499668025715 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
23:27:05 INFO - TEST-END: test_click.py TestClick.test_input_file1499668025723 Marionette TRACE 388 <- [1,5,null,{"value":null}]
23:27:05 INFO - 1499668025725 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025729 Marionette TRACE 388 <- [1,6,null,{}]
23:27:05 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 603ms
23:27:05 INFO - TEST-START | test_click.py TestClick.test_obscured_element
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025735 Marionette DEBUG Closed connection 388
23:27:05 INFO - 1499668025736 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49834
23:27:05 INFO - 1499668025738 Marionette DEBUG Closed connection 389
23:27:05 INFO - 1499668025740 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49835
23:27:05 INFO - 1499668025763 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:05 INFO - 1499668025766 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025791 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025802 Marionette TRACE 390 <- [1,1,null,{"sessionId":"d05012fc-9509-44e9-b588-31801171f552","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:05 INFO - 1499668025812 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
23:27:05 INFO - 1499668025813 Marionette TRACE 390 <- [1,2,null,{}]
23:27:05 INFO - 1499668025816 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:05 INFO - 1499668025818 Marionette TRACE 390 <- [1,3,null,{}]
23:27:05 INFO - 1499668025820 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:05 INFO - 1499668025821 Marionette TRACE 390 <- [1,4,null,{}]
23:27:05 INFO - 1499668025824 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
23:27:05 INFO - TEST-START: test_click.py TestClick.test_obscured_element1499668025833 Marionette TRACE 390 <- [1,5,null,{"value":null}]
23:27:05 INFO - 1499668025835 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025839 Marionette TRACE 390 <- [1,6,null,{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025863 Marionette DEBUG Closed connection 390
23:27:05 INFO - 1499668025865 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49836
23:27:05 INFO - 1499668025869 Marionette DEBUG Closed connection 391
23:27:05 INFO - 1499668025870 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49837
23:27:05 INFO - 1499668025872 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:05 INFO - 1499668025874 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025899 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025911 Marionette TRACE 392 <- [1,1,null,{"sessionId":"b53e546e-a0c1-48ea-b866-7f6a52ed72e8","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:05 INFO - 1499668025921 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025925 Marionette TRACE 392 <- [1,2,null,{}]
23:27:05 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:05 INFO - 1499668025947 Marionette DEBUG Closed connection 392
23:27:05 INFO - 1499668025949 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49838
23:27:05 INFO - 1499668025953 Marionette DEBUG Closed connection 393
23:27:05 INFO - 1499668025954 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49839
23:27:05 INFO - 1499668025957 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:05 INFO - 1499668025959 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:05 INFO - 1499668025984 Marionette DEBUG Register listener.js for window 12
23:27:05 INFO - 1499668025995 Marionette TRACE 394 <- [1,1,null,{"sessionId":"f0af9c38-e9c8-4f13-ba8d-178dba0c0b0a","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:06 INFO - 1499668026005 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
23:27:06 INFO - 1499668026009 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
23:27:06 INFO - 1499668026018 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
23:27:06 INFO - 1499668026019 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
23:27:06 INFO - ++DOMWINDOW == 24 (0000005776038000) [pid = 424] [serial = 51] [outer = 0000005774BE0000]
23:27:06 INFO - 1499668026077 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"
23:27:06 INFO - 1499668026084 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"
23:27:06 INFO - 1499668026101 Marionette TRACE 394 <- [1,2,null,{}]
23:27:06 INFO - 1499668026107 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
23:27:06 INFO - 1499668026116 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"112e853b-bf59-430f-a386-ecd39b243b57","ELEMENT":"112e853b-bf59-430f-a386-ecd39b243b57"}}]
23:27:06 INFO - 1499668026118 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
23:27:06 INFO - 1499668026125 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"02c613b3-1d12-4a00-bb0f-24172fec0f0b","ELEMENT":"02c613b3-1d12-4a00-bb0f-24172fec0f0b"}}]
23:27:06 INFO - 1499668026127 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"112e853b-bf59-430f-a386-ecd39b243b57"}]
23:27:06 INFO - 1499668026593 Marionette DEBUG Canceled page load listener because no navigation has been detected
23:27:06 INFO - 1499668026595 Marionette TRACE 394 <- [1,5,null,{}]
23:27:06 INFO - 1499668026597 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"02c613b3-1d12-4a00-bb0f-24172fec0f0b"}]
23:27:06 INFO - 1499668026758 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:392:12\nclickElement@chrome://marionette/content/listener.js:1312:5\n"},null]
23:27:06 INFO - 1499668026763 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":257}]
23:27:06 INFO - 1499668026771 Marionette TRACE 394 <- [1,7,null,{"value":false}]
23:27:06 INFO - 1499668026774 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
23:27:06 INFO - TEST-END: test_click.py TestClick.test_obscured_element1499668026781 Marionette TRACE 394 <- [1,8,null,{"value":null}]
23:27:06 INFO - 1499668026783 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026787 Marionette TRACE 394 <- [1,9,null,{}]
23:27:06 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1059ms
23:27:06 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026793 Marionette DEBUG Closed connection 394
23:27:06 INFO - 1499668026795 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49840
23:27:06 INFO - 1499668026796 Marionette DEBUG Closed connection 395
23:27:06 INFO - 1499668026797 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49841
23:27:06 INFO - 1499668026800 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:06 INFO - 1499668026803 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:06 INFO - 1499668026831 Marionette DEBUG Register listener.js for window 12
23:27:06 INFO - 1499668026857 Marionette TRACE 396 <- [1,1,null,{"sessionId":"a0fda4f9-20e7-4799-a4ea-3506a7160b98","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:06 INFO - 1499668026864 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
23:27:06 INFO - 1499668026865 Marionette TRACE 396 <- [1,2,null,{}]
23:27:06 INFO - 1499668026867 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
23:27:06 INFO - 1499668026869 Marionette TRACE 396 <- [1,3,null,{}]
23:27:06 INFO - 1499668026871 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
23:27:06 INFO - 1499668026873 Marionette TRACE 396 <- [1,4,null,{}]
23:27:06 INFO - 1499668026875 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
23:27:06 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1499668026883 Marionette TRACE 396 <- [1,5,null,{"value":null}]
23:27:06 INFO - 1499668026885 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026889 Marionette TRACE 396 <- [1,6,null,{}]
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026895 Marionette DEBUG Closed connection 396
23:27:06 INFO - 1499668026896 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49842
23:27:06 INFO - 1499668026898 Marionette DEBUG Closed connection 397
23:27:06 INFO - 1499668026899 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49843
23:27:06 INFO - 1499668026902 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
23:27:06 INFO - 1499668026904 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:06 INFO - 1499668026929 Marionette DEBUG Register listener.js for window 12
23:27:06 INFO - 1499668026939 Marionette TRACE 398 <- [1,1,null,{"sessionId":"ffa05c17-17ca-4f5c-babe-db31e6a2d9ba","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:06 INFO - 1499668026945 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026949 Marionette TRACE 398 <- [1,2,null,{}]
23:27:06 INFO - [424] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/oak-w64-d-00000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
23:27:06 INFO - 1499668026955 Marionette DEBUG Closed connection 398
23:27:06 INFO - 1499668026957 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49844
23:27:06 INFO - 1499668026958 Marionette DEBUG Closed connection 399
23:27:06 INFO - 1499668026960 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49845
23:27:06 INFO - 1499668026962 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
23:27:06 INFO - 1499668026964 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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}
23:27:06 INFO - 1499668026988 Marionette DEBUG Register listener.js for window 12
23:27:07 INFO - 1499668026999 Marionette TRACE 400 <- [1,1,null,{"sessionId":"fb9a296f-62c8-4070-8df8-9c7e4c252182","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":424,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-026.001\\AppData\\Local\\Temp\\tmpeuvnu4.mozrunner","moz:accessibilityChecks":false}}]
23:27:07 INFO - 1499668027005 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
23:27:07 INFO - 1499668027008 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"
23:27:07 INFO - 1499668027015 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"
23:27:07 INFO - 1499668027016 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"
23:27:07 INFO - ++DOMWINDOW == 25 (0000005779E0B000) [pid = 424] [serial = 52] [outer = 0000005774BE0000]
23:27:07 INFO - 1499668027149 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"
23:27:07 INFO - 1499668027154 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"
23:27:07 INFO - 1499668027170 Marionette TRACE 400 <- [1,2,null,{}]
23:27:07 INFO - 1499668027176 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
23:27:07 INFO - 1499668027184 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"c08d15e5-e88c-4b3a-a5d6-0f3b92089ac5","ELEMENT":"c08d15e5-e88c-4b3a-a5d6-0f3b92089ac5"}}]
23:27:07 INFO - 1499668027186 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"c08d15e5-e88c-4b3a-a5d6-0f3b92089ac5"}]
23:27:07 INFO - 1499668027314 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
23:27:07 INFO - 1499668027316 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"c08d15e5-e88c-4b3a-a5d6-0f3b92089ac5"}]
23:27:07 INFO - 1499668027493 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element